[54.231243] Initializing watchdogs
[54.231292]   /dev/watchdog0
[54.245335] [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]
[54.249620] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.251803] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.255031] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[54.372232] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[54.376637] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[54.501913] [002/133] (960s left) syncobj_wait (wait-for-submit-snapshot)
[54.560082] Starting subtest: wait-for-submit-snapshot
[54.642236] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[54.722202] [003/133] (960s left) kms_selftest (drm_dp_mst_helper)
[54.754395] Starting subtest: drm_dp_mst_helper
[54.761089] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[54.902800] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.143s)
[54.909672] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[55.069195] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.168s)
[55.075980] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[55.222452] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.157s)
[55.224347] Subtest drm_dp_mst_helper: SUCCESS (0.475s)
[55.445169] [004/133] (959s left) kms_cursor_edge_walk (128x128-right-edge)
[55.539082] Starting subtest: 128x128-right-edge
[55.541306] Starting dynamic subtest: pipe-A-eDP-1
[58.963262] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s)
[58.971970] Starting dynamic subtest: pipe-D-eDP-1
[62.056891] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[62.059211] Subtest 128x128-right-edge: SUCCESS (6.581s)
[62.880684] [005/133] (952s left) api_intel_allocator (gem-pool)
[62.935945] Starting subtest: gem-pool
[62.941884] Subtest gem-pool: SUCCESS (0.009s)
[63.079793] [006/133] (951s left) gem_ctx_exec (basic-invalid-context)
[63.138089] Starting subtest: basic-invalid-context
[63.142922] Subtest basic-invalid-context: SUCCESS (0.004s)
[63.286316] [007/133] (951s left) gem_exec_store (cachelines)
[63.357645] Starting subtest: cachelines
[63.359816] Starting dynamic subtest: rcs0
[63.485994] Dynamic subtest rcs0: SUCCESS (0.128s)
[63.495430] Starting dynamic subtest: bcs0
[63.549485] Dynamic subtest bcs0: SUCCESS (0.063s)
[63.558772] Starting dynamic subtest: vcs0
[63.615853] Dynamic subtest vcs0: SUCCESS (0.066s)
[63.626086] Starting dynamic subtest: vcs1
[63.670473] Dynamic subtest vcs1: SUCCESS (0.054s)
[63.679648] Starting dynamic subtest: vecs0
[63.730761] Dynamic subtest vecs0: SUCCESS (0.060s)
[63.740072] Starting dynamic subtest: ccs0
[63.794023] Dynamic subtest ccs0: SUCCESS (0.063s)
[63.796538] Subtest cachelines: SUCCESS (0.438s)
[64.002562] [008/133] (951s left) kms_busy (basic-hang)
[64.104954] Starting subtest: basic-hang
[64.107301] Starting dynamic subtest: flip-pipe-A
[64.690715] Dynamic subtest flip-pipe-A: SUCCESS (0.588s)
[64.698436] Starting dynamic subtest: modeset-pipe-A
[68.103669] Dynamic subtest modeset-pipe-A: SUCCESS (3.424s)
[68.112243] Starting dynamic subtest: flip-pipe-D
[69.298889] Dynamic subtest flip-pipe-D: SUCCESS (1.195s)
[69.308770] Starting dynamic subtest: modeset-pipe-D
[72.710878] Dynamic subtest modeset-pipe-D: SUCCESS (3.419s)
[72.713240] Subtest basic-hang: SUCCESS (8.632s)
[73.520579] [009/133] (941s left) gem_gtt_cpu_tlb
[73.647708] [010/133] (941s left) kms_vblank (ts-continuation-idle)
[73.745608] Starting subtest: ts-continuation-idle
[73.747569] Starting dynamic subtest: pipe-A-eDP-1
[74.140119] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[74.153423] Starting dynamic subtest: pipe-D-eDP-1
[75.214277] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.072s)
[75.216817] Subtest ts-continuation-idle: SUCCESS (1.472s)
[76.094507] [011/133] (939s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[76.199583] Starting subtest: bo-too-small-due-to-tiling
[76.203910] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[76.315705] [012/133] (938s left) gem_ctx_shared (q-smoketest)
[76.380629] Starting subtest: Q-smoketest
[76.383081] Starting dynamic subtest: rcs0
[81.940864] Dynamic subtest rcs0: SUCCESS (5.518s)
[81.949484] Starting dynamic subtest: bcs0
[87.459085] Dynamic subtest bcs0: SUCCESS (5.516s)
[87.467414] Starting dynamic subtest: vcs0
[92.935350] Dynamic subtest vcs0: SUCCESS (5.477s)
[92.943129] Starting dynamic subtest: vcs1
[98.436737] Dynamic subtest vcs1: SUCCESS (5.496s)
[98.444970] Starting dynamic subtest: vecs0
[103.907651] Dynamic subtest vecs0: SUCCESS (5.476s)
[103.919582] Starting dynamic subtest: ccs0
[109.419768] Dynamic subtest ccs0: SUCCESS (5.508s)
[109.421739] Subtest Q-smoketest: SUCCESS (32.994s)
[109.623818] [013/133] (905s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[109.688566] Starting subtest: legacy-engines-hostile-preempt
[109.691059] Starting dynamic subtest: render
[109.806847] Dynamic subtest render: SUCCESS (0.117s)
[109.817362] Starting dynamic subtest: bsd1
[110.874318] Dynamic subtest bsd1: SUCCESS (1.064s)
[110.886224] Starting dynamic subtest: bsd2
[112.937295] Dynamic subtest bsd2: SUCCESS (2.061s)
[112.948054] Starting dynamic subtest: blt
[113.022882] Dynamic subtest blt: SUCCESS (0.086s)
[113.032951] Starting dynamic subtest: vebox
[114.923089] Dynamic subtest vebox: SUCCESS (1.897s)
[114.925798] Subtest legacy-engines-hostile-preempt: SUCCESS (5.233s)
[115.013291] [014/133] (900s left) kms_psr (fbc-psr-primary-page-flip)
[115.116937] Starting subtest: fbc-psr-primary-page-flip
[115.119373] Starting dynamic subtest: eDP-1
[115.123708] Dynamic subtest eDP-1: SKIP (0.000s)
[115.128154] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[115.209971] [015/133] (900s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[115.316847] Starting subtest: y-tiled-16bpp-rotate-0
[115.321159] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[115.432783] [016/133] (899s left) dmabuf_sync_file (export-wait-after-attach)
[115.542769] Starting subtest: export-wait-after-attach
[115.544905] Subtest export-wait-after-attach: SUCCESS (0.001s)
[115.615147] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[115.618170] [017/133] (899s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[115.706426] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[115.814704] [018/133] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[115.909268] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[115.913244] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[116.043823] [019/133] (899s left) gem_pxp (verify-pxp-stale-buf-execution)
[116.176661] Starting subtest: verify-pxp-stale-buf-execution
[117.240044] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.063s)
[117.394566] [020/133] (898s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[117.491279] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[117.495243] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[117.616122] [021/133] (897s left) kms_flip (flip-vs-modeset-vs-hang)
[117.720755] Starting subtest: flip-vs-modeset-vs-hang
[117.723265] Starting dynamic subtest: A-eDP1
[168.364775] Dynamic subtest A-eDP1: SUCCESS (50.644s)
[168.375628] Starting dynamic subtest: D-eDP1
[218.352527] Dynamic subtest D-eDP1: SUCCESS (49.984s)
[218.354862] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.632s)
[218.743836] [022/133] (796s left) kms_cdclk (plane-scaling)
[218.840232] Starting subtest: plane-scaling
[218.842589] Starting dynamic subtest: pipe-A-eDP-1
[219.133593] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[219.143019] Starting dynamic subtest: pipe-B-eDP-1
[219.147403] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s)
[219.155076] Starting dynamic subtest: pipe-C-eDP-1
[219.159437] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[219.166996] Starting dynamic subtest: pipe-D-eDP-1
[219.171580] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[219.175774] Subtest plane-scaling: SKIP (0.301s)
[219.989196] [023/133] (795s left) kms_cursor_crc (cursor-random-256x256)
[220.233684] Starting subtest: cursor-random-256x256
[220.238965] Starting dynamic subtest: pipe-A-eDP-1
[223.580670] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.340s)
[223.607609] Starting dynamic subtest: pipe-D-eDP-1
[227.580279] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.980s)
[227.582677] Subtest cursor-random-256x256: SUCCESS (7.346s)
[228.453817] [024/133] (787s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[228.520244] Starting subtest: wait-all-for-submit-delayed-submit
[228.623581] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[228.711179] [025/133] (786s left) gem_exec_balancer (semaphore)
[228.776602] Starting subtest: semaphore
[230.969060] Subtest semaphore: SUCCESS (2.192s)
[231.337712] [026/133] (784s left) kms_properties (crtc-properties-legacy)
[231.443932] Starting subtest: crtc-properties-legacy
[231.446298] Starting dynamic subtest: pipe-A-eDP-1
[231.881798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s)
[231.890178] Starting dynamic subtest: pipe-B-eDP-1
[233.004089] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.120s)
[233.012939] Starting dynamic subtest: pipe-C-eDP-1
[234.115630] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[234.125284] Starting dynamic subtest: pipe-D-eDP-1
[235.249903] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[235.252246] Subtest crtc-properties-legacy: SUCCESS (3.806s)
[236.066417] [027/133] (779s left) gem_exec_schedule (implicit-read-write)
[236.139527] Starting subtest: implicit-read-write
[236.141841] Starting dynamic subtest: rcs0
[236.237746] Dynamic subtest rcs0: SUCCESS (0.107s)
[236.248065] Starting dynamic subtest: vcs0
[236.316250] Dynamic subtest vcs0: SUCCESS (0.078s)
[236.326723] Starting dynamic subtest: vcs1
[236.393868] Dynamic subtest vcs1: SUCCESS (0.077s)
[236.404511] Starting dynamic subtest: vecs0
[236.470665] Dynamic subtest vecs0: SUCCESS (0.077s)
[236.480781] Starting dynamic subtest: ccs0
[236.555412] Dynamic subtest ccs0: SUCCESS (0.084s)
[236.557888] Subtest implicit-read-write: SUCCESS (0.426s)
[238.034752] [028/133] (777s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[238.135535] Starting subtest: x-tiled-8bpp-rotate-0
[239.339319] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.203s)
[239.505606] [029/133] (776s left) i915_query (query-regions-sanity-check)
[239.564455] Starting subtest: query-regions-sanity-check
[239.573274] Subtest query-regions-sanity-check: SUCCESS (0.011s)
[239.704688] [030/133] (776s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[239.797555] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[239.799486] Starting dynamic subtest: pipe-A-eDP-1
[239.818991] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[239.828394] Starting dynamic subtest: pipe-B-eDP-1
[239.846025] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[239.853323] Starting dynamic subtest: pipe-C-eDP-1
[239.871067] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[239.878539] Starting dynamic subtest: pipe-D-eDP-1
[239.896760] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[239.900276] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[242.035258] [031/133] (773s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[246.995985] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[247.000816] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[247.850771] [032/133] (768s left) gem_mmap_gtt (basic-read)
[247.895775] Subtest basic-read: SKIP (0.000s)
[247.955907] [033/133] (768s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[248.012912] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[248.081943] [034/133] (767s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[248.184757] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[248.188800] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[248.317908] [035/133] (767s left) kms_psr (psr-primary-render)
[248.419380] Starting subtest: psr-primary-render
[248.421720] Starting dynamic subtest: eDP-1
[250.135199] Dynamic subtest eDP-1: SUCCESS (1.716s)
[250.137459] Subtest psr-primary-render: SUCCESS (1.717s)
[251.019899] [036/133] (765s left) gem_sync (basic-store-all)
[251.104374] Starting subtest: basic-store-all
[253.550162] Subtest basic-store-all: SUCCESS (2.456s)
[253.742687] [037/133] (762s left) gem_spin_batch (spin-all-new)
[253.803468] Starting subtest: spin-all-new
[253.824714] Subtest spin-all-new: SUCCESS (0.020s)
[254.984744] [038/133] (761s left) i915_module_load (reload-with-fault-injection)
[255.015086] Starting subtest: reload-with-fault-injection
[298.558215] Subtest reload-with-fault-injection: SUCCESS (43.541s)
[298.588692] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[298.589493] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[298.592634] [039/133] (717s left) kms_chamelium_frames (dp-crc-fast)
[300.347131] Subtest dp-crc-fast: SKIP (0.000s)
[301.180046] [FACT kms_chamelium_frames (dp-crc-fast)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[301.181292] [FACT kms_chamelium_frames (dp-crc-fast)] new: kernel.kmod_is_loaded.i915: true
[301.184917] [040/133] (715s left) gen7_exec_parse (basic-allowed)
[301.254718] Subtest basic-allowed: SKIP (0.000s)
[301.336024] [041/133] (714s left) gem_tiled_wb
[301.451901] [042/133] (714s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[301.543158] Starting subtest: fbc-psr-sprite-mmap-gtt
[301.545449] Starting dynamic subtest: eDP-1
[301.549830] Dynamic subtest eDP-1: SKIP (0.000s)
[301.554244] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[301.628690] [043/133] (714s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[301.685305] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[301.689816] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[301.889449] [044/133] (714s left) perf (buffer-fill)
[302.012256] Starting subtest: buffer-fill
[302.014475] Starting dynamic subtest: 0-rcs0
[304.263713] Dynamic subtest 0-rcs0: SUCCESS (2.250s)
[304.271507] Starting dynamic subtest: 1-vcs0
[308.714926] Dynamic subtest 1-vcs0: SUCCESS (4.450s)
[308.717453] Subtest buffer-fill: SUCCESS (6.703s)
[308.763502] [045/133] (707s left) kms_vblank (crtc-id)
[308.860649] Starting subtest: crtc-id
[308.862836] Starting dynamic subtest: pipe-A-eDP-1
[309.322460] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.462s)
[309.335416] Starting dynamic subtest: pipe-D-eDP-1
[310.433763] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.110s)
[310.436103] Subtest crtc-id: SUCCESS (1.576s)
[311.291038] [046/133] (705s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[311.406837] Starting subtest: fbcpsr-1p-rte
[318.367377] Subtest fbcpsr-1p-rte: SUCCESS (6.963s)
[318.561317] [047/133] (697s left) kms_flip (2x-blocking-absolute-wf_vblank)
[318.663096] Starting subtest: 2x-blocking-absolute-wf_vblank
[318.674892] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[318.781334] [048/133] (697s left) gem_exec_params (dr1-dirt)
[318.846980] Starting subtest: DR1-dirt
[318.849464] Subtest DR1-dirt: SUCCESS (0.000s)
[318.966254] [049/133] (697s left) i915_pm_rc6_residency (rc6-fence)
[319.029165] Starting subtest: rc6-fence
[319.045791] Starting dynamic subtest: gt0
[331.363235] Dynamic subtest gt0: SUCCESS (12.316s)
[331.373600] Starting dynamic subtest: gt1
[344.915970] Dynamic subtest gt1: SUCCESS (13.549s)
[344.918742] Subtest rc6-fence: SUCCESS (25.889s)
[345.072867] [050/133] (671s left) kms_flip (blocking-wf_vblank)
[345.172256] Starting subtest: blocking-wf_vblank
[345.174447] Starting dynamic subtest: A-eDP1
[354.067464] Dynamic subtest A-eDP1: SUCCESS (8.896s)
[354.078592] Starting dynamic subtest: B-eDP1
[362.998488] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[363.006935] Starting dynamic subtest: C-eDP1
[371.921904] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[371.935430] Starting dynamic subtest: D-eDP1
[380.845155] Dynamic subtest D-eDP1: SUCCESS (8.920s)
[380.847497] Subtest blocking-wf_vblank: SUCCESS (35.675s)
[382.075071] [051/133] (634s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[382.176307] Starting subtest: fbc-psr2-cursor-mmap-cpu
[382.178589] Starting dynamic subtest: eDP-1
[382.183093] Dynamic subtest eDP-1: SKIP (0.000s)
[382.187462] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[382.259822] [052/133] (634s left) gem_basic (multigpu-create-close)
[382.316703] Starting subtest: multigpu-create-close
[382.321479] Subtest multigpu-create-close: SKIP (0.000s)
[382.446301] [053/133] (634s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[382.531059] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[382.533312] Starting dynamic subtest: pipe-A-default-mode
[383.730623] Dynamic subtest pipe-A-default-mode: SKIP (1.196s)
[383.735060] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.197s)
[383.896785] [054/133] (632s left) kms_colorop (plane-xr30-xr30-gamma_2_2_inv_oetf-gamma_2_2_oetf-gamma_2_2_inv_
[384.033865] Subtest plane-XR30-XR30-gamma_2_2_inv_oetf-gamma_2_2_oetf-gamma_2_2_inv_oetf: SKIP (0.000s)
[384.114055] [055/133] (632s left) kms_getfb (getfb2-into-addfb2)
[384.211064] Starting subtest: getfb2-into-addfb2
[384.213271] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[384.349867] [056/133] (632s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[384.438279] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[388.128760] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.692s)
[389.320231] [057/133] (627s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[389.445161] Starting subtest: cursorB-vs-flipA-legacy
[389.449703] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[389.612157] [058/133] (627s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[394.564320] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[394.566695] Starting dynamic subtest: pipe-A-eDP-1
[406.282854] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.717s)
[406.292047] Starting dynamic subtest: pipe-B-eDP-1
[418.028951] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.741s)
[418.031489] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.463s)
[418.900856] [059/133] (598s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[419.009744] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[426.386908] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.378s)
[426.556531] [060/133] (590s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[426.656564] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[431.015542] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.362s)
[432.215443] [061/133] (584s left) gem_exec_reloc (basic-gtt-noreloc)
[432.280223] Subtest basic-gtt-noreloc: SKIP (0.000s)
[432.355046] [062/133] (584s left) gem_exec_schedule (u-semaphore-user)
[432.429391] Starting subtest: u-semaphore-user
[432.481622] Subtest u-semaphore-user: SUCCESS (0.059s)
[433.938448] [063/133] (583s left) kms_lease (lessee-list)
[434.037980] Starting subtest: lessee-list
[434.040393] Starting dynamic subtest: pipe-A-eDP-1
[434.042733] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[434.051351] Starting dynamic subtest: pipe-B-eDP-1
[434.053512] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[434.061671] Starting dynamic subtest: pipe-C-eDP-1
[434.063811] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[434.071867] Starting dynamic subtest: pipe-D-eDP-1
[434.074047] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[434.076177] Subtest lessee-list: SUCCESS (0.010s)
[434.177061] [064/133] (583s left) kms_plane_alpha_blend (alpha-opaque-fb)
[434.276364] Starting subtest: alpha-opaque-fb
[434.567423] Starting dynamic subtest: pipe-A-eDP-1
[435.192975] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s)
[435.202370] Starting dynamic subtest: pipe-D-eDP-1
[436.546315] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.358s)
[436.548569] Subtest alpha-opaque-fb: SUCCESS (2.272s)
[437.385557] [065/133] (579s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[437.448653] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[437.450986] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[437.590754] [066/133] (579s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[437.694768] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[437.699283] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[437.826294] [067/133] (579s left) prime_busy (hang-wait)
[437.883097] Starting subtest: hang-wait
[437.885511] Starting dynamic subtest: rcs0
[464.437663] Dynamic subtest rcs0: SUCCESS (26.549s)
[464.445636] Starting dynamic subtest: bcs0
[471.525257] Dynamic subtest bcs0: SUCCESS (7.085s)
[471.535548] Starting dynamic subtest: vcs0
[478.500808] Dynamic subtest vcs0: SUCCESS (6.972s)
[478.511201] Starting dynamic subtest: vcs1
[485.540201] Dynamic subtest vcs1: SUCCESS (7.036s)
[485.554064] Starting dynamic subtest: vecs0
[492.517847] Dynamic subtest vecs0: SUCCESS (6.977s)
[492.528551] Starting dynamic subtest: ccs0
[506.353679] Dynamic subtest ccs0: SUCCESS (13.834s)
[506.355851] Subtest hang-wait: SUCCESS (68.466s)
[506.497903] [068/133] (510s left) kms_invalid_mode (zero-vdisplay)
[506.594450] Starting subtest: zero-vdisplay
[506.596819] Starting dynamic subtest: pipe-A-eDP-1
[506.886587] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[506.896719] Starting dynamic subtest: pipe-B-eDP-1
[506.899128] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[506.909411] Starting dynamic subtest: pipe-C-eDP-1
[506.911334] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[506.919166] Starting dynamic subtest: pipe-D-eDP-1
[506.921471] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[506.923806] Subtest zero-vdisplay: SUCCESS (0.295s)
[507.685538] [069/133] (509s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[507.798090] Starting subtest: fbc-2p-pri-indfb-multidraw
[507.802364] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[507.906104] [070/133] (509s left) gen3_render_tiledx_blits
[508.024239] [071/133] (509s left) syncobj_eventfd (invalid-bad-flags)
[508.070174] Starting subtest: invalid-bad-flags
[508.072465] Subtest invalid-bad-flags: SUCCESS (0.000s)
[508.215886] [072/133] (509s left) kms_content_protection (dp-mst-type-0)
[508.346617] Starting subtest: dp-mst-type-0
[508.351172] Subtest dp-mst-type-0: SKIP (0.000s)
[508.517014] [073/133] (509s left) kms_addfb_basic (addfb25-bad-modifier)
[508.611624] Starting subtest: addfb25-bad-modifier
[508.613590] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[508.731496] [074/133] (508s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[508.985645] Starting subtest: cursor-rapid-movement-512x512
[508.989580] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[509.199840] [075/133] (508s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[509.586539] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[510.384880] [076/133] (507s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[510.510287] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[510.514650] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[510.680344] [077/133] (507s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[510.789209] Starting subtest: psr-rgb565-draw-mmap-wc
[517.594840] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.809s)
[517.729103] [078/133] (500s left) kms_flip (flip-vs-expired-vblank)
[517.821203] Starting subtest: flip-vs-expired-vblank
[517.823531] Starting dynamic subtest: A-eDP1
[526.528899] Dynamic subtest A-eDP1: SUCCESS (8.707s)
[526.537510] Starting dynamic subtest: B-eDP1
[535.167100] Dynamic subtest B-eDP1: SUCCESS (8.635s)
[535.180233] Starting dynamic subtest: C-eDP1
[543.789493] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[543.798063] Starting dynamic subtest: D-eDP1
[552.438116] Dynamic subtest D-eDP1: SUCCESS (8.647s)
[552.443332] Subtest flip-vs-expired-vblank: SUCCESS (34.621s)
[553.636660] [079/133] (464s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[553.729228] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[553.731460] Starting dynamic subtest: pipe-A-default-mode
[554.873439] Dynamic subtest pipe-A-default-mode: SKIP (1.143s)
[554.878034] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.144s)
[555.064798] [080/133] (462s left) gem_create (hog-create)
[555.122133] Starting subtest: hog-create
[555.124530] Starting dynamic subtest: smem0
[588.985065] Dynamic subtest smem0: SUCCESS (33.859s)
[588.987894] Subtest hog-create: SUCCESS (33.861s)
[589.193898] [081/133] (428s left) gem_exec_gttfill (all-engines)
[589.260243] Starting subtest: all-engines
[612.878991] Subtest all-engines: SUCCESS (23.617s)
[613.094652] [082/133] (404s left) api_intel_bb (intel-bb-blit-none)
[613.185595] Starting subtest: intel-bb-blit-none
[617.086440] Subtest intel-bb-blit-none: SUCCESS (3.900s)
[617.241459] [083/133] (400s left) sysfs_defaults (readonly)
[617.304584] Starting subtest: readonly
[617.306836] Starting dynamic subtest: vecs0
[617.309453] Dynamic subtest vecs0: SUCCESS (0.000s)
[617.318367] Starting dynamic subtest: ccs0
[617.320264] Dynamic subtest ccs0: SUCCESS (0.000s)
[617.329073] Starting dynamic subtest: vcs0
[617.331245] Dynamic subtest vcs0: SUCCESS (0.000s)
[617.339745] Starting dynamic subtest: bcs0
[617.341663] Dynamic subtest bcs0: SUCCESS (0.000s)
[617.349728] Starting dynamic subtest: rcs0
[617.351686] Dynamic subtest rcs0: SUCCESS (0.000s)
[617.359932] Starting dynamic subtest: vcs1
[617.361911] Dynamic subtest vcs1: SUCCESS (0.000s)
[617.363875] Subtest readonly: SUCCESS (0.006s)
[617.400164] [084/133] (400s left) gem_lmem_swapping (verify-ccs)
[617.447083] Subtest verify-ccs: SKIP (0.000s)
[617.492912] [085/133] (400s left) kms_async_flips (test-time-stamp)
[617.589892] Starting subtest: test-time-stamp
[617.972264] Starting dynamic subtest: pipe-A-eDP-1
[619.218902] Dynamic subtest pipe-A-eDP-1: FAIL (0.766s)
[619.229655] Starting dynamic subtest: pipe-B-eDP-1
[620.111317] Dynamic subtest pipe-B-eDP-1: FAIL (0.744s)
[620.235076] Starting dynamic subtest: pipe-C-eDP-1
[621.004329] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.778s)
[621.378674] Starting dynamic subtest: pipe-D-eDP-1
[622.133755] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.762s)
[622.136205] Subtest test-time-stamp: FAIL (4.544s)
[623.301368] [086/133] (394s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[623.403945] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[632.051338] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.651s)
[632.191791] [087/133] (385s left) kms_pm_backlight (fade-with-suspend)
[632.283075] Starting subtest: fade-with-suspend
[648.871495] Starting dynamic subtest: eDP-1
[651.551500] Dynamic subtest eDP-1: SUCCESS (2.731s)
[651.553826] Subtest fade-with-suspend: SUCCESS (4.089s)
[652.350316] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[652.367938] [FACT kms_pm_backlight (fade-with-suspend)] new: kernel.is_tainted.taint_warn: true
[652.368750] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_selftest
results: parsing output: 3/ for test: kms_cursor_edge_walk
results: parsing output: 4/ for test: api_intel_allocator
results: parsing output: 5/ for test: gem_ctx_exec
results: parsing output: 6/ for test: gem_exec_store
results: parsing output: 7/ for test: kms_busy
results: parsing output: 8/ for test: gem_gtt_cpu_tlb
results: parsing output: 9/ for test: kms_vblank
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: gem_ctx_shared
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: dmabuf_sync_file
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_cdclk
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: kms_properties
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: i915_query
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_sync
results: parsing output: 36/ for test: gem_spin_batch
results: parsing output: 37/ for test: i915_module_load
results: parsing output: 38/ for test: kms_chamelium_frames
results: parsing output: 39/ for test: gen7_exec_parse
results: parsing output: 40/ for test: gem_tiled_wb
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: i915_pm_rc6_residency
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_basic
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_colorop
results: parsing output: 54/ for test: kms_getfb
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_lease
results: parsing output: 63/ for test: kms_plane_alpha_blend
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: prime_busy
results: parsing output: 67/ for test: kms_invalid_mode
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gen3_render_tiledx_blits
results: parsing output: 70/ for test: syncobj_eventfd
results: parsing output: 71/ for test: kms_content_protection
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: kms_chamelium_hpd
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: gem_create
results: parsing output: 80/ for test: gem_exec_gttfill
results: parsing output: 81/ for test: api_intel_bb
results: parsing output: 82/ for test: sysfs_defaults
results: parsing output: 83/ for test: gem_lmem_swapping
results: parsing output: 84/ for test: kms_async_flips
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_pm_backlight
results: parsing output: 87/ for test: gem_pxp
results: no output, setting notrun
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 89/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 90/ for test: i915_drm_fdinfo
results: no output, setting notrun
results: parsing output: 91/ for test: kms_properties
results: no output, setting notrun
results: parsing output: 92/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 93/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 94/ for test: kms_colorop
results: no output, setting notrun
results: parsing output: 95/ for test: gem_mmap_wc
results: no output, setting notrun
results: parsing output: 96/ for test: kms_colorop
results: no output, setting notrun
results: parsing output: 97/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 98/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 99/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 100/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 102/ for test: gem_mmap_wc
results: no output, setting notrun
results: parsing output: 103/ for test: gem_madvise
results: no output, setting notrun
results: parsing output: 104/ for test: kms_dsc
results: no output, setting notrun
results: parsing output: 105/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 106/ for test: gem_exec_fence
results: no output, setting notrun
results: parsing output: 107/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 108/ for test: kms_pm_rpm
results: no output, setting notrun
results: parsing output: 109/ for test: kms_writeback
results: no output, setting notrun
results: parsing output: 110/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 111/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 112/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 113/ for test: vgem_basic
results: no output, setting notrun
results: parsing output: 114/ for test: kms_plane_scaling
results: no output, setting notrun
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 116/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 117/ for test: gem_mmap_offset
results: no output, setting notrun
results: parsing output: 118/ for test: kms_plane_scaling
results: no output, setting notrun
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 120/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 121/ for test: gem_lmem_swapping
results: no output, setting notrun
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 123/ for test: perf
results: no output, setting notrun
results: parsing output: 124/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 125/ for test: gem_mmap_gtt
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: gem_tiled_partial_pwrite_pread
results: no output, setting notrun
results: parsing output: 128/ for test: gem_userptr_blits
results: no output, setting notrun
results: parsing output: 129/ for test: kms_setmode
results: no output, setting notrun
results: parsing output: 130/ for test: gem_exec_balancer
results: no output, setting notrun
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 132/ for test: gem_exec_reloc
results: no output, setting notrun
Done.