[57.776793] Initializing watchdogs
[57.776837]   /dev/watchdog0
[57.791263] [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.795437] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.797848] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.801367] [001/131] (960s left) kms_pm_dc (dc5-dpms-negative)
[58.920945] Starting subtest: dc5-dpms-negative
[58.925493] Subtest dc5-dpms-negative: SKIP (0.000s)
[58.997593] [002/131] (959s left) kms_color (ctm-0-50)
[59.086536] Starting subtest: ctm-0-50
[59.088430] Starting dynamic subtest: pipe-A-eDP-1
[62.619055] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.553s)
[62.627502] Starting dynamic subtest: pipe-B-eDP-1
[66.813396] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.208s)
[66.822084] Starting dynamic subtest: pipe-C-eDP-1
[70.853645] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.050s)
[70.862909] Starting dynamic subtest: pipe-D-eDP-1
[74.833400] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.985s)
[74.835988] Subtest ctm-0-50: SUCCESS (15.798s)
[75.671544] [003/131] (942s left) kms_cursor_crc (cursor-offscreen-64x64)
[75.869294] Starting subtest: cursor-offscreen-64x64
[75.873995] Starting dynamic subtest: pipe-A-eDP-1
[77.871068] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.998s)
[77.898086] Starting dynamic subtest: pipe-D-eDP-1
[80.478229] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.581s)
[80.480472] Subtest cursor-offscreen-64x64: SUCCESS (4.607s)
[81.317482] [004/131] (937s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[81.419171] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[81.421668] Starting dynamic subtest: pipe-A-eDP-1
[81.445453] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[81.455310] Starting dynamic subtest: pipe-B-eDP-1
[81.477419] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[81.487205] Starting dynamic subtest: pipe-C-eDP-1
[81.507849] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[81.516061] Starting dynamic subtest: pipe-D-eDP-1
[81.538240] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[81.542644] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[83.579749] [005/131] (934s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[83.681613] Starting subtest: plane-upscale-20x20-with-rotation
[83.683866] Starting dynamic subtest: pipe-A
[83.911538] Dynamic subtest pipe-A: SUCCESS (0.230s)
[83.921563] Starting dynamic subtest: pipe-B
[85.165800] Dynamic subtest pipe-B: SUCCESS (1.254s)
[85.173711] Starting dynamic subtest: pipe-C
[86.509304] Dynamic subtest pipe-C: SUCCESS (1.343s)
[86.518524] Starting dynamic subtest: pipe-D
[87.843622] Dynamic subtest pipe-D: SUCCESS (1.333s)
[87.845765] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.162s)
[89.014552] [006/131] (929s left) gem_exec_store (basic)
[89.079934] Starting subtest: basic
[89.167885] Subtest basic: SUCCESS (0.088s)
[89.345532] [007/131] (929s left) gem_mmap_gtt (basic-copy)
[89.397186] Subtest basic-copy: SKIP (0.000s)
[89.449050] [008/131] (929s left) kms_getfb (getfb2-into-addfb2)
[89.539167] Starting subtest: getfb2-into-addfb2
[89.541510] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[89.638933] [009/131] (928s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[89.762293] Starting subtest: 2x-long-flip-vs-cursor-legacy
[89.767181] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[89.913897] [010/131] (928s left) prime_vgem (wait)
[90.018566] Starting subtest: wait
[90.020908] Starting dynamic subtest: rcs0
[90.065721] Dynamic subtest rcs0: SUCCESS (0.046s)
[90.072957] Starting dynamic subtest: bcs0
[90.123440] Dynamic subtest bcs0: SUCCESS (0.058s)
[90.130563] Starting dynamic subtest: vcs0
[90.172721] Dynamic subtest vcs0: SUCCESS (0.049s)
[90.179912] Starting dynamic subtest: vcs1
[90.217832] Dynamic subtest vcs1: SUCCESS (0.045s)
[90.225081] Starting dynamic subtest: vecs0
[90.263771] Dynamic subtest vecs0: SUCCESS (0.045s)
[90.271064] Starting dynamic subtest: ccs0
[90.307025] Dynamic subtest ccs0: SUCCESS (0.043s)
[90.309097] Subtest wait: SUCCESS (0.289s)
[90.413539] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[90.416847] [011/131] (928s left) gem_mmap_gtt (hang-user)
[90.475227] Subtest hang-user: SKIP (0.000s)
[90.530152] [012/131] (928s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[90.645694] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[90.649416] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[90.738912] [013/131] (928s left) gem_exec_fence (syncobj-unused-fence)
[91.152225] Starting subtest: syncobj-unused-fence
[91.156823] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[92.940942] [014/131] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[93.054684] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[93.059117] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[93.137683] [015/131] (925s left) core_hotunplug (unbind-rebind)
[93.227162] Starting subtest: unbind-rebind
[99.144433] Subtest unbind-rebind: SUCCESS (5.917s)
[99.186877] [016/131] (919s left) kms_chamelium_color (ctm-0-50)
[100.906850] Subtest ctm-0-50: SKIP (0.000s)
[100.949757] [017/131] (917s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[101.045396] Starting subtest: dsc-fractional-bpp-with-bpc
[101.077678] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[101.120113] [018/131] (917s left) gem_blits (basic)
[101.171143] Starting subtest: basic
[102.607886] Subtest basic: SUCCESS (1.405s)
[102.692862] [019/131] (916s left) kms_prop_blob (invalid-set-prop-any)
[102.755116] Starting subtest: invalid-set-prop-any
[102.757357] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[102.852728] [020/131] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[102.959593] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[102.963691] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[103.059858] [021/131] (916s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[103.117887] Starting subtest: legacy-engines-hostile-preempt
[103.120284] Starting dynamic subtest: render
[103.186406] Dynamic subtest render: SUCCESS (0.068s)
[103.196698] Starting dynamic subtest: bsd1
[104.913591] Dynamic subtest bsd1: SUCCESS (1.723s)
[104.924602] Starting dynamic subtest: bsd2
[106.900325] Dynamic subtest bsd2: SUCCESS (1.984s)
[106.911123] Starting dynamic subtest: blt
[106.924318] Dynamic subtest blt: SUCCESS (0.024s)
[106.931851] Starting dynamic subtest: vebox
[108.861814] Dynamic subtest vebox: SUCCESS (1.933s)
[108.864816] Subtest legacy-engines-hostile-preempt: SUCCESS (5.743s)
[108.992942] [022/131] (910s left) i915_pm_rps (thresholds-park)
[109.049930] Starting subtest: thresholds-park
[109.054485] Subtest thresholds-park: SKIP (0.001s)
[109.148999] [023/131] (910s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[109.240799] Starting subtest: crc-primary-basic-y-tiled-ccs
[109.243164] Starting dynamic subtest: pipe-A-eDP-1
[109.266075] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[109.276155] Starting dynamic subtest: pipe-B-eDP-1
[109.297821] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[109.305947] Starting dynamic subtest: pipe-C-eDP-1
[109.328096] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[109.335607] Starting dynamic subtest: pipe-D-eDP-1
[109.357670] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[109.362058] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[111.450757] [024/131] (907s left) gem_fenced_exec_thrash (2-spare-fences)
[111.521766] Subtest 2-spare-fences: SKIP (0.000s)
[111.590209] [025/131] (907s left) kms_addfb_basic (too-high)
[111.693920] Starting subtest: too-high
[111.696251] Subtest too-high: SUCCESS (0.000s)
[111.796337] [026/131] (907s left) kms_psr (fbc-pr-sprite-plane-onoff)
[111.891333] Starting subtest: fbc-pr-sprite-plane-onoff
[111.895413] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[111.965293] [027/131] (907s left) perf (invalid-open-flags)
[112.081765] Starting subtest: invalid-open-flags
[112.083687] Subtest invalid-open-flags: SUCCESS (0.000s)
[112.128258] [028/131] (907s left) gem_exec_schedule (u-fairslice-all)
[112.196472] Starting subtest: u-fairslice-all
[114.250872] Subtest u-fairslice-all: SUCCESS (2.055s)
[115.944766] [029/131] (903s left) perf_pmu (render-node-busy)
[116.018905] Starting subtest: render-node-busy
[116.020881] Starting dynamic subtest: rcs0
[116.605293] Dynamic subtest rcs0: SUCCESS (0.587s)
[116.616735] Starting dynamic subtest: bcs0
[117.164044] Dynamic subtest bcs0: SUCCESS (0.557s)
[117.175210] Starting dynamic subtest: vcs0
[118.935392] Dynamic subtest vcs0: SUCCESS (1.768s)
[118.946903] Starting dynamic subtest: vcs1
[120.919409] Dynamic subtest vcs1: SUCCESS (1.982s)
[120.929219] Starting dynamic subtest: vecs0
[122.902646] Dynamic subtest vecs0: SUCCESS (1.981s)
[122.916926] Starting dynamic subtest: ccs0
[123.472549] Dynamic subtest ccs0: SUCCESS (0.570s)
[123.475184] Subtest render-node-busy: SUCCESS (7.456s)
[123.550402] [030/131] (895s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[123.661080] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[123.665313] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[123.767406] [031/131] (895s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[123.871144] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[123.875685] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[123.939357] [032/131] (895s left) gem_readwrite (read-bad-handle)
[124.002087] Subtest read-bad-handle: SKIP (0.000s)
[124.059708] [033/131] (895s left) gem_userptr_blits (sync-overlap)
[124.126804] Starting subtest: sync-overlap
[124.128651] Subtest sync-overlap: SUCCESS (0.000s)
[124.263185] [034/131] (895s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[124.360847] Starting subtest: 2x-absolute-wf_vblank-interruptible
[124.371868] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[124.455795] [035/131] (895s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[124.552367] Starting subtest: yf-tiled-addfb-size-overflow
[124.556087] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[124.641410] [036/131] (895s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[124.739059] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[124.742416] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[124.848464] [037/131] (894s left) gem_render_linear_blits (basic)
[124.900070] Starting subtest: basic
[124.924548] Subtest basic: SUCCESS (0.024s)
[125.010434] [038/131] (894s left) kms_psr (psr-sprite-plane-onoff)
[125.095468] Starting subtest: psr-sprite-plane-onoff
[125.097416] Starting dynamic subtest: eDP-1
[126.891438] Dynamic subtest eDP-1: SUCCESS (1.795s)
[126.893920] Subtest psr-sprite-plane-onoff: SUCCESS (1.796s)
[127.725730] [039/131] (892s left) kms_atomic_transition (plane-toggle-modeset-transition)
[127.829216] Starting subtest: plane-toggle-modeset-transition
[127.831209] Starting dynamic subtest: pipe-A-eDP-1
[140.541856] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.711s)
[140.552940] Starting dynamic subtest: pipe-B-eDP-1
[152.951838] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.408s)
[152.954413] Subtest plane-toggle-modeset-transition: SUCCESS (25.125s)
[153.764060] [040/131] (866s left) kms_chamelium_edid (dp-mode-timings)
[154.132149] Subtest dp-mode-timings: SKIP (0.000s)
[154.981235] [041/131] (864s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[155.097418] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[156.059841] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.962s)
[156.934473] [042/131] (862s left) gem_mmap_wc (coherency)
[156.996418] Subtest coherency: SKIP (0.000s)
[157.064582] [043/131] (862s left) gem_create (hog-create)
[157.125130] Starting subtest: hog-create
[157.127430] Starting dynamic subtest: smem0
[190.932356] Dynamic subtest smem0: SUCCESS (33.807s)
[190.934938] Subtest hog-create: SUCCESS (33.808s)
[191.117943] [044/131] (828s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[191.210972] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[191.215426] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[191.279411] [045/131] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[191.385407] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[214.309826] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.927s)
[214.458166] [046/131] (805s left) kms_cursor_crc (cursor-random-256x85)
[214.704477] Starting subtest: cursor-random-256x85
[214.754352] Subtest cursor-random-256x85: SKIP (0.045s)
[214.920549] [047/131] (805s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[215.021163] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[215.634523] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.614s)
[215.806035] [048/131] (804s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[215.929513] Starting subtest: flip-vs-cursor-crc-legacy
[216.610894] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.681s)
[217.404307] [049/131] (802s left) gem_mmap_wc (pf-nonblock)
[217.464866] Subtest pf-nonblock: SKIP (0.000s)
[217.519454] [050/131] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[217.616571] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[224.940146] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.326s)
[225.088306] [051/131] (795s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[225.175983] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[225.180074] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[225.278734] [052/131] (795s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[225.364083] Starting subtest: plane-all-modeset-transition-internal-panels
[225.366256] Starting dynamic subtest: pipe-A-eDP-1
[226.674109] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.309s)
[226.951063] Starting dynamic subtest: pipe-B-eDP-1
[228.004648] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.061s)
[228.271710] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.905s)
[229.108455] [053/131] (791s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[229.213061] Starting subtest: 4-tiled-16bpp-rotate-180
[230.537574] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.323s)
[230.647721] [054/131] (789s left) gem_mmap (short-mmap)
[230.706847] Subtest short-mmap: SKIP (0.000s)
[230.777244] [055/131] (789s left) i915_drm_fdinfo (memory-info-idle)
[230.815647] Starting subtest: memory-info-idle
[230.817685] Starting dynamic subtest: smem0
[230.869912] Dynamic subtest smem0: SUCCESS (0.054s)
[230.872591] Subtest memory-info-idle: SUCCESS (0.054s)
[230.943993] [056/131] (789s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[231.041327] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[231.043207] Starting dynamic subtest: pipe-A
[231.401624] Dynamic subtest pipe-A: SUCCESS (0.362s)
[231.410079] Starting dynamic subtest: pipe-B
[232.836370] Dynamic subtest pipe-B: SUCCESS (1.433s)
[232.845154] Starting dynamic subtest: pipe-C
[234.237681] Dynamic subtest pipe-C: SUCCESS (1.399s)
[234.246292] Starting dynamic subtest: pipe-D
[235.658904] Dynamic subtest pipe-D: SUCCESS (1.420s)
[235.661510] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.620s)
[236.825418] [057/131] (783s left) i915_pm_rpm (reg-read-ioctl)
[239.061755] Starting subtest: reg-read-ioctl
[241.344786] Subtest reg-read-ioctl: SUCCESS (2.286s)
[241.727741] [058/131] (778s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[241.825836] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[241.830040] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[241.915181] [059/131] (778s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[242.008437] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[242.010772] Starting dynamic subtest: pipe-A-eDP-1
[242.070383] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[242.080985] Starting dynamic subtest: pipe-B-eDP-1
[242.139593] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[242.152715] Starting dynamic subtest: pipe-C-eDP-1
[242.210776] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[242.220695] Starting dynamic subtest: pipe-D-eDP-1
[242.279801] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[242.283941] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[244.284326] [060/131] (776s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[244.373423] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[244.378115] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[245.522161] [061/131] (775s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[245.622312] Starting subtest: pr-overlay-plane-update-continuous-sf
[245.626499] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[245.708801] [062/131] (775s left) gem_ctx_param (vm)
[245.760810] Starting subtest: vm
[245.806552] Subtest vm: SUCCESS (0.045s)
[245.944225] [063/131] (774s left) i915_hangman (error-state-basic)
[246.014511] Starting subtest: error-state-basic
[246.168115] Subtest error-state-basic: SUCCESS (0.154s)
[246.257291] [064/131] (774s left) sw_sync (sync_random_merge)
[246.298062] Starting subtest: sync_random_merge
[246.338819] Subtest sync_random_merge: SUCCESS (0.044s)
[246.401026] [065/131] (774s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[246.515159] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[246.518417] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[246.604734] [066/131] (774s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[246.711072] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[246.714487] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[246.802653] [067/131] (774s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[246.872309] Starting subtest: y-tiled-to-vebox-yf-tiled
[246.875902] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[247.057437] [068/131] (773s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[247.150811] Starting subtest: plane-all-transition-nonblocking-fencing
[247.153113] Starting dynamic subtest: pipe-A-eDP-1
[249.644956] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[249.956951] Starting dynamic subtest: pipe-B-eDP-1
[253.155059] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.206s)
[253.459176] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.307s)
[254.280340] [069/131] (766s left) gem_exec_schedule (preempt-other)
[254.356324] Starting subtest: preempt-other
[254.358762] Starting dynamic subtest: rcs0
[254.419150] Dynamic subtest rcs0: SUCCESS (0.070s)
[254.433291] Starting dynamic subtest: bcs0
[254.485052] Dynamic subtest bcs0: SUCCESS (0.065s)
[254.498741] Starting dynamic subtest: vcs0
[254.553657] Dynamic subtest vcs0: SUCCESS (0.068s)
[254.568290] Starting dynamic subtest: vcs1
[254.617729] Dynamic subtest vcs1: SUCCESS (0.062s)
[254.630921] Starting dynamic subtest: vecs0
[254.681453] Dynamic subtest vecs0: SUCCESS (0.064s)
[254.694391] Starting dynamic subtest: ccs0
[254.752298] Dynamic subtest ccs0: SUCCESS (0.070s)
[254.754732] Subtest preempt-other: SUCCESS (0.404s)
[255.970775] [070/131] (765s left) prime_mmap (test_dup)
[256.027448] Starting subtest: test_dup
[256.029917] Starting dynamic subtest: test_dup-smem
[256.054441] Dynamic subtest test_dup-smem: SUCCESS (0.030s)
[256.056819] Subtest test_dup: SUCCESS (0.031s)
[256.128041] [071/131] (764s left) kms_cursor_crc (cursor-sliding-512x512)
[256.392600] Starting subtest: cursor-sliding-512x512
[256.396997] Subtest cursor-sliding-512x512: SKIP (0.001s)
[256.554093] [072/131] (764s left) perf (gen12-oa-tlb-invalidate)
[256.650588] Starting subtest: gen12-oa-tlb-invalidate
[256.652968] Starting dynamic subtest: 0-rcs0
[266.748580] Dynamic subtest 0-rcs0: SUCCESS (10.044s)
[266.760144] Starting dynamic subtest: 1-vcs1
[276.798650] Dynamic subtest 1-vcs1: SUCCESS (10.048s)
[276.801692] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.095s)
[276.841456] [073/131] (744s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[276.948899] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[276.953548] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[277.036076] [074/131] (744s left) i915_query (query-topology-matches-eu-total)
[277.097712] Starting subtest: query-topology-matches-eu-total
[277.099991] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[277.213189] [075/131] (744s left) kms_flip (wf_vblank-ts-check)
[277.302305] Starting subtest: wf_vblank-ts-check
[277.304518] Starting dynamic subtest: A-eDP1
[286.249568] Dynamic subtest A-eDP1: SUCCESS (8.912s)
[286.263271] Starting dynamic subtest: B-eDP1
[295.177953] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[295.189721] Starting dynamic subtest: C-eDP1
[304.107420] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[304.118113] Starting dynamic subtest: D-eDP1
[312.992278] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[312.997043] Subtest wf_vblank-ts-check: SUCCESS (35.694s)
[314.204393] [076/131] (707s left) gem_spin_batch (spin-all)
[314.266413] Starting subtest: spin-all
[314.278243] Subtest spin-all: SUCCESS (0.014s)
[315.981676] [077/131] (705s left) gem_userptr_blits (stress-purge)
[316.064059] Starting subtest: stress-purge
[321.450827] Subtest stress-purge: SUCCESS (5.387s)
[321.581050] [078/131] (699s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[321.685206] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[321.687290] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[321.789885] [079/131] (699s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[321.890473] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[321.894394] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.001s)
[321.994232] [080/131] (699s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[322.071036] Starting subtest: mixed-tiled-to-y-tiled-ccs
[322.074743] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[322.256436] [081/131] (699s left) gem_render_copy (y-tiled)
[322.309167] Starting subtest: y-tiled
[322.313940] Subtest y-tiled: SKIP (0.000s)
[322.491953] [082/131] (699s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[322.583439] Starting subtest: coverage-vs-premult-vs-constant
[322.876364] Starting dynamic subtest: pipe-A-eDP-1
[323.508950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s)
[323.518927] Starting dynamic subtest: pipe-D-eDP-1
[324.815715] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s)
[324.818040] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.233s)
[325.675657] [083/131] (695s left) syncobj_timeline (wait-all-delayed-signal)
[325.740268] Starting subtest: wait-all-delayed-signal
[325.841807] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[325.932865] [084/131] (695s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[326.029463] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[330.622744] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.597s)
[331.793889] [085/131] (689s left) sysfs_timeslice_duration (timeout)
[331.851157] Starting subtest: timeout
[331.853503] Starting dynamic subtest: vecs0
[341.905985] Dynamic subtest vecs0: SUCCESS (10.051s)
[341.918107] Starting dynamic subtest: ccs0
[343.182695] Dynamic subtest ccs0: SUCCESS (1.277s)
[343.194139] Starting dynamic subtest: vcs0
[352.908696] Dynamic subtest vcs0: SUCCESS (9.719s)
[352.920857] Starting dynamic subtest: bcs0
[353.530517] Dynamic subtest bcs0: SUCCESS (0.622s)
[353.542305] Starting dynamic subtest: rcs0
[354.735294] Dynamic subtest rcs0: SUCCESS (1.202s)
[354.747331] Starting dynamic subtest: vcs1
[363.916789] Dynamic subtest vcs1: SUCCESS (9.179s)
[363.919320] Subtest timeout: SUCCESS (32.062s)
[364.012061] [086/131] (657s left) prime_vgem (fence-flip-hang)
[364.124437] Subtest fence-flip-hang: SKIP (0.000s)
[364.216427] [087/131] (657s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[364.344369] Starting subtest: cursor-vs-flip-atomic
[394.057811] Subtest cursor-vs-flip-atomic: SUCCESS (29.710s)
[394.898464] [088/131] (626s left) gem_exec_balancer (bonded-chain)
[394.960226] Starting subtest: bonded-chain
[401.935204] Subtest bonded-chain: SUCCESS (6.976s)
[402.245286] [089/131] (619s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[402.347496] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[402.351882] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[402.444339] [090/131] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[402.542112] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[402.546346] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[402.629562] [091/131] (619s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[402.731022] Starting subtest: fbcpsr-tiling-y
[402.735339] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[402.834309] [092/131] (619s left) gem_busy (close-race)
[402.910767] Starting subtest: close-race
[426.902447] Subtest close-race: SUCCESS (23.989s)
[427.260081] [093/131] (594s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[427.417089] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[427.419379] Starting dynamic subtest: pipe-A-default-mode
[430.135743] Dynamic subtest pipe-A-default-mode: SUCCESS (2.716s)
[430.138046] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.718s)
[430.993230] [094/131] (591s left) syncobj_eventfd (invalid-bad-flags)
[431.063428] Starting subtest: invalid-bad-flags
[431.065417] Subtest invalid-bad-flags: SUCCESS (0.000s)
[431.155902] [095/131] (590s left) gem_exec_fence (syncobj-timeline-repeat)
[431.710794] Starting subtest: syncobj-timeline-repeat
[431.944396] Subtest syncobj-timeline-repeat: SUCCESS (0.233s)
[432.994142] [096/131] (589s left) gem_media_vme
[433.140092] [097/131] (589s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[433.232315] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[433.236376] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[433.323442] [098/131] (588s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[433.416063] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[433.420146] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[433.513134] [099/131] (588s left) kms_psr (psr-cursor-plane-move)
[433.611066] Starting subtest: psr-cursor-plane-move
[433.613286] Starting dynamic subtest: eDP-1
[435.301482] Dynamic subtest eDP-1: SUCCESS (1.691s)
[435.303803] Subtest psr-cursor-plane-move: SUCCESS (1.692s)
[436.174835] [100/131] (586s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[436.219921] Starting subtest: etime-multi-wait-all-submitted-signaled
[436.321818] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[436.405243] [101/131] (585s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[436.500014] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[436.503837] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[436.596957] [102/131] (585s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[436.691030] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[437.680481] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.989s)
[437.803492] [103/131] (584s left) api_intel_bb (full-batch)
[437.857931] Starting subtest: full-batch
[437.862922] Subtest full-batch: SUCCESS (0.005s)
[437.958022] [104/131] (584s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[438.085317] Starting subtest: cursorA-vs-flipB-legacy
[438.089050] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[438.226965] [105/131] (584s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[438.312160] Starting subtest: psr-rgb101010-draw-blt
[445.575190] Subtest psr-rgb101010-draw-blt: SUCCESS (7.266s)
[445.687070] [106/131] (576s left) kms_vblank (crtc-id)
[445.790169] Starting subtest: crtc-id
[445.792248] Starting dynamic subtest: pipe-A-eDP-1
[446.233463] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[446.247751] Starting dynamic subtest: pipe-D-eDP-1
[447.323275] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.089s)
[447.325596] Subtest crtc-id: SUCCESS (1.535s)
[448.160262] [107/131] (574s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[448.261462] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[448.265710] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[448.369895] [108/131] (574s left) api_intel_bb (blit-reloc-keep-cache)
[448.423545] Starting subtest: blit-reloc-keep-cache
[448.428289] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[448.560459] [109/131] (574s left) kms_selftest (drm_framebuffer)
[448.605185] Starting subtest: drm_framebuffer
[448.617315] Starting dynamic subtest: drm_test_framebuffer_check_src_coords
[448.704502] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.087s)
[448.714040] Starting dynamic subtest: drm_test_framebuffer_cleanup
[448.812088] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.108s)
[448.823245] Starting dynamic subtest: drm_test_framebuffer_create
[449.023466] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.208s)
[449.032810] Starting dynamic subtest: drm_test_framebuffer_free
[449.225138] Dynamic subtest drm_test_framebuffer_free: FAIL (0.156s)
[449.229323] Subtest drm_framebuffer: FAIL (0.576s)
[449.336251] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[449.353823] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true
[449.354660] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_dc
results: parsing output: 1/ for test: kms_color
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: gem_exec_store
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_getfb
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: core_hotunplug
results: parsing output: 15/ for test: kms_chamelium_color
results: parsing output: 16/ for test: kms_dsc
results: parsing output: 17/ for test: gem_blits
results: parsing output: 18/ for test: kms_prop_blob
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: i915_pm_rps
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: gem_fenced_exec_thrash
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: perf_pmu
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: gem_readwrite
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_render_linear_blits
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_atomic_transition
results: parsing output: 39/ for test: kms_chamelium_edid
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: gem_mmap_wc
results: parsing output: 42/ for test: gem_create
results: parsing output: 43/ for test: kms_plane
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: gem_mmap_wc
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: kms_atomic_transition
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_mmap
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: i915_pm_rpm
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gem_ctx_param
results: parsing output: 62/ for test: i915_hangman
results: parsing output: 63/ for test: sw_sync
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_render_copy
results: parsing output: 67/ for test: kms_atomic_transition
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: prime_mmap
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: i915_query
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: gem_spin_batch
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: kms_plane_alpha_blend
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: sysfs_timeslice_duration
results: parsing output: 85/ for test: prime_vgem
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_busy
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: syncobj_eventfd
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: gem_media_vme
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: api_intel_bb
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: kms_selftest
results: parsing output: 109/ for test: gem_exec_whisper
results: no output, setting notrun
results: parsing output: 110/ for test: kms_async_flips
results: no output, setting notrun
results: parsing output: 111/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 112/ for test: kms_chamelium_hpd
results: no output, setting notrun
results: parsing output: 113/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 114/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 115/ for test: kms_vblank
results: no output, setting notrun
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 117/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 118/ for test: kms_hdr
results: no output, setting notrun
results: parsing output: 119/ for test: kms_content_protection
results: no output, setting notrun
results: parsing output: 120/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 121/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 122/ for test: kms_fbcon_fbt
results: no output, setting notrun
results: parsing output: 123/ for test: kms_lease
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: kms_psr
results: no output, setting notrun
results: parsing output: 126/ for test: gen9_exec_parse
results: no output, setting notrun
results: parsing output: 127/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 128/ for test: gem_set_tiling_vs_blt
results: no output, setting notrun
results: parsing output: 129/ for test: gem_exec_fence
results: no output, setting notrun
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
Done.