[57.121768] Initializing watchdogs
[57.121814]   /dev/watchdog0
[57.135119] [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.139399] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.141562] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.144706] [001/131] (960s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[57.236819] Starting subtest: y-tiled-ccs-to-yf-tiled
[57.241497] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[57.430338] [002/131] (960s left) gem_exec_whisper (basic-fds-priority-all)
[57.502358] Starting subtest: basic-fds-priority-all
[81.136745] Subtest basic-fds-priority-all: SUCCESS (23.471s)
[81.328509] [003/131] (936s left) gem_exec_balancer (parallel-keep-in-fence)
[81.569851] Starting subtest: parallel-keep-in-fence
[82.701667] Subtest parallel-keep-in-fence: SUCCESS (1.131s)
[82.830358] [004/131] (934s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[82.930222] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[82.934530] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[83.050396] [005/131] (934s left) gem_ctx_exec (basic)
[83.102742] Starting subtest: basic
[83.108049] Subtest basic: SUCCESS (0.006s)
[83.277860] [006/131] (934s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[83.370060] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[90.219254] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.850s)
[90.397892] [007/131] (927s left) kms_content_protection (dp-mst-type-0)
[90.553031] Starting subtest: dp-mst-type-0
[90.557684] Subtest dp-mst-type-0: SKIP (0.000s)
[90.716980] [008/131] (927s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[90.776252] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[90.837567] [009/131] (927s left) gem_mmap_offset (mmap-unmap)
[90.903934] Starting subtest: mmap-unmap
[90.906209] Starting dynamic subtest: smem0
[112.598648] Dynamic subtest smem0: SUCCESS (21.689s)
[112.601471] Subtest mmap-unmap: SUCCESS (21.689s)
[112.723544] [010/131] (905s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[112.794209] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[112.897812] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s)
[112.988594] [011/131] (905s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[113.078177] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[113.089683] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[113.227777] [012/131] (904s left) syncobj_basic (illegal-fd-to-handle)
[113.288256] Starting subtest: illegal-fd-to-handle
[113.290704] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[113.421171] [013/131] (904s left) syncobj_wait (invalid-wait-illegal-handle)
[113.485092] Starting subtest: invalid-wait-illegal-handle
[113.487536] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[113.597706] [014/131] (904s left) dumb_buffer (invalid-bpp)
[113.653580] Starting subtest: invalid-bpp
[113.655420] Subtest invalid-bpp: SUCCESS (0.000s)
[113.776579] [015/131] (904s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[113.880601] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[113.885119] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[114.014952] [016/131] (904s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[114.100080] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[114.102128] Starting dynamic subtest: pipe-A-eDP-1
[130.725147] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.518s)
[130.734245] Starting dynamic subtest: pipe-B-eDP-1
[147.635259] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.367s)
[147.645388] Starting dynamic subtest: pipe-C-eDP-1
[164.611630] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.284s)
[164.621978] Starting dynamic subtest: pipe-D-eDP-1
[181.612323] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.229s)
[181.615115] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.401s)
[182.847781] [017/131] (835s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[182.946224] Starting subtest: sprite-rotation-90-pos-100-0
[182.951189] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[183.028814] [018/131] (835s left) kms_pm_rpm (cursor-dpms)
[185.097062] Starting subtest: cursor-dpms
[185.102612] Subtest cursor-dpms: SKIP (0.000s)
[185.494514] [019/131] (832s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[185.591249] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[185.593914] Starting dynamic subtest: pipe-A
[186.799484] Dynamic subtest pipe-A: SUCCESS (1.196s)
[186.808784] Starting dynamic subtest: pipe-B
[189.038800] Dynamic subtest pipe-B: SUCCESS (2.216s)
[189.049542] Starting dynamic subtest: pipe-C
[190.219034] Dynamic subtest pipe-C: SUCCESS (1.169s)
[190.234124] Starting dynamic subtest: pipe-D
[191.475263] Dynamic subtest pipe-D: SUCCESS (1.246s)
[191.477960] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.830s)
[192.673604] [020/131] (825s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[192.732614] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[192.735132] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[192.851613] [021/131] (825s left) i915_pm_rps (min-max-config-idle)
[192.913532] Starting subtest: min-max-config-idle
[192.918626] Subtest min-max-config-idle: SKIP (0.001s)
[193.018222] [022/131] (825s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[193.102621] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[193.108046] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[193.225469] [023/131] (825s left) gem_mmap_wc (close)
[193.282459] Subtest close: SKIP (0.000s)
[193.346691] [024/131] (825s left) syncobj_timeline (reset-signaled)
[193.405529] Starting subtest: reset-signaled
[193.408015] Subtest reset-signaled: SUCCESS (0.000s)
[193.500846] [025/131] (825s left) i915_hangman (engine-engine-error)
[193.564484] Starting subtest: engine-engine-error
[193.567233] Starting dynamic subtest: rcs0
[194.893931] Dynamic subtest rcs0: SUCCESS (1.322s)
[194.906599] Starting dynamic subtest: bcs0
[196.875361] Dynamic subtest bcs0: SUCCESS (1.972s)
[196.887840] Starting dynamic subtest: vcs0
[198.925003] Dynamic subtest vcs0: SUCCESS (2.043s)
[198.937355] Starting dynamic subtest: vcs1
[200.907876] Dynamic subtest vcs1: SUCCESS (1.976s)
[200.919680] Starting dynamic subtest: vecs0
[202.891612] Dynamic subtest vecs0: SUCCESS (1.978s)
[202.904214] Starting dynamic subtest: ccs0
[204.938966] Dynamic subtest ccs0: SUCCESS (2.042s)
[204.941910] Subtest engine-engine-error: SUCCESS (11.343s)
[205.032844] [026/131] (813s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[205.138523] Starting subtest: yf-tiled-32bpp-rotate-180
[205.144015] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[205.259826] [027/131] (813s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[205.353457] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[205.357777] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[205.485891] [028/131] (813s left) kms_big_fb (linear-64bpp-rotate-90)
[205.584773] Starting subtest: linear-64bpp-rotate-90
[205.607043] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[205.749511] [029/131] (812s left) gem_softpin (noreloc-s3)
[205.811002] Starting subtest: noreloc-S3
[225.713676] Subtest noreloc-S3: SUCCESS (5.405s)
[225.937116] [030/131] (792s left) gem_ctx_engines (none)
[225.995365] Starting subtest: none
[225.997813] Subtest none: SUCCESS (0.001s)
[226.192318] [031/131] (792s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[226.587517] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[227.371847] [032/131] (791s left) kms_dsc (dsc-with-output-formats-with-bpc)
[227.470785] Starting subtest: dsc-with-output-formats-with-bpc
[227.537660] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[227.576033] [033/131] (791s left) gen9_exec_parse (shadow-peek)
[227.636683] Subtest shadow-peek: SKIP (0.000s)
[227.698948] [034/131] (791s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[227.816657] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[259.112225] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.206s)
[259.923567] [035/131] (759s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[260.021459] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[260.026258] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[260.151056] [036/131] (758s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[260.256860] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[261.294732] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.037s)
[261.450390] [037/131] (757s left) api_intel_bb (offset-control)
[261.497936] Starting subtest: offset-control
[261.503589] Subtest offset-control: SUCCESS (0.007s)
[261.627505] [038/131] (757s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[261.721548] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[266.186487] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.467s)
[267.324840] [039/131] (751s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[267.426615] Starting subtest: plane-primary-overlay-mutable-zpos
[270.845361] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.417s)
[272.031080] [040/131] (747s left) perf (global-sseu-config-invalid)
[272.168932] Starting subtest: global-sseu-config-invalid
[272.173451] Subtest global-sseu-config-invalid: SKIP (0.000s)
[272.210624] [041/131] (746s left) gem_basic (create-close)
[272.260164] Starting subtest: create-close
[272.265814] Subtest create-close: SUCCESS (0.000s)
[272.351626] [042/131] (746s left) gem_softpin (full)
[272.409051] Starting subtest: full
[272.418057] Subtest full: SUCCESS (0.009s)
[272.587926] [043/131] (746s left) gem_mmap_gtt (basic-write)
[272.645623] Subtest basic-write: SKIP (0.000s)
[272.710041] [044/131] (746s left) kms_pm_rpm (system-suspend-idle)
[274.540784] Starting subtest: system-suspend-idle
[294.068489] Subtest system-suspend-idle: SUCCESS (4.590s)
[294.473175] [045/131] (724s left) gem_userptr_blits (process-exit-busy)
[294.556075] Starting subtest: process-exit-busy
[294.566491] Subtest process-exit-busy: SUCCESS (0.011s)
[294.689666] [046/131] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[294.779527] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[301.838034] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.984s)
[302.007874] [047/131] (717s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[302.113661] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[302.118144] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[302.245404] [048/131] (717s left) kms_cursor_crc (cursor-onscreen-32x10)
[302.398808] Starting subtest: cursor-onscreen-32x10
[302.447270] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[302.732525] [049/131] (716s left) kms_psr (fbc-pr-sprite-render)
[302.830883] Starting subtest: fbc-pr-sprite-render
[302.834461] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[302.918223] [050/131] (716s left) kms_psr (psr-cursor-blt)
[303.015199] Starting subtest: psr-cursor-blt
[303.017195] Starting dynamic subtest: eDP-1
[304.774422] Dynamic subtest eDP-1: SUCCESS (1.749s)
[304.776744] Subtest psr-cursor-blt: SUCCESS (1.750s)
[305.653078] [051/131] (713s left) gem_madvise (dontneed-before-mmap)
[305.689006] Starting subtest: dontneed-before-mmap
[305.717704] Subtest dontneed-before-mmap: SUCCESS (0.030s)
[305.838180] [052/131] (713s left) gem_vm_create (invalid-create)
[305.898631] Starting subtest: invalid-create
[305.901070] Subtest invalid-create: SUCCESS (0.002s)
[306.039216] [053/131] (713s left) gem_pread (display)
[306.103799] Subtest display: SKIP (0.000s)
[306.175331] [054/131] (713s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[306.236988] Subtest tiled-to-untiled: SKIP (0.000s)
[306.340298] [055/131] (713s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[306.437274] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[306.439727] Starting dynamic subtest: pipe-A-default-mode
[306.735293] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[306.740000] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.295s)
[307.604943] [056/131] (712s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[307.704971] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[307.709237] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[307.828671] [057/131] (712s left) perf_pmu (most-busy-idle-check-all)
[307.866705] Starting subtest: most-busy-idle-check-all
[307.868900] Starting dynamic subtest: rcs0
[308.572930] Dynamic subtest rcs0: FAIL (0.648s)
[308.583374] Starting dynamic subtest: bcs0
[309.234711] Dynamic subtest bcs0: SUCCESS (0.715s)
[309.246650] Starting dynamic subtest: vcs0
[311.283126] Dynamic subtest vcs0: SUCCESS (2.040s)
[311.294390] Starting dynamic subtest: vcs1
[313.268270] Dynamic subtest vcs1: SUCCESS (1.979s)
[313.279574] Starting dynamic subtest: vecs0
[315.252257] Dynamic subtest vecs0: SUCCESS (1.978s)
[315.263675] Starting dynamic subtest: ccs0
[317.235599] Dynamic subtest ccs0: SUCCESS (1.978s)
[317.238852] Subtest most-busy-idle-check-all: FAIL (9.351s)
[317.350592] [058/131] (702s left) gem_exec_balancer (busy)
[317.412723] Starting subtest: busy
[319.308565] Subtest busy: SUCCESS (1.892s)
[319.652443] [059/131] (700s left) kms_prop_blob (invalid-set-prop-any)
[319.706753] Starting subtest: invalid-set-prop-any
[319.709144] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[319.828309] [060/131] (700s left) gem_exec_schedule (submit-early-slice)
[319.910620] Starting subtest: submit-early-slice
[319.912798] Starting dynamic subtest: rcs0
[319.965163] Dynamic subtest rcs0: SUCCESS (0.060s)
[319.981020] Starting dynamic subtest: bcs0
[320.017001] Dynamic subtest bcs0: SUCCESS (0.051s)
[320.026201] Starting dynamic subtest: vcs0
[320.073076] Dynamic subtest vcs0: SUCCESS (0.055s)
[320.084496] Starting dynamic subtest: vcs1
[320.123907] Dynamic subtest vcs1: SUCCESS (0.051s)
[320.134830] Starting dynamic subtest: vecs0
[320.164134] Dynamic subtest vecs0: SUCCESS (0.040s)
[320.174429] Starting dynamic subtest: ccs0
[320.228484] Dynamic subtest ccs0: SUCCESS (0.064s)
[320.230917] Subtest submit-early-slice: SUCCESS (0.324s)
[321.397241] [061/131] (698s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[321.493889] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[321.498017] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[321.622121] [062/131] (698s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[321.718964] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[328.557953] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.840s)
[328.707291] [063/131] (691s left) kms_chamelium_hpd (hdmi-hpd-fast)
[329.093516] Subtest hdmi-hpd-fast: SKIP (0.000s)
[329.944139] [064/131] (690s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[330.044058] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[330.045971] Starting dynamic subtest: A-eDP1
[333.677227] Dynamic subtest A-eDP1: SUCCESS (3.631s)
[333.687575] Starting dynamic subtest: B-eDP1
[336.868702] Dynamic subtest B-eDP1: SUCCESS (3.190s)
[336.878793] Starting dynamic subtest: C-eDP1
[339.999946] Dynamic subtest C-eDP1: SUCCESS (3.130s)
[340.009314] Starting dynamic subtest: D-eDP1
[343.107153] Dynamic subtest D-eDP1: SUCCESS (3.106s)
[343.109353] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.065s)
[343.929935] [065/131] (676s left) kms_flip (bo-too-big)
[344.014068] Starting subtest: bo-too-big
[344.016290] Starting dynamic subtest: A-eDP1
[345.363097] Dynamic subtest A-eDP1: SUCCESS (1.347s)
[345.375754] Starting dynamic subtest: B-eDP1
[346.683118] Dynamic subtest B-eDP1: SUCCESS (1.319s)
[346.695636] Starting dynamic subtest: C-eDP1
[347.942503] Dynamic subtest C-eDP1: SUCCESS (1.257s)
[347.954406] Starting dynamic subtest: D-eDP1
[349.263270] Dynamic subtest D-eDP1: SUCCESS (1.319s)
[349.269571] Subtest bo-too-big: SUCCESS (5.253s)
[350.479988] [066/131] (669s left) kms_cursor_crc (cursor-onscreen-64x21)
[350.671432] Starting subtest: cursor-onscreen-64x21
[350.724658] Subtest cursor-onscreen-64x21: SKIP (0.048s)
[350.956032] [067/131] (669s left) gen7_exec_parse (chained-batch)
[351.013883] Subtest chained-batch: SKIP (0.000s)
[351.094072] [068/131] (669s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[351.188406] Starting subtest: crc-primary-basic-yf-tiled-ccs
[351.190789] Starting dynamic subtest: pipe-A-eDP-1
[351.213208] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[351.223355] Starting dynamic subtest: pipe-B-eDP-1
[351.244453] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[351.252932] Starting dynamic subtest: pipe-C-eDP-1
[351.274303] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[351.282732] Starting dynamic subtest: pipe-D-eDP-1
[351.304406] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[351.308830] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.007s)
[353.382801] [069/131] (666s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[353.476821] Starting subtest: fb-8bpc-vs-panel-8bpc
[353.478976] Starting dynamic subtest: pipe-A-eDP-1
[354.830948] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.351s)
[354.832772] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.353s)
[355.641342] [070/131] (664s left) gem_userptr_blits (stress-mm-invalidate-close)
[355.704790] Starting subtest: stress-mm-invalidate-close
[357.852753] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[358.000259] [071/131] (662s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[358.105885] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[362.229238] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.125s)
[363.445908] [072/131] (657s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[363.544744] Starting subtest: extended-pageflip-modeset-hang-oldfb
[363.546648] Starting dynamic subtest: pipe-A
[371.453201] Dynamic subtest pipe-A: SUCCESS (7.904s)
[371.462868] Starting dynamic subtest: pipe-D
[380.033707] Dynamic subtest pipe-D: SUCCESS (8.575s)
[380.036042] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.484s)
[380.902712] [073/131] (639s left) kms_psr (fbc-psr-primary-render)
[381.001105] Starting subtest: fbc-psr-primary-render
[381.003440] Starting dynamic subtest: eDP-1
[381.007804] Dynamic subtest eDP-1: SKIP (0.000s)
[381.012087] Subtest fbc-psr-primary-render: SKIP (0.001s)
[381.099357] [074/131] (639s left) syncobj_wait (invalid-reset-zero-handles)
[381.154416] Starting subtest: invalid-reset-zero-handles
[381.156751] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[381.266302] [075/131] (639s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[381.353850] Starting subtest: compare-crc-sanitycheck-nv12
[381.355645] Starting dynamic subtest: pipe-A-eDP-1
[382.002099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.649s)
[382.012883] Starting dynamic subtest: pipe-B-eDP-1
[383.265984] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.260s)
[383.275798] Starting dynamic subtest: pipe-C-eDP-1
[384.505043] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.238s)
[384.518484] Starting dynamic subtest: pipe-D-eDP-1
[385.769233] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s)
[385.771716] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.415s)
[386.612610] [076/131] (633s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[386.711916] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[393.456944] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.749s)
[393.582786] [077/131] (627s left) gem_ctx_shared (disjoint-timelines)
[393.643225] Starting subtest: disjoint-timelines
[393.729983] Subtest disjoint-timelines: SUCCESS (0.086s)
[393.993287] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[393.997121] [078/131] (626s left) gem_sync (basic-store-all)
[394.073282] Starting subtest: basic-store-all
[397.272196] Subtest basic-store-all: SUCCESS (3.211s)
[397.468750] [079/131] (623s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[397.577539] Starting subtest: x-tiled-32bpp-rotate-270
[397.597890] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[397.734511] [080/131] (623s left) gem_busy (parallel)
[397.908316] Starting subtest: parallel
[397.910564] Starting dynamic subtest: rcs0
[399.284594] Dynamic subtest rcs0: SUCCESS (1.374s)
[399.297707] Starting dynamic subtest: bcs0
[401.268123] Dynamic subtest bcs0: SUCCESS (1.981s)
[401.280288] Starting dynamic subtest: vcs0
[403.250892] Dynamic subtest vcs0: SUCCESS (1.982s)
[403.264575] Starting dynamic subtest: vcs1
[405.236481] Dynamic subtest vcs1: SUCCESS (1.982s)
[405.251365] Starting dynamic subtest: vecs0
[407.283668] Dynamic subtest vecs0: SUCCESS (2.044s)
[407.296556] Starting dynamic subtest: ccs0
[409.268007] Dynamic subtest ccs0: SUCCESS (1.982s)
[409.271058] Subtest parallel: SUCCESS (11.361s)
[409.520647] [081/131] (611s left) gem_ctx_param (set-priority-not-supported)
[409.590771] Starting subtest: set-priority-not-supported
[409.594779] Subtest set-priority-not-supported: SKIP (0.000s)
[409.677182] [082/131] (611s left) kms_chamelium_color (gamma)
[409.783730] Subtest gamma: SKIP (0.000s)
[409.825876] [083/131] (611s left) gem_exec_whisper (basic-sync-all)
[409.883288] Starting subtest: basic-sync-all
[416.672079] Subtest basic-sync-all: SUCCESS (6.786s)
[416.864283] [084/131] (604s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[416.930743] Starting subtest: map-fixed-invalidate-overlap-busy
[416.935162] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[417.074822] [085/131] (603s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[417.183834] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[417.350370] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.170s)
[417.505847] [086/131] (603s left) kms_cursor_crc (cursor-tearing-position-change)
[417.619472] Starting subtest: cursor-tearing-position-change
[417.621793] Starting dynamic subtest: pipe-A-eDP-1
[418.195017] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s)
[418.204295] Starting dynamic subtest: pipe-D-eDP-1
[419.406427] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s)
[419.408642] Subtest cursor-tearing-position-change: SUCCESS (1.786s)
[420.248474] [087/131] (600s left) kms_vblank (wait-idle-hang)
[420.344002] Starting subtest: wait-idle-hang
[420.346282] Starting dynamic subtest: pipe-A-eDP-1
[447.025051] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.674s)
[447.040294] Starting dynamic subtest: pipe-D-eDP-1
[472.007362] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.973s)
[472.009732] Subtest wait-idle-hang: SUCCESS (51.651s)
[472.813434] [088/131] (548s left) kms_flip (2x-dpms-vs-vblank-race)
[472.925801] Starting subtest: 2x-dpms-vs-vblank-race
[472.934389] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[473.086936] [089/131] (548s left) gem_ctx_persistence (file)
[473.141485] Starting subtest: file
[473.275746] Subtest file: SUCCESS (0.134s)
[473.441134] [090/131] (547s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[473.537300] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[473.541410] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[473.650131] [091/131] (547s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[473.747301] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[473.749398] Starting dynamic subtest: pipe-A
[473.766079] Dynamic subtest pipe-A: SKIP (0.017s)
[473.775290] Starting dynamic subtest: pipe-B
[473.796068] Dynamic subtest pipe-B: SKIP (0.030s)
[473.805285] Starting dynamic subtest: pipe-C
[473.825145] Dynamic subtest pipe-C: SKIP (0.030s)
[473.834235] Starting dynamic subtest: pipe-D
[473.857285] Dynamic subtest pipe-D: SKIP (0.030s)
[473.860950] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.109s)
[473.994573] [092/131] (547s left) gem_eio (wait-immediate)
[474.204189] Starting subtest: wait-immediate
[474.537127] Subtest wait-immediate: SUCCESS (0.334s)
[474.719631] [093/131] (546s left) gem_sync (basic-all)
[474.785517] Starting subtest: basic-all
[478.259476] Subtest basic-all: SUCCESS (3.479s)
[478.454526] [094/131] (542s left) kms_joiner (invalid-modeset-ultra-joiner)
[478.566677] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[478.649835] [095/131] (542s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[483.572147] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[483.573997] Starting dynamic subtest: pipe-A-eDP-1
[495.023284] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.447s)
[495.037848] Starting dynamic subtest: pipe-B-eDP-1
[506.436389] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.407s)
[506.438650] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.858s)
[507.312180] [096/131] (514s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[507.376424] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[507.469357] [097/131] (514s left) gem_exec_schedule (preempt-hang)
[507.650136] Starting subtest: preempt-hang
[507.652329] Starting dynamic subtest: rcs0
[507.884928] Dynamic subtest rcs0: SUCCESS (0.237s)
[507.895295] Starting dynamic subtest: bcs0
[508.121179] Dynamic subtest bcs0: SUCCESS (0.235s)
[508.134020] Starting dynamic subtest: vcs0
[508.354491] Dynamic subtest vcs0: SUCCESS (0.231s)
[508.364442] Starting dynamic subtest: vcs1
[508.585579] Dynamic subtest vcs1: SUCCESS (0.229s)
[508.595243] Starting dynamic subtest: vecs0
[508.812349] Dynamic subtest vecs0: SUCCESS (0.226s)
[508.824521] Starting dynamic subtest: ccs0
[509.047933] Dynamic subtest ccs0: SUCCESS (0.234s)
[509.050022] Subtest preempt-hang: SUCCESS (1.399s)
[509.346117] [098/131] (512s left) gem_exec_fence (keep-in-fence)
[509.535926] Starting subtest: keep-in-fence
[509.537835] Starting dynamic subtest: rcs0
[509.600365] Dynamic subtest rcs0: SUCCESS (0.067s)
[509.613216] Starting dynamic subtest: bcs0
[509.652966] Dynamic subtest bcs0: SUCCESS (0.051s)
[509.665042] Starting dynamic subtest: vcs0
[511.286092] Dynamic subtest vcs0: SUCCESS (1.629s)
[511.298589] Starting dynamic subtest: vcs1
[513.267286] Dynamic subtest vcs1: SUCCESS (1.979s)
[513.279657] Starting dynamic subtest: vecs0
[515.251988] Dynamic subtest vecs0: SUCCESS (1.981s)
[515.264230] Starting dynamic subtest: ccs0
[515.491578] Dynamic subtest ccs0: SUCCESS (0.239s)
[515.494598] Subtest keep-in-fence: SUCCESS (5.958s)
[517.343614] [099/131] (504s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[517.393127] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[517.395416] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[517.525577] [100/131] (504s left) kms_psr (fbc-pr-basic)
[517.617851] Starting subtest: fbc-pr-basic
[517.622292] Subtest fbc-pr-basic: SKIP (0.000s)
[517.708863] [101/131] (503s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[517.800836] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[517.805280] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[518.936521] [102/131] (502s left) kms_rotation_crc (cursor-rotation-180)
[519.028614] Starting subtest: cursor-rotation-180
[520.517412] Subtest cursor-rotation-180: SUCCESS (1.490s)
[521.711901] [103/131] (500s left) sw_sync (sync_merge_same)
[521.747713] Starting subtest: sync_merge_same
[521.750233] Subtest sync_merge_same: SUCCESS (0.000s)
[521.823466] [104/131] (499s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[521.929128] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[521.933436] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[522.054614] [105/131] (499s left) kms_selftest (drm_framebuffer)
[522.088969] Starting subtest: drm_framebuffer
[522.100397] Starting dynamic subtest: drm_test_framebuffer_check_src_coords
[522.252601] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.155s)
[522.263565] Starting dynamic subtest: drm_test_framebuffer_cleanup
[522.416355] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.160s)
[522.425796] Starting dynamic subtest: drm_test_framebuffer_create
[522.636404] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.220s)
[522.646523] Starting dynamic subtest: drm_test_framebuffer_free
[522.881554] Dynamic subtest drm_test_framebuffer_free: FAIL (0.188s)
[522.885952] Subtest drm_framebuffer: FAIL (0.736s)
[523.019519] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[523.038108] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true
[523.038975] Closing watchdogs
results: parsing output: 0/ for test: gem_render_copy
results: parsing output: 1/ for test: gem_exec_whisper
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_ctx_exec
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_pipe_b_c_ivb
results: parsing output: 8/ for test: gem_mmap_offset
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: syncobj_basic
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: dumb_buffer
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: i915_pm_rps
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_mmap_wc
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: i915_hangman
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: gem_ctx_engines
results: parsing output: 30/ for test: kms_chamelium_edid
results: parsing output: 31/ for test: kms_dsc
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_atomic
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: gem_basic
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_pm_rpm
results: parsing output: 44/ for test: gem_userptr_blits
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_madvise
results: parsing output: 51/ for test: gem_vm_create
results: parsing output: 52/ for test: gem_pread
results: parsing output: 53/ for test: gem_set_tiling_vs_blt
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_prop_blob
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: gen7_exec_parse
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_dither
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_busy
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_pipe_crc_basic
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_ctx_shared
results: parsing output: 77/ for test: gem_sync
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_busy
results: parsing output: 80/ for test: gem_ctx_param
results: parsing output: 81/ for test: kms_chamelium_color
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: gem_pxp
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: gem_eio
results: parsing output: 92/ for test: gem_sync
results: parsing output: 93/ for test: kms_joiner
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: sw_sync
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_selftest
results: parsing output: 105/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 106/ for test: gem_ctx_isolation
results: no output, setting notrun
results: parsing output: 107/ for test: kms_psr
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: kms_scaling_modes
results: no output, setting notrun
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 111/ for test: gem_create
results: no output, setting notrun
results: parsing output: 112/ for test: kms_invalid_mode
results: no output, setting notrun
results: parsing output: 113/ for test: vgem_basic
results: no output, setting notrun
results: parsing output: 114/ for test: api_intel_allocator
results: no output, setting notrun
results: parsing output: 115/ for test: prime_mmap
results: no output, setting notrun
results: parsing output: 116/ for test: kms_plane_cursor
results: no output, setting notrun
results: parsing output: 117/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 118/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 119/ for test: gem_exec_fence
results: no output, setting notrun
results: parsing output: 120/ for test: sriov_basic
results: no output, setting notrun
results: parsing output: 121/ for test: kms_addfb_basic
results: no output, setting notrun
results: parsing output: 122/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 123/ for test: i915_query
results: no output, setting notrun
results: parsing output: 124/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 125/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 126/ for test: syncobj_wait
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: kms_big_fb
results: no output, setting notrun
results: parsing output: 129/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 130/ for test: kms_flip
results: no output, setting notrun
Done.