[85.034329] Initializing watchdogs
[85.034503]   /dev/watchdog0
[85.073578] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[85.087608] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[85.094280] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[85.102855] [001/131] (960s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[85.236150] Starting subtest: y-tiled-ccs-to-yf-tiled
[85.240560] Starting dynamic subtest: smem
[85.575630] Dynamic subtest smem: SUCCESS (0.338s)
[85.579534] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.340s)
[85.835191] [002/131] (959s left) gem_exec_whisper (basic-fds-priority-all)
[85.969979] Starting subtest: basic-fds-priority-all
[101.951550] Subtest basic-fds-priority-all: SUCCESS (15.980s)
[102.231567] [003/131] (943s left) gem_exec_balancer (parallel-keep-in-fence)
[102.472176] Subtest parallel-keep-in-fence: SKIP (0.000s)
[102.659489] [004/131] (943s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[102.860477] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[102.867763] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[103.032823] [005/131] (942s left) gem_ctx_exec (basic)
[103.146117] Starting subtest: basic
[103.149844] Subtest basic: SUCCESS (0.006s)
[103.331752] [006/131] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[103.534490] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[103.541569] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[103.696208] [007/131] (942s left) kms_content_protection (dp-mst-type-0)
[103.894351] Starting subtest: dp-mst-type-0
[103.901979] Subtest dp-mst-type-0: SKIP (0.000s)
[104.068383] [008/131] (942s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[104.182488] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[104.285090] [009/131] (942s left) gem_mmap_offset (mmap-unmap)
[104.393633] Starting subtest: mmap-unmap
[104.396871] Starting dynamic subtest: smem0
[190.070547] Dynamic subtest smem0: SUCCESS (85.682s)
[190.074149] Subtest mmap-unmap: SUCCESS (85.683s)
[190.240649] [010/131] (856s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[190.343658] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[190.455870] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.110s)
[190.604668] [011/131] (855s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[190.800553] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[190.803778] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[192.504816] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.700s)
[192.525280] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[194.114221] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.603s)
[194.134543] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[195.716750] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.599s)
[195.720993] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SUCCESS (4.916s)
[196.296736] [012/131] (850s left) syncobj_basic (illegal-fd-to-handle)
[196.402540] Starting subtest: illegal-fd-to-handle
[196.405750] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[196.544994] [013/131] (850s left) syncobj_wait (invalid-wait-illegal-handle)
[196.651063] Starting subtest: invalid-wait-illegal-handle
[196.655350] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[196.794076] [014/131] (849s left) dumb_buffer (invalid-bpp)
[196.902690] Starting subtest: invalid-bpp
[196.906463] Subtest invalid-bpp: SUCCESS (0.000s)
[197.061848] [015/131] (849s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[197.257854] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[197.265048] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[197.413460] [016/131] (849s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[197.604576] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[197.607834] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.621407] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[197.708147] Starting dynamic subtest: pipe-A-HDMI-A-2
[197.723374] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[197.742998] Starting dynamic subtest: pipe-B-HDMI-A-1
[197.756236] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[197.776149] Starting dynamic subtest: pipe-B-HDMI-A-2
[197.789046] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[197.808884] Starting dynamic subtest: pipe-C-HDMI-A-1
[197.821673] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[197.841043] Starting dynamic subtest: pipe-C-HDMI-A-2
[197.853949] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[197.860588] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.023s)
[198.584410] [017/131] (848s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[198.795253] Starting subtest: sprite-rotation-90-pos-100-0
[210.112735] Subtest sprite-rotation-90-pos-100-0: SUCCESS (11.338s)
[210.378954] [018/131] (836s left) kms_pm_rpm (cursor-dpms)
[212.176376] Starting subtest: cursor-dpms
[214.099105] Subtest cursor-dpms: SUCCESS (1.923s)
[214.475303] [019/131] (832s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[214.666528] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[214.670298] Starting dynamic subtest: pipe-A
[215.724716] Dynamic subtest pipe-A: SUCCESS (1.063s)
[215.746335] Starting dynamic subtest: pipe-B
[216.880489] Dynamic subtest pipe-B: SUCCESS (1.129s)
[216.973995] Starting dynamic subtest: pipe-C
[217.303812] Dynamic subtest pipe-C: SUCCESS (0.448s)
[217.307642] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (2.645s)
[217.976614] [020/131] (829s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[218.132718] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[218.136281] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[218.305894] [021/131] (829s left) i915_pm_rps (min-max-config-idle)
[218.427555] Starting subtest: min-max-config-idle
[218.783619] Subtest min-max-config-idle: SUCCESS (0.361s)
[218.953203] [022/131] (828s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[219.160221] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[221.641678] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.484s)
[221.875153] [023/131] (825s left) gem_mmap_wc (close)
[221.983945] Starting subtest: close
[221.991812] Subtest close: SUCCESS (0.011s)
[222.135197] [024/131] (825s left) syncobj_timeline (reset-signaled)
[222.241927] Starting subtest: reset-signaled
[222.245277] Subtest reset-signaled: SUCCESS (0.001s)
[222.392293] [025/131] (825s left) i915_hangman (engine-engine-error)
[222.520660] Starting subtest: engine-engine-error
[222.524406] Starting dynamic subtest: rcs0
[222.602272] Dynamic subtest rcs0: SUCCESS (0.079s)
[222.622585] Starting dynamic subtest: bcs0
[222.629458] Dynamic subtest bcs0: SKIP (0.003s)
[222.650876] Starting dynamic subtest: vcs0
[222.676626] Dynamic subtest vcs0: SUCCESS (0.071s)
[222.696218] Starting dynamic subtest: vecs0
[222.754499] Dynamic subtest vecs0: SUCCESS (0.074s)
[222.757795] Subtest engine-engine-error: SUCCESS (0.235s)
[222.937493] [026/131] (825s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[223.148310] Starting subtest: yf-tiled-32bpp-rotate-180
[226.772331] Subtest yf-tiled-32bpp-rotate-180: SUCCESS (3.623s)
[227.206761] [027/131] (820s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[227.409267] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[227.416437] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[227.573626] [028/131] (820s left) kms_big_fb (linear-64bpp-rotate-90)
[227.773482] Starting subtest: linear-64bpp-rotate-90
[228.058293] Subtest linear-64bpp-rotate-90: SKIP (0.281s)
[228.327178] [029/131] (819s left) gem_softpin (noreloc-s3)
[228.445036] Starting subtest: noreloc-S3
[249.726738] Subtest noreloc-S3: SUCCESS (5.492s)
[257.910146] [030/131] (798s left) gem_ctx_engines (none)
[258.042390] Starting subtest: none
[258.047160] Subtest none: SUCCESS (0.003s)
[258.318869] [031/131] (798s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[258.901837] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[259.241486] [032/131] (797s left) kms_dsc (dsc-with-output-formats-with-bpc)
[259.430876] Subtest dsc-with-output-formats-with-bpc: SKIP (0.000s)
[259.542008] [033/131] (797s left) gen9_exec_parse (shadow-peek)
[259.673754] Starting subtest: shadow-peek
[259.677530] Subtest shadow-peek: SUCCESS (0.005s)
[259.963447] [034/131] (796s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[260.143827] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[306.114047] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (45.757s)
[306.325023] [035/131] (750s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[306.530327] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[306.537777] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[306.688840] [036/131] (750s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[306.903275] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[306.910114] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[307.108102] [037/131] (749s left) api_intel_bb (offset-control)
[307.214142] Starting subtest: offset-control
[307.226569] Subtest offset-control: SUCCESS (0.017s)
[307.402587] [038/131] (749s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[307.597609] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[310.504733] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.905s)
[310.790271] [039/131] (746s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[310.968930] Starting subtest: plane-primary-overlay-mutable-zpos
[311.889574] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.909s)
[312.357573] [040/131] (745s left) perf (global-sseu-config-invalid)
[312.582534] Starting subtest: global-sseu-config-invalid
[312.585914] Starting dynamic subtest: 0-rcs0
[312.615133] Dynamic subtest 0-rcs0: SUCCESS (0.032s)
[312.619116] Subtest global-sseu-config-invalid: SUCCESS (0.034s)
[312.723167] [041/131] (744s left) gem_basic (create-close)
[312.825310] Starting subtest: create-close
[312.832400] Subtest create-close: SUCCESS (0.000s)
[313.030448] [042/131] (744s left) gem_softpin (full)
[313.137078] Starting subtest: full
[313.154469] Subtest full: SUCCESS (0.017s)
[313.342961] [043/131] (744s left) gem_mmap_gtt (basic-write)
[313.450873] Starting subtest: basic-write
[313.854005] Subtest basic-write: SUCCESS (0.400s)
[314.033304] [044/131] (743s left) kms_pm_rpm (system-suspend-idle)
[315.934969] Starting subtest: system-suspend-idle
[333.147414] Subtest system-suspend-idle: SUCCESS (1.871s)
[341.571319] [045/131] (724s left) gem_userptr_blits (process-exit-busy)
[341.713690] Starting subtest: process-exit-busy
[341.753785] Subtest process-exit-busy: SUCCESS (0.041s)
[341.967683] [046/131] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[342.165210] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[342.172797] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[342.366605] [047/131] (723s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[342.567453] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[343.774512] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.205s)
[344.115990] [048/131] (722s left) kms_cursor_crc (cursor-onscreen-32x10)
[344.315125] Starting subtest: cursor-onscreen-32x10
[344.461687] Subtest cursor-onscreen-32x10: SKIP (0.143s)
[344.658557] [049/131] (721s left) kms_psr (fbc-pr-sprite-render)
[344.852643] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[344.963567] [050/131] (721s left) kms_psr (psr-cursor-blt)
[345.160411] Subtest psr-cursor-blt: SKIP (0.000s)
[345.266112] [051/131] (721s left) gem_madvise (dontneed-before-mmap)
[345.372956] Starting subtest: dontneed-before-mmap
[345.388456] Subtest dontneed-before-mmap: SUCCESS (0.019s)
[345.566230] [052/131] (721s left) gem_vm_create (invalid-create)
[345.675698] Starting subtest: invalid-create
[345.679304] Subtest invalid-create: SUCCESS (0.001s)
[345.856984] [053/131] (720s left) gem_pread (display)
[345.962769] Starting subtest: display
[349.089755] Subtest display: SUCCESS (3.122s)
[349.237614] [054/131] (717s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[349.353297] Starting subtest: tiled-to-untiled
[349.468657] Subtest tiled-to-untiled: SUCCESS (0.110s)
[349.652064] [055/131] (717s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[349.837220] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[349.880722] Starting dynamic subtest: pipe-A-valid-mode
[350.250973] Dynamic subtest pipe-A-valid-mode: SKIP (0.406s)
[350.259912] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.411s)
[350.571253] [056/131] (716s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[350.784557] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[350.792699] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[351.046069] [057/131] (716s left) perf_pmu (most-busy-idle-check-all)
[351.500350] Starting subtest: most-busy-idle-check-all
[351.565925] Starting dynamic subtest: rcs0
[352.017700] Dynamic subtest rcs0: SUCCESS (0.625s)
[352.083852] Starting dynamic subtest: bcs0
[352.537084] Dynamic subtest bcs0: SUCCESS (0.618s)
[352.562764] Starting dynamic subtest: vcs0
[353.167092] Dynamic subtest vcs0: SUCCESS (0.623s)
[353.192514] Starting dynamic subtest: vecs0
[353.789075] Dynamic subtest vecs0: SUCCESS (0.621s)
[353.793124] Subtest most-busy-idle-check-all: SUCCESS (2.495s)
[353.953044] [058/131] (713s left) gem_exec_balancer (busy)
[354.084563] Starting subtest: busy
[356.259325] Subtest busy: SUCCESS (2.177s)
[356.554750] [059/131] (710s left) kms_prop_blob (invalid-set-prop-any)
[356.662614] Starting subtest: invalid-set-prop-any
[356.668473] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[356.821719] [060/131] (710s left) gem_exec_schedule (submit-early-slice)
[356.952244] Starting subtest: submit-early-slice
[356.955586] Starting dynamic subtest: rcs0
[357.014142] Dynamic subtest rcs0: SUCCESS (0.064s)
[357.040719] Starting dynamic subtest: bcs0
[357.073148] Dynamic subtest bcs0: SUCCESS (0.057s)
[357.097935] Starting dynamic subtest: vcs0
[357.133365] Dynamic subtest vcs0: SUCCESS (0.054s)
[357.157642] Starting dynamic subtest: vecs0
[357.193236] Dynamic subtest vecs0: SUCCESS (0.058s)
[357.196936] Subtest submit-early-slice: SUCCESS (0.247s)
[357.623119] [061/131] (709s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[357.829675] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[360.855714] Subtest fbc-2p-primscrn-indfb-plflip-blt: SUCCESS (3.024s)
[361.077457] [062/131] (706s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[361.286509] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[361.293634] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[361.458338] [063/131] (706s left) kms_chamelium_hpd (hdmi-hpd-fast)
[362.016294] Subtest hdmi-hpd-fast: SKIP (0.000s)
[362.287549] [064/131] (705s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[362.472251] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[362.477191] Starting dynamic subtest: A-HDMI-A1
[363.881483] Dynamic subtest A-HDMI-A1: SUCCESS (1.399s)
[363.906961] Starting dynamic subtest: B-HDMI-A1
[364.781750] Dynamic subtest B-HDMI-A1: SUCCESS (0.899s)
[364.807282] Starting dynamic subtest: C-HDMI-A1
[365.701025] Dynamic subtest C-HDMI-A1: SUCCESS (0.911s)
[365.729110] Starting dynamic subtest: A-HDMI-A2
[366.681711] Dynamic subtest A-HDMI-A2: SUCCESS (0.974s)
[366.711026] Starting dynamic subtest: B-HDMI-A2
[367.632129] Dynamic subtest B-HDMI-A2: SUCCESS (0.941s)
[367.656521] Starting dynamic subtest: C-HDMI-A2
[368.570822] Dynamic subtest C-HDMI-A2: SUCCESS (0.929s)
[368.574083] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (6.090s)
[368.884601] [065/131] (699s left) kms_flip (bo-too-big)
[369.077475] Starting subtest: bo-too-big
[369.090425] Starting dynamic subtest: A-HDMI-A1
[370.155273] Dynamic subtest A-HDMI-A1: SUCCESS (1.068s)
[370.179941] Starting dynamic subtest: B-HDMI-A1
[370.943574] Dynamic subtest B-HDMI-A1: SUCCESS (0.780s)
[370.968700] Starting dynamic subtest: C-HDMI-A1
[371.736907] Dynamic subtest C-HDMI-A1: SUCCESS (0.787s)
[371.762853] Starting dynamic subtest: A-HDMI-A2
[372.540942] Dynamic subtest A-HDMI-A2: SUCCESS (0.801s)
[372.571261] Starting dynamic subtest: B-HDMI-A2
[373.329005] Dynamic subtest B-HDMI-A2: SUCCESS (0.783s)
[373.354443] Starting dynamic subtest: C-HDMI-A2
[374.139989] Dynamic subtest C-HDMI-A2: SUCCESS (0.804s)
[374.144527] Subtest bo-too-big: SUCCESS (5.060s)
[374.644102] [066/131] (693s left) kms_cursor_crc (cursor-onscreen-64x21)
[374.850932] Starting subtest: cursor-onscreen-64x21
[374.896233] Starting dynamic subtest: pipe-A-HDMI-A-1
[377.618453] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.722s)
[377.737689] Starting dynamic subtest: pipe-C-HDMI-A-1
[380.069742] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.385s)
[380.073165] Subtest cursor-onscreen-64x21: SUCCESS (5.217s)
[380.407297] [067/131] (687s left) gen7_exec_parse (chained-batch)
[380.532453] Subtest chained-batch: SKIP (0.000s)
[380.646162] [068/131] (687s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[380.839488] Starting subtest: crc-primary-basic-yf-tiled-ccs
[380.843617] Starting dynamic subtest: pipe-A-HDMI-A-1
[381.381097] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.526s)
[381.405129] Starting dynamic subtest: pipe-A-HDMI-A-2
[381.890826] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.443s)
[381.915081] Starting dynamic subtest: pipe-B-HDMI-A-1
[382.293769] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.457s)
[382.317706] Starting dynamic subtest: pipe-B-HDMI-A-2
[382.755289] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.413s)
[382.780638] Starting dynamic subtest: pipe-C-HDMI-A-1
[382.813478] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[382.842750] Starting dynamic subtest: pipe-C-HDMI-A-2
[382.873880] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[382.877199] Subtest crc-primary-basic-yf-tiled-ccs: SUCCESS (1.877s)
[383.472149] [069/131] (684s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[383.666115] Starting subtest: fb-8bpc-vs-panel-8bpc
[383.694877] Starting dynamic subtest: pipe-A-HDMI-A-1
[384.432159] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.690s)
[384.518059] Starting dynamic subtest: pipe-A-HDMI-A-2
[384.916205] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.436s)
[384.982502] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.139s)
[385.501716] [070/131] (683s left) gem_userptr_blits (stress-mm-invalidate-close)
[385.640664] Starting subtest: stress-mm-invalidate-close
[387.788889] Subtest stress-mm-invalidate-close: SUCCESS (2.149s)
[387.979603] [071/131] (680s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[388.188771] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[390.627368] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (2.445s)
[390.948191] [072/131] (678s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[391.144853] Starting subtest: extended-pageflip-modeset-hang-oldfb
[391.148386] Starting dynamic subtest: pipe-A
[394.940965] Dynamic subtest pipe-A: SUCCESS (3.793s)
[395.015536] Starting dynamic subtest: pipe-C
[398.962422] Dynamic subtest pipe-C: SUCCESS (4.015s)
[398.966888] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (7.827s)
[399.360236] [073/131] (669s left) kms_psr (fbc-psr-primary-render)
[399.554530] Subtest fbc-psr-primary-render: SKIP (0.000s)
[399.664153] [074/131] (669s left) syncobj_wait (invalid-reset-zero-handles)
[399.772853] Starting subtest: invalid-reset-zero-handles
[399.776367] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[399.941889] [075/131] (669s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[400.130440] Starting subtest: compare-crc-sanitycheck-nv12
[400.144336] Starting dynamic subtest: pipe-A-HDMI-A-1
[401.091923] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.951s)
[401.121761] Starting dynamic subtest: pipe-B-HDMI-A-2
[401.783123] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.681s)
[401.812341] Starting dynamic subtest: pipe-C-HDMI-A-1
[402.419748] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.635s)
[402.423194] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.291s)
[402.732719] [076/131] (666s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[402.944830] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[402.952536] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[403.133375] [077/131] (666s left) gem_ctx_shared (disjoint-timelines)
[403.260976] Starting subtest: disjoint-timelines
[403.355074] Subtest disjoint-timelines: SUCCESS (0.095s)
[403.661889] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[403.669643] [078/131] (665s left) gem_sync (basic-store-all)
[403.806820] Starting subtest: basic-store-all
[406.138222] Subtest basic-store-all: SUCCESS (2.339s)
[406.437309] [079/131] (663s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[406.658194] Starting subtest: x-tiled-32bpp-rotate-270
[406.959459] Subtest x-tiled-32bpp-rotate-270: SKIP (0.297s)
[407.257839] [080/131] (662s left) gem_busy (parallel)
[407.529038] Starting subtest: parallel
[407.533051] Starting dynamic subtest: rcs0
[407.570206] Dynamic subtest rcs0: SUCCESS (0.039s)
[407.596770] Starting dynamic subtest: bcs0
[407.606460] Dynamic subtest bcs0: SUCCESS (0.031s)
[407.632697] Starting dynamic subtest: vcs0
[407.643279] Dynamic subtest vcs0: SUCCESS (0.033s)
[407.667732] Starting dynamic subtest: vecs0
[407.677495] Dynamic subtest vecs0: SUCCESS (0.032s)
[407.681510] Subtest parallel: SUCCESS (0.149s)
[408.005905] [081/131] (661s left) gem_ctx_param (set-priority-not-supported)
[408.115043] Starting subtest: set-priority-not-supported
[408.123185] Subtest set-priority-not-supported: SKIP (0.000s)
[408.288841] [082/131] (661s left) kms_chamelium_color (gamma)
[408.486429] Subtest gamma: SKIP (0.000s)
[408.608813] [083/131] (661s left) gem_exec_whisper (basic-sync-all)
[408.742920] Starting subtest: basic-sync-all
[416.721286] Subtest basic-sync-all: SUCCESS (7.975s)
[416.991788] [084/131] (653s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[417.123159] Starting subtest: map-fixed-invalidate-overlap-busy
[417.126627] Starting dynamic subtest: gtt
[420.845039] Dynamic subtest gtt: SUCCESS (3.718s)
[420.870353] Starting dynamic subtest: wb
[424.487930] Dynamic subtest wb: SUCCESS (3.639s)
[424.519961] Starting dynamic subtest: wc
[428.142061] Dynamic subtest wc: SUCCESS (3.646s)
[428.166794] Starting dynamic subtest: uc
[431.797239] Dynamic subtest uc: SUCCESS (3.651s)
[431.801087] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (14.671s)
[431.995186] [085/131] (638s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[434.640461] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[434.648373] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[434.812666] [086/131] (635s left) kms_cursor_crc (cursor-tearing-position-change)
[435.012412] Starting subtest: cursor-tearing-position-change
[435.015621] Starting dynamic subtest: pipe-A-HDMI-A-1
[435.860675] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.845s)
[435.903775] Starting dynamic subtest: pipe-C-HDMI-A-1
[436.389886] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.518s)
[436.394373] Subtest cursor-tearing-position-change: SUCCESS (1.383s)
[436.736552] [087/131] (633s left) kms_vblank (wait-idle-hang)
[436.932449] Starting subtest: wait-idle-hang
[436.935746] Starting dynamic subtest: pipe-A-HDMI-A-1
[443.979425] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.045s)
[444.029840] Starting dynamic subtest: pipe-A-HDMI-A-2
[450.959670] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.975s)
[451.030536] Starting dynamic subtest: pipe-C-HDMI-A-1
[457.978989] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.008s)
[458.030570] Starting dynamic subtest: pipe-C-HDMI-A-2
[464.964297] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.972s)
[465.007565] Subtest wait-idle-hang: SUCCESS (28.033s)
[465.265446] [088/131] (605s left) kms_flip (2x-dpms-vs-vblank-race)
[465.462205] Starting subtest: 2x-dpms-vs-vblank-race
[465.474109] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[469.780491] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (4.304s)
[469.805607] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[474.263546] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (4.479s)
[474.297248] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[478.703583] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (4.422s)
[478.706773] Subtest 2x-dpms-vs-vblank-race: SUCCESS (13.238s)
[479.042216] [089/131] (591s left) gem_ctx_persistence (file)
[479.177710] Starting subtest: file
[479.262592] Subtest file: SUCCESS (0.083s)
[479.437203] [090/131] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[479.652089] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[479.659133] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[479.837426] [091/131] (591s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[480.033356] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[480.038771] Starting dynamic subtest: pipe-A
[480.353511] Dynamic subtest pipe-A: SUCCESS (0.333s)
[480.387580] Starting dynamic subtest: pipe-B
[480.750054] Dynamic subtest pipe-B: SUCCESS (0.393s)
[480.787606] Starting dynamic subtest: pipe-C
[480.850405] Dynamic subtest pipe-C: SUCCESS (0.093s)
[480.856250] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.829s)
[481.328196] [092/131] (589s left) gem_eio (wait-immediate)
[481.465882] Starting subtest: wait-immediate
[481.550047] Subtest wait-immediate: SUCCESS (0.079s)
[481.847177] [093/131] (589s left) gem_sync (basic-all)
[481.988715] Starting subtest: basic-all
[484.202465] Subtest basic-all: SUCCESS (2.219s)
[484.512933] [094/131] (586s left) kms_joiner (invalid-modeset-ultra-joiner)
[484.711810] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[484.883467] [095/131] (586s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[485.104630] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[485.212590] [096/131] (586s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[485.322134] Starting subtest: basic-wc-cpu-noreloc
[485.336310] Subtest basic-wc-cpu-noreloc: SUCCESS (0.012s)
[485.612212] [097/131] (585s left) gem_exec_schedule (preempt-hang)
[485.857214] Starting subtest: preempt-hang
[485.860287] Starting dynamic subtest: rcs0
[486.119353] Dynamic subtest rcs0: SUCCESS (0.255s)
[486.145907] Starting dynamic subtest: bcs0
[486.396627] Dynamic subtest bcs0: SUCCESS (0.270s)
[486.422774] Starting dynamic subtest: vcs0
[486.645468] Dynamic subtest vcs0: SUCCESS (0.254s)
[486.681875] Starting dynamic subtest: vecs0
[486.904491] Dynamic subtest vecs0: SUCCESS (0.246s)
[486.910494] Subtest preempt-hang: SUCCESS (1.043s)
[487.244518] [098/131] (584s left) gem_exec_fence (keep-in-fence)
[487.494988] Starting subtest: keep-in-fence
[487.498660] Starting dynamic subtest: rcs0
[487.528936] Dynamic subtest rcs0: SUCCESS (0.031s)
[487.554346] Starting dynamic subtest: bcs0
[487.651335] Dynamic subtest bcs0: SUCCESS (0.120s)
[487.679656] Starting dynamic subtest: vcs0
[487.691273] Dynamic subtest vcs0: SUCCESS (0.036s)
[487.717859] Starting dynamic subtest: vecs0
[487.736582] Dynamic subtest vecs0: SUCCESS (0.038s)
[487.740546] Subtest keep-in-fence: SUCCESS (0.240s)
[488.463595] [099/131] (583s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[488.572704] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[488.576565] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[488.731650] [100/131] (583s left) kms_psr (fbc-pr-basic)
[488.918164] Subtest fbc-pr-basic: SKIP (0.000s)
[489.048789] [101/131] (583s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[489.280131] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[489.344260] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[489.986731] [102/131] (582s left) kms_rotation_crc (cursor-rotation-180)
[490.177800] Starting subtest: cursor-rotation-180
[492.021664] Subtest cursor-rotation-180: SUCCESS (1.845s)
[492.290924] [103/131] (579s left) sw_sync (sync_merge_same)
[492.401455] Starting subtest: sync_merge_same
[492.405465] Subtest sync_merge_same: SUCCESS (0.001s)
[492.541630] [104/131] (579s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[492.758946] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[495.691291] Subtest fbc-2p-primscrn-cur-indfb-move: SUCCESS (2.935s)
[495.949188] [105/131] (576s left) kms_selftest (drm_framebuffer)
[496.060562] Starting subtest: drm_framebuffer
[496.084999] Starting dynamic subtest: drm_test_framebuffer_check_src_coords
[496.186934] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.096s)
[496.217863] Starting dynamic subtest: drm_test_framebuffer_cleanup
[496.267869] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.081s)
[496.293290] Starting dynamic subtest: drm_test_framebuffer_create
[496.734111] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.457s)
[496.762789] Starting dynamic subtest: drm_test_framebuffer_free
[496.928601] Dynamic subtest drm_test_framebuffer_free: FAIL (0.139s)
[496.934629] Subtest drm_framebuffer: FAIL (0.819s)
[497.009912] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[497.087659] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true
[497.091203] 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.