[55.136415] Initializing watchdogs
[55.136466]   /dev/watchdog0
[55.151564] [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]
[55.156197] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.158450] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.161781] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[55.289622] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[55.293701] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[55.417816] [002/133] (960s left) syncobj_wait (wait-for-submit-snapshot)
[55.470865] Starting subtest: wait-for-submit-snapshot
[55.551312] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[55.630261] [003/133] (960s left) kms_selftest (drm_dp_mst_helper)
[55.663431] Starting subtest: drm_dp_mst_helper
[55.668153] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[55.751456] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.082s)
[55.757711] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[55.902298] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.152s)
[55.910835] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[56.049492] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.145s)
[56.051489] Subtest drm_dp_mst_helper: SUCCESS (0.386s)
[56.274597] [004/133] (959s left) kms_cursor_edge_walk (128x128-right-edge)
[56.357694] Starting subtest: 128x128-right-edge
[56.359947] Starting dynamic subtest: pipe-A-eDP-1
[59.776918] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[59.787605] Starting dynamic subtest: pipe-D-eDP-1
[62.890573] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[62.892844] Subtest 128x128-right-edge: SUCCESS (6.535s)
[63.708765] [005/133] (952s left) api_intel_allocator (gem-pool)
[63.769806] Starting subtest: gem-pool
[63.780714] Subtest gem-pool: SUCCESS (0.012s)
[63.921954] [006/133] (951s left) gem_ctx_exec (basic-invalid-context)
[63.979469] Starting subtest: basic-invalid-context
[63.985234] Subtest basic-invalid-context: SUCCESS (0.005s)
[64.134255] [007/133] (951s left) gem_exec_store (cachelines)
[64.191194] Starting subtest: cachelines
[64.193448] Starting dynamic subtest: rcs0
[64.311199] Dynamic subtest rcs0: SUCCESS (0.121s)
[64.319905] Starting dynamic subtest: bcs0
[64.369303] Dynamic subtest bcs0: SUCCESS (0.057s)
[64.378242] Starting dynamic subtest: vcs0
[64.435280] Dynamic subtest vcs0: SUCCESS (0.065s)
[64.444519] Starting dynamic subtest: vcs1
[64.499171] Dynamic subtest vcs1: SUCCESS (0.063s)
[64.508105] Starting dynamic subtest: vecs0
[64.564720] Dynamic subtest vecs0: SUCCESS (0.064s)
[64.573757] Starting dynamic subtest: ccs0
[64.619487] Dynamic subtest ccs0: SUCCESS (0.053s)
[64.621775] Subtest cachelines: SUCCESS (0.430s)
[64.821624] [008/133] (951s left) kms_busy (basic-hang)
[64.921852] Starting subtest: basic-hang
[64.924092] Starting dynamic subtest: flip-pipe-A
[65.499678] Dynamic subtest flip-pipe-A: SUCCESS (0.578s)
[65.508910] Starting dynamic subtest: modeset-pipe-A
[68.922795] Dynamic subtest modeset-pipe-A: SUCCESS (3.423s)
[68.930994] Starting dynamic subtest: flip-pipe-D
[70.136306] Dynamic subtest flip-pipe-D: SUCCESS (1.210s)
[70.146566] Starting dynamic subtest: modeset-pipe-D
[73.576936] Dynamic subtest modeset-pipe-D: SUCCESS (3.442s)
[73.579217] Subtest basic-hang: SUCCESS (8.659s)
[74.382634] [009/133] (941s left) gem_gtt_cpu_tlb
[74.497760] [010/133] (941s left) kms_vblank (ts-continuation-idle)
[74.585913] Starting subtest: ts-continuation-idle
[74.588202] Starting dynamic subtest: pipe-A-eDP-1
[74.983621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[74.997502] Starting dynamic subtest: pipe-D-eDP-1
[76.076325] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.092s)
[76.078636] Subtest ts-continuation-idle: SUCCESS (1.493s)
[76.973997] [011/133] (939s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[77.072705] Starting subtest: bo-too-small-due-to-tiling
[77.077047] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[77.191370] [012/133] (938s left) gem_ctx_shared (q-smoketest)
[77.257970] Starting subtest: Q-smoketest
[77.260374] Starting dynamic subtest: rcs0
[82.820201] Dynamic subtest rcs0: SUCCESS (5.517s)
[82.828220] Starting dynamic subtest: bcs0
[88.330898] Dynamic subtest bcs0: SUCCESS (5.508s)
[88.337863] Starting dynamic subtest: vcs0
[93.814392] Dynamic subtest vcs0: SUCCESS (5.481s)
[93.823631] Starting dynamic subtest: vcs1
[99.301024] Dynamic subtest vcs1: SUCCESS (5.490s)
[99.308711] Starting dynamic subtest: vecs0
[104.783201] Dynamic subtest vecs0: SUCCESS (5.482s)
[104.791031] Starting dynamic subtest: ccs0
[110.277623] Dynamic subtest ccs0: SUCCESS (5.489s)
[110.279611] Subtest Q-smoketest: SUCCESS (32.969s)
[110.428363] [013/133] (905s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[110.492675] Starting subtest: legacy-engines-hostile-preempt
[110.494973] Starting dynamic subtest: render
[110.621466] Dynamic subtest render: SUCCESS (0.129s)
[110.631862] Starting dynamic subtest: bsd1
[111.920343] Dynamic subtest bsd1: SUCCESS (1.296s)
[111.930409] Starting dynamic subtest: bsd2
[113.960440] Dynamic subtest bsd2: SUCCESS (2.038s)
[113.970592] Starting dynamic subtest: blt
[114.003713] Dynamic subtest blt: SUCCESS (0.042s)
[114.013129] Starting dynamic subtest: vebox
[115.937325] Dynamic subtest vebox: SUCCESS (1.932s)
[115.939901] Subtest legacy-engines-hostile-preempt: SUCCESS (5.444s)
[116.026407] [014/133] (900s left) kms_psr (fbc-psr-primary-page-flip)
[116.128229] Starting subtest: fbc-psr-primary-page-flip
[116.130150] Starting dynamic subtest: eDP-1
[116.134258] Dynamic subtest eDP-1: SKIP (0.000s)
[116.138393] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[116.223198] [015/133] (899s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[116.319709] Starting subtest: y-tiled-16bpp-rotate-0
[116.324150] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[116.436794] [016/133] (899s left) dmabuf_sync_file (export-wait-after-attach)
[116.533952] Starting subtest: export-wait-after-attach
[116.536603] Subtest export-wait-after-attach: SUCCESS (0.001s)
[116.609938] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[116.613023] [017/133] (899s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[116.708116] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[116.826840] [018/133] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[116.922524] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[116.926691] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[117.052592] [019/133] (899s left) gem_pxp (verify-pxp-stale-buf-execution)
[117.171523] Starting subtest: verify-pxp-stale-buf-execution
[118.235315] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.065s)
[118.390977] [020/133] (897s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[118.495554] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[118.499661] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[118.605219] [021/133] (897s left) kms_flip (flip-vs-modeset-vs-hang)
[118.698511] Starting subtest: flip-vs-modeset-vs-hang
[118.700734] Starting dynamic subtest: A-eDP1
[169.390831] Dynamic subtest A-eDP1: SUCCESS (50.692s)
[169.401984] Starting dynamic subtest: D-eDP1
[219.376281] Dynamic subtest D-eDP1: SUCCESS (49.983s)
[219.378442] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.680s)
[219.757588] [022/133] (796s left) kms_cdclk (plane-scaling)
[219.845062] Starting subtest: plane-scaling
[219.847428] Starting dynamic subtest: pipe-A-eDP-1
[220.144077] Dynamic subtest pipe-A-eDP-1: SKIP (0.298s)
[220.153376] Starting dynamic subtest: pipe-B-eDP-1
[220.157690] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[220.164907] Starting dynamic subtest: pipe-C-eDP-1
[220.169502] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[220.176869] Starting dynamic subtest: pipe-D-eDP-1
[220.181152] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[220.185425] Subtest plane-scaling: SKIP (0.304s)
[220.995678] [023/133] (795s left) kms_cursor_crc (cursor-random-256x256)
[221.233745] Starting subtest: cursor-random-256x256
[221.239034] Starting dynamic subtest: pipe-A-eDP-1
[224.568592] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.330s)
[224.597144] Starting dynamic subtest: pipe-D-eDP-1
[228.581106] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.989s)
[228.583066] Subtest cursor-random-256x256: SUCCESS (7.345s)
[229.468250] [024/133] (787s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[229.523752] Starting subtest: wait-all-for-submit-delayed-submit
[229.627670] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[229.729609] [025/133] (786s left) gem_exec_balancer (semaphore)
[229.798804] Starting subtest: semaphore
[231.869685] Subtest semaphore: SUCCESS (2.071s)
[232.233130] [026/133] (784s left) kms_properties (crtc-properties-legacy)
[232.346700] Starting subtest: crtc-properties-legacy
[232.349024] Starting dynamic subtest: pipe-A-eDP-1
[232.792654] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[232.801995] Starting dynamic subtest: pipe-B-eDP-1
[233.923366] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.130s)
[233.931561] Starting dynamic subtest: pipe-C-eDP-1
[235.050229] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[235.059590] Starting dynamic subtest: pipe-D-eDP-1
[236.178641] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[236.180988] Subtest crtc-properties-legacy: SUCCESS (3.832s)
[236.999017] [027/133] (779s left) gem_exec_schedule (implicit-read-write)
[237.071132] Starting subtest: implicit-read-write
[237.073089] Starting dynamic subtest: rcs0
[237.169320] Dynamic subtest rcs0: SUCCESS (0.108s)
[237.179296] Starting dynamic subtest: vcs0
[237.250165] Dynamic subtest vcs0: SUCCESS (0.081s)
[237.260063] Starting dynamic subtest: vcs1
[237.334128] Dynamic subtest vcs1: SUCCESS (0.084s)
[237.346090] Starting dynamic subtest: vecs0
[237.414225] Dynamic subtest vecs0: SUCCESS (0.079s)
[237.424584] Starting dynamic subtest: ccs0
[237.496867] Dynamic subtest ccs0: SUCCESS (0.082s)
[237.499706] Subtest implicit-read-write: SUCCESS (0.436s)
[239.046018] [028/133] (777s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[239.155810] Starting subtest: x-tiled-8bpp-rotate-0
[240.348602] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.192s)
[240.514117] [029/133] (776s left) i915_query (query-regions-sanity-check)
[240.569986] Starting subtest: query-regions-sanity-check
[240.579667] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[240.729325] [030/133] (776s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[240.828759] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[240.831042] Starting dynamic subtest: pipe-A-eDP-1
[240.851555] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[240.863084] Starting dynamic subtest: pipe-B-eDP-1
[240.880522] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[240.890902] Starting dynamic subtest: pipe-C-eDP-1
[240.908740] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[240.916169] Starting dynamic subtest: pipe-D-eDP-1
[240.934154] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[240.937700] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[243.083679] [031/133] (773s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[248.068331] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[248.072963] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[248.910730] [032/133] (767s left) gem_mmap_gtt (basic-read)
[248.967600] Subtest basic-read: SKIP (0.000s)
[249.028070] [033/133] (767s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[249.082818] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[249.143937] [034/133] (767s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[249.239564] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[249.243948] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[249.364824] [035/133] (767s left) kms_psr (psr-primary-render)
[249.455219] Starting subtest: psr-primary-render
[249.457511] Starting dynamic subtest: eDP-1
[251.195315] Dynamic subtest eDP-1: SUCCESS (1.740s)
[251.197566] Subtest psr-primary-render: SUCCESS (1.741s)
[252.085386] [036/133] (764s left) gem_sync (basic-store-all)
[252.151793] Starting subtest: basic-store-all
[254.974644] Subtest basic-store-all: SUCCESS (2.832s)
[255.170420] [037/133] (761s left) gem_spin_batch (spin-all-new)
[255.234469] Starting subtest: spin-all-new
[255.256424] Subtest spin-all-new: SUCCESS (0.021s)
[256.978599] [038/133] (760s left) i915_module_load (reload-with-fault-injection)
[257.009390] Starting subtest: reload-with-fault-injection
[288.535211] Subtest reload-with-fault-injection: SUCCESS (31.523s)
[288.563866] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[288.564573] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[288.568083] [039/133] (728s left) kms_chamelium_frames (dp-crc-fast)
[290.315567] Subtest dp-crc-fast: SKIP (0.000s)
[291.151654] [FACT kms_chamelium_frames (dp-crc-fast)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[291.152919] [FACT kms_chamelium_frames (dp-crc-fast)] new: kernel.kmod_is_loaded.i915: true
[291.156551] [040/133] (726s left) gen7_exec_parse (basic-allowed)
[291.235195] Subtest basic-allowed: SKIP (0.000s)
[291.324213] [041/133] (725s left) gem_tiled_wb
[291.447088] [042/133] (725s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[291.533087] Starting subtest: fbc-psr-sprite-mmap-gtt
[291.535345] Starting dynamic subtest: eDP-1
[291.539614] Dynamic subtest eDP-1: SKIP (0.000s)
[291.544052] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[291.617658] [043/133] (725s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[291.676459] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[291.681078] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[291.899992] [044/133] (725s left) perf (buffer-fill)
[292.046439] Starting subtest: buffer-fill
[292.048572] Starting dynamic subtest: 0-rcs0
[294.314733] Dynamic subtest 0-rcs0: SUCCESS (2.268s)
[294.322056] Starting dynamic subtest: 1-vcs0
[298.777748] Dynamic subtest 1-vcs0: SUCCESS (4.461s)
[298.780065] Subtest buffer-fill: SUCCESS (6.732s)
[298.826095] [045/133] (718s left) kms_vblank (crtc-id)
[298.925872] Starting subtest: crtc-id
[298.927789] Starting dynamic subtest: pipe-A-eDP-1
[299.367920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[299.379931] Starting dynamic subtest: pipe-D-eDP-1
[300.509860] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[300.512594] Subtest crtc-id: SUCCESS (1.586s)
[301.364893] [046/133] (716s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[301.462146] Starting subtest: fbcpsr-1p-rte
[308.505078] Subtest fbcpsr-1p-rte: SUCCESS (7.045s)
[308.699697] [047/133] (708s left) kms_flip (2x-blocking-absolute-wf_vblank)
[308.802187] Starting subtest: 2x-blocking-absolute-wf_vblank
[308.811168] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[308.905007] [048/133] (708s left) gem_exec_params (dr1-dirt)
[308.969773] Starting subtest: DR1-dirt
[308.972215] Subtest DR1-dirt: SUCCESS (0.000s)
[309.103526] [049/133] (708s left) i915_pm_rc6_residency (rc6-fence)
[309.157686] Starting subtest: rc6-fence
[309.208517] Starting dynamic subtest: gt0
[321.532048] Dynamic subtest gt0: SUCCESS (12.322s)
[321.543588] Starting dynamic subtest: gt1
[336.855593] Dynamic subtest gt1: SUCCESS (15.319s)
[336.858208] Subtest rc6-fence: SUCCESS (27.697s)
[336.954684] [050/133] (680s left) kms_flip (blocking-wf_vblank)
[337.055485] Starting subtest: blocking-wf_vblank
[337.057805] Starting dynamic subtest: A-eDP1
[346.025506] Dynamic subtest A-eDP1: SUCCESS (8.969s)
[346.033626] Starting dynamic subtest: B-eDP1
[354.952611] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[354.966351] Starting dynamic subtest: C-eDP1
[363.873831] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[363.887229] Starting dynamic subtest: D-eDP1
[372.798402] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[372.800766] Subtest blocking-wf_vblank: SUCCESS (35.744s)
[374.050196] [051/133] (643s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[374.146752] Starting subtest: fbc-psr2-cursor-mmap-cpu
[374.149181] Starting dynamic subtest: eDP-1
[374.153657] Dynamic subtest eDP-1: SKIP (0.000s)
[374.158249] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[374.245554] [052/133] (643s left) gem_basic (multigpu-create-close)
[374.307118] Starting subtest: multigpu-create-close
[374.311605] Subtest multigpu-create-close: SKIP (0.000s)
[374.455700] [053/133] (643s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[374.556411] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[374.558644] Starting dynamic subtest: pipe-A-default-mode
[375.690271] Dynamic subtest pipe-A-default-mode: SKIP (1.132s)
[375.694463] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.134s)
[375.888283] [054/133] (641s left) kms_colorop (plane-xr30-xr30-gamma_2_2_inv_oetf-gamma_2_2_oetf-gamma_2_2_inv_
[376.044107] Subtest plane-XR30-XR30-gamma_2_2_inv_oetf-gamma_2_2_oetf-gamma_2_2_inv_oetf: SKIP (0.000s)
[376.135667] [055/133] (641s left) kms_getfb (getfb2-into-addfb2)
[376.227200] Starting subtest: getfb2-into-addfb2
[376.229503] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[376.353187] [056/133] (641s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[376.450737] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[380.175998] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.729s)
[381.379617] [057/133] (636s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[381.488448] Starting subtest: cursorB-vs-flipA-legacy
[381.493043] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[381.645829] [058/133] (636s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[386.648435] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[386.650822] Starting dynamic subtest: pipe-A-eDP-1
[398.360471] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.710s)
[398.372408] Starting dynamic subtest: pipe-B-eDP-1
[410.108564] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.746s)
[410.110915] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.461s)
[410.964213] [059/133] (606s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[411.072350] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[418.474534] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.403s)
[418.647912] [060/133] (599s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[418.754581] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[423.037237] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.286s)
[424.186654] [061/133] (593s left) gem_exec_reloc (basic-gtt-noreloc)
[424.244721] Subtest basic-gtt-noreloc: SKIP (0.000s)
[424.307622] [062/133] (593s left) gem_exec_schedule (u-semaphore-user)
[424.378676] Starting subtest: u-semaphore-user
[424.429592] Subtest u-semaphore-user: SUCCESS (0.058s)
[425.993702] [063/133] (592s left) kms_lease (lessee-list)
[426.084204] Starting subtest: lessee-list
[426.086586] Starting dynamic subtest: pipe-A-eDP-1
[426.088986] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[426.099637] Starting dynamic subtest: pipe-B-eDP-1
[426.101730] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[426.109667] Starting dynamic subtest: pipe-C-eDP-1
[426.111750] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[426.119610] Starting dynamic subtest: pipe-D-eDP-1
[426.121716] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[426.123797] Subtest lessee-list: SUCCESS (0.010s)
[426.227780] [064/133] (591s left) kms_plane_alpha_blend (alpha-opaque-fb)
[426.330272] Starting subtest: alpha-opaque-fb
[426.620228] Starting dynamic subtest: pipe-A-eDP-1
[427.308216] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[427.316282] Starting dynamic subtest: pipe-D-eDP-1
[428.630720] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[428.633251] Subtest alpha-opaque-fb: SUCCESS (2.299s)
[429.462537] [065/133] (588s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[429.514695] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[429.516969] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[429.643718] [066/133] (588s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[429.749894] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[429.754289] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[429.879187] [067/133] (588s left) prime_busy (hang-wait)
[429.932544] Starting subtest: hang-wait
[429.934916] Starting dynamic subtest: rcs0
[456.373762] Dynamic subtest rcs0: SUCCESS (26.437s)
[456.382073] Starting dynamic subtest: bcs0
[463.592978] Dynamic subtest bcs0: SUCCESS (7.214s)
[463.602545] Starting dynamic subtest: vcs0
[470.503859] Dynamic subtest vcs0: SUCCESS (6.909s)
[470.511628] Starting dynamic subtest: vcs1
[477.538337] Dynamic subtest vcs1: SUCCESS (7.034s)
[477.549542] Starting dynamic subtest: vecs0
[484.513258] Dynamic subtest vecs0: SUCCESS (6.972s)
[484.521476] Starting dynamic subtest: ccs0
[498.419550] Dynamic subtest ccs0: SUCCESS (13.905s)
[498.421953] Subtest hang-wait: SUCCESS (68.486s)
[498.554947] [068/133] (519s left) kms_invalid_mode (zero-vdisplay)
[498.663189] Starting subtest: zero-vdisplay
[498.665407] Starting dynamic subtest: pipe-A-eDP-1
[498.947196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[498.956543] Starting dynamic subtest: pipe-B-eDP-1
[498.958801] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[498.966708] Starting dynamic subtest: pipe-C-eDP-1
[498.968890] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[498.976984] Starting dynamic subtest: pipe-D-eDP-1
[498.978889] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[498.980785] Subtest zero-vdisplay: SUCCESS (0.293s)
[499.794802] [069/133] (518s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[499.893846] Starting subtest: fbc-2p-pri-indfb-multidraw
[499.898075] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[500.023278] [070/133] (518s left) gen3_render_tiledx_blits
[500.145276] [071/133] (518s left) syncobj_eventfd (invalid-bad-flags)
[500.199111] Starting subtest: invalid-bad-flags
[500.201421] Subtest invalid-bad-flags: SUCCESS (0.000s)
[500.322194] [072/133] (518s left) kms_content_protection (dp-mst-type-0)
[500.461293] Starting subtest: dp-mst-type-0
[500.465192] Subtest dp-mst-type-0: SKIP (0.000s)
[500.608951] [073/133] (517s left) kms_addfb_basic (addfb25-bad-modifier)
[500.706294] Starting subtest: addfb25-bad-modifier
[500.707958] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[500.834614] [074/133] (517s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[501.090516] Starting subtest: cursor-rapid-movement-512x512
[501.094260] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[501.260794] [075/133] (517s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[501.652209] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[502.477745] [076/133] (516s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[502.605714] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[502.610437] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[502.786264] [077/133] (515s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[502.885978] Starting subtest: psr-rgb565-draw-mmap-wc
[509.675293] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.793s)
[509.804469] [078/133] (508s left) kms_flip (flip-vs-expired-vblank)
[509.902196] Starting subtest: flip-vs-expired-vblank
[509.904537] Starting dynamic subtest: A-eDP1
[518.627101] Dynamic subtest A-eDP1: SUCCESS (8.724s)
[518.638180] Starting dynamic subtest: B-eDP1
[527.266423] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[527.275509] Starting dynamic subtest: C-eDP1
[535.891548] Dynamic subtest C-eDP1: SUCCESS (8.623s)
[535.899777] Starting dynamic subtest: D-eDP1
[544.516776] Dynamic subtest D-eDP1: SUCCESS (8.623s)
[544.521810] Subtest flip-vs-expired-vblank: SUCCESS (34.622s)
[545.805173] [079/133] (472s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[545.906535] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[545.909064] Starting dynamic subtest: pipe-A-default-mode
[547.048211] Dynamic subtest pipe-A-default-mode: SKIP (1.139s)
[547.052645] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.141s)
[547.225859] [080/133] (471s left) gem_create (hog-create)
[547.282328] Starting subtest: hog-create
[547.284587] Starting dynamic subtest: smem0
[580.915531] Dynamic subtest smem0: SUCCESS (33.629s)
[580.917999] Subtest hog-create: SUCCESS (33.631s)
[581.115521] [081/133] (437s left) gem_exec_gttfill (all-engines)
[581.179750] Starting subtest: all-engines
[604.879347] Subtest all-engines: SUCCESS (23.697s)
[605.081400] [082/133] (413s left) api_intel_bb (intel-bb-blit-none)
[605.178738] Starting subtest: intel-bb-blit-none
[609.187033] Subtest intel-bb-blit-none: SUCCESS (4.007s)
[609.329422] [083/133] (409s left) sysfs_defaults (readonly)
[609.395262] Starting subtest: readonly
[609.397612] Starting dynamic subtest: vecs0
[609.399940] Dynamic subtest vecs0: SUCCESS (0.000s)
[609.408746] Starting dynamic subtest: ccs0
[609.410958] Dynamic subtest ccs0: SUCCESS (0.000s)
[609.419513] Starting dynamic subtest: vcs0
[609.421717] Dynamic subtest vcs0: SUCCESS (0.000s)
[609.430196] Starting dynamic subtest: bcs0
[609.432356] Dynamic subtest bcs0: SUCCESS (0.000s)
[609.440890] Starting dynamic subtest: rcs0
[609.442763] Dynamic subtest rcs0: SUCCESS (0.000s)
[609.450921] Starting dynamic subtest: vcs1
[609.453335] Dynamic subtest vcs1: SUCCESS (0.000s)
[609.455610] Subtest readonly: SUCCESS (0.006s)
[609.526208] [084/133] (409s left) gem_lmem_swapping (verify-ccs)
[609.574825] Subtest verify-ccs: SKIP (0.000s)
[609.620426] [085/133] (409s left) kms_async_flips (test-time-stamp)
[609.730352] Starting subtest: test-time-stamp
[610.112332] Starting dynamic subtest: pipe-A-eDP-1
[611.397700] Dynamic subtest pipe-A-eDP-1: FAIL (0.805s)
[611.407451] Starting dynamic subtest: pipe-B-eDP-1
[612.302091] Dynamic subtest pipe-B-eDP-1: FAIL (0.735s)
[612.422769] Starting dynamic subtest: pipe-C-eDP-1
[613.192633] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s)
[613.560512] Starting dynamic subtest: pipe-D-eDP-1
[614.329790] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.775s)
[614.332147] Subtest test-time-stamp: FAIL (4.599s)
[615.502055] [086/133] (403s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[615.606892] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[624.207060] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.602s)
[624.391362] [087/133] (394s left) kms_pm_backlight (fade-with-suspend)
[624.502731] Starting subtest: fade-with-suspend
[641.151055] Starting dynamic subtest: eDP-1
[643.817191] Dynamic subtest eDP-1: SUCCESS (2.667s)
[643.819720] Subtest fade-with-suspend: SUCCESS (4.452s)
[644.648051] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[644.668429] [FACT kms_pm_backlight (fade-with-suspend)] new: kernel.is_tainted.taint_warn: true
[644.669321] 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.