[57.797752] Initializing watchdogs
[57.797801]   /dev/watchdog0
[57.811806] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.816130] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.818305] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.821418] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[57.940656] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[57.944774] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[58.056196] [002/133] (960s left) syncobj_wait (wait-for-submit-snapshot)
[58.110380] Starting subtest: wait-for-submit-snapshot
[58.191340] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[58.287904] [003/133] (960s left) kms_selftest (drm_dp_mst_helper)
[58.322021] Starting subtest: drm_dp_mst_helper
[58.332691] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[58.420088] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.086s)
[58.428400] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[58.558662] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.137s)
[58.566750] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[58.693895] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.135s)
[58.696107] Subtest drm_dp_mst_helper: SUCCESS (0.371s)
[58.918740] [004/133] (959s left) kms_cursor_edge_walk (128x128-right-edge)
[59.010032] Starting subtest: 128x128-right-edge
[59.012357] Starting dynamic subtest: pipe-A-eDP-1
[62.467691] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.459s)
[62.474877] Starting dynamic subtest: pipe-D-eDP-1
[65.599268] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[65.601527] Subtest 128x128-right-edge: SUCCESS (6.589s)
[66.412153] [005/133] (952s left) api_intel_allocator (gem-pool)
[66.474693] Starting subtest: gem-pool
[66.480620] Subtest gem-pool: SUCCESS (0.009s)
[66.611176] [006/133] (951s left) gem_ctx_exec (basic-invalid-context)
[66.659788] Starting subtest: basic-invalid-context
[66.665647] Subtest basic-invalid-context: SUCCESS (0.008s)
[66.801201] [007/133] (951s left) gem_exec_store (cachelines)
[66.865540] Starting subtest: cachelines
[66.867794] Starting dynamic subtest: rcs0
[66.954848] Dynamic subtest rcs0: SUCCESS (0.090s)
[66.965039] Starting dynamic subtest: bcs0
[67.024405] Dynamic subtest bcs0: SUCCESS (0.069s)
[67.033218] Starting dynamic subtest: vcs0
[67.085661] Dynamic subtest vcs0: SUCCESS (0.061s)
[67.092988] Starting dynamic subtest: vcs1
[67.151048] Dynamic subtest vcs1: SUCCESS (0.064s)
[67.160082] Starting dynamic subtest: vecs0
[67.210153] Dynamic subtest vecs0: SUCCESS (0.058s)
[67.218268] Starting dynamic subtest: ccs0
[67.270017] Dynamic subtest ccs0: SUCCESS (0.060s)
[67.272536] Subtest cachelines: SUCCESS (0.406s)
[67.460060] [008/133] (951s left) kms_busy (basic-hang)
[67.552024] Starting subtest: basic-hang
[67.554340] Starting dynamic subtest: flip-pipe-A
[68.125581] Dynamic subtest flip-pipe-A: SUCCESS (0.572s)
[68.134679] Starting dynamic subtest: modeset-pipe-A
[71.536668] Dynamic subtest modeset-pipe-A: SUCCESS (3.412s)
[71.544769] Starting dynamic subtest: flip-pipe-D
[72.802731] Dynamic subtest flip-pipe-D: SUCCESS (1.263s)
[72.810453] Starting dynamic subtest: modeset-pipe-D
[76.276276] Dynamic subtest modeset-pipe-D: SUCCESS (3.472s)
[76.278591] Subtest basic-hang: SUCCESS (8.725s)
[77.081932] [009/133] (941s left) gem_gtt_cpu_tlb
[77.220065] [010/133] (941s left) kms_vblank (ts-continuation-idle)
[77.303374] Starting subtest: ts-continuation-idle
[77.305644] Starting dynamic subtest: pipe-A-eDP-1
[77.700183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[77.714345] Starting dynamic subtest: pipe-D-eDP-1
[78.766672] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.064s)
[78.769031] Subtest ts-continuation-idle: SUCCESS (1.465s)
[79.638136] [011/133] (939s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[79.732052] Starting subtest: bo-too-small-due-to-tiling
[79.736184] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[79.847224] [012/133] (938s left) gem_ctx_shared (q-smoketest)
[79.904046] Starting subtest: Q-smoketest
[79.906355] Starting dynamic subtest: rcs0
[85.456931] Dynamic subtest rcs0: SUCCESS (5.511s)
[85.465439] Starting dynamic subtest: bcs0
[90.949284] Dynamic subtest bcs0: SUCCESS (5.493s)
[90.957302] Starting dynamic subtest: vcs0
[96.416738] Dynamic subtest vcs0: SUCCESS (5.464s)
[96.424567] Starting dynamic subtest: vcs1
[101.899890] Dynamic subtest vcs1: SUCCESS (5.488s)
[101.911619] Starting dynamic subtest: vecs0
[107.378091] Dynamic subtest vecs0: SUCCESS (5.480s)
[107.387078] Starting dynamic subtest: ccs0
[112.882997] Dynamic subtest ccs0: SUCCESS (5.503s)
[112.885309] Subtest Q-smoketest: SUCCESS (32.941s)
[113.025425] [013/133] (905s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[113.071102] Starting subtest: legacy-engines-hostile-preempt
[113.073321] Starting dynamic subtest: render
[113.161791] Dynamic subtest render: SUCCESS (0.090s)
[113.171972] Starting dynamic subtest: bsd1
[114.923562] Dynamic subtest bsd1: SUCCESS (1.759s)
[114.933495] Starting dynamic subtest: bsd2
[116.901104] Dynamic subtest bsd2: SUCCESS (1.976s)
[116.909755] Starting dynamic subtest: blt
[116.966051] Dynamic subtest blt: SUCCESS (0.064s)
[116.976623] Starting dynamic subtest: vebox
[118.957067] Dynamic subtest vebox: SUCCESS (1.988s)
[118.959171] Subtest legacy-engines-hostile-preempt: SUCCESS (5.885s)
[119.049211] [014/133] (899s left) kms_psr (fbc-psr-primary-page-flip)
[119.147020] Starting subtest: fbc-psr-primary-page-flip
[119.149320] Starting dynamic subtest: eDP-1
[119.153811] Dynamic subtest eDP-1: SKIP (0.000s)
[119.158447] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[119.242702] [015/133] (899s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[119.348843] Starting subtest: y-tiled-16bpp-rotate-0
[119.352998] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[119.469646] [016/133] (899s left) dmabuf_sync_file (export-wait-after-attach)
[119.571939] Starting subtest: export-wait-after-attach
[119.574098] Subtest export-wait-after-attach: SUCCESS (0.001s)
[119.638774] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[119.641435] [017/133] (899s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[119.728049] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[119.839174] [018/133] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[119.939318] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[119.943837] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[120.071359] [019/133] (898s left) gem_pxp (verify-pxp-stale-buf-execution)
[120.188263] Starting subtest: verify-pxp-stale-buf-execution
[121.251056] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s)
[121.405354] [020/133] (897s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[121.498835] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[121.503351] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[121.622159] [021/133] (897s left) kms_flip (flip-vs-modeset-vs-hang)
[121.714441] Starting subtest: flip-vs-modeset-vs-hang
[121.716882] Starting dynamic subtest: A-eDP1
[160.374583] Dynamic subtest A-eDP1: SUCCESS (38.655s)
[160.382946] Starting dynamic subtest: D-eDP1
[209.390836] Dynamic subtest D-eDP1: SUCCESS (49.008s)
[209.393075] Subtest flip-vs-modeset-vs-hang: SUCCESS (87.667s)
[209.826279] [022/133] (809s left) kms_cdclk (plane-scaling)
[209.905895] Starting subtest: plane-scaling
[209.908353] Starting dynamic subtest: pipe-A-eDP-1
[210.195264] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[210.204201] Starting dynamic subtest: pipe-B-eDP-1
[210.208629] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[210.216097] Starting dynamic subtest: pipe-C-eDP-1
[210.220653] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[210.228873] Starting dynamic subtest: pipe-D-eDP-1
[210.233232] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[210.237450] Subtest plane-scaling: SKIP (0.293s)
[211.062357] [023/133] (808s left) kms_cursor_crc (cursor-random-256x256)
[211.293289] Starting subtest: cursor-random-256x256
[211.298551] Starting dynamic subtest: pipe-A-eDP-1
[214.629595] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.331s)
[214.658686] Starting dynamic subtest: pipe-D-eDP-1
[219.431569] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.778s)
[219.433952] Subtest cursor-random-256x256: SUCCESS (8.135s)
[219.898226] [024/133] (799s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[219.959053] Starting subtest: wait-all-for-submit-delayed-submit
[220.062336] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[220.151788] [025/133] (799s left) gem_exec_balancer (semaphore)
[220.206689] Starting subtest: semaphore
[221.890566] Subtest semaphore: SUCCESS (1.684s)
[222.225221] [026/133] (797s left) kms_properties (crtc-properties-legacy)
[222.311246] Starting subtest: crtc-properties-legacy
[222.313546] Starting dynamic subtest: pipe-A-eDP-1
[222.754451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[222.763438] Starting dynamic subtest: pipe-B-eDP-1
[223.928104] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.173s)
[223.936286] Starting dynamic subtest: pipe-C-eDP-1
[225.047111] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[225.058403] Starting dynamic subtest: pipe-D-eDP-1
[226.169693] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[226.171611] Subtest crtc-properties-legacy: SUCCESS (3.859s)
[226.999284] [027/133] (792s left) gem_exec_schedule (implicit-read-write)
[227.068560] Starting subtest: implicit-read-write
[227.070865] Starting dynamic subtest: rcs0
[227.177342] Dynamic subtest rcs0: SUCCESS (0.119s)
[227.187724] Starting dynamic subtest: vcs0
[227.251846] Dynamic subtest vcs0: SUCCESS (0.074s)
[227.262181] Starting dynamic subtest: vcs1
[227.325036] Dynamic subtest vcs1: SUCCESS (0.072s)
[227.335776] Starting dynamic subtest: vecs0
[227.403245] Dynamic subtest vecs0: SUCCESS (0.078s)
[227.413313] Starting dynamic subtest: ccs0
[227.482143] Dynamic subtest ccs0: SUCCESS (0.078s)
[227.484599] Subtest implicit-read-write: SUCCESS (0.425s)
[228.990357] [028/133] (790s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[229.101813] Starting subtest: x-tiled-8bpp-rotate-0
[230.314189] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.213s)
[230.479271] [029/133] (788s left) i915_query (query-regions-sanity-check)
[230.528394] Starting subtest: query-regions-sanity-check
[230.539242] Subtest query-regions-sanity-check: SUCCESS (0.013s)
[230.672777] [030/133] (788s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[230.767506] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[230.769504] Starting dynamic subtest: pipe-A-eDP-1
[230.788962] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.798151] Starting dynamic subtest: pipe-B-eDP-1
[230.815850] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.823848] Starting dynamic subtest: pipe-C-eDP-1
[230.841209] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[230.847858] Starting dynamic subtest: pipe-D-eDP-1
[230.865627] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[230.869153] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[232.981622] [031/133] (786s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[237.934359] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[237.938865] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[238.794703] [032/133] (780s left) gem_mmap_gtt (basic-read)
[238.852292] Subtest basic-read: SKIP (0.000s)
[238.917923] [033/133] (780s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[238.975364] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[239.039893] [034/133] (780s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[239.135594] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[239.139728] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[239.265476] [035/133] (780s left) kms_psr (psr-primary-render)
[239.369668] Starting subtest: psr-primary-render
[239.372175] Starting dynamic subtest: eDP-1
[241.100202] Dynamic subtest eDP-1: SUCCESS (1.729s)
[241.102462] Subtest psr-primary-render: SUCCESS (1.730s)
[241.973560] [036/133] (777s left) gem_sync (basic-store-all)
[242.054705] Starting subtest: basic-store-all
[245.809916] Subtest basic-store-all: SUCCESS (3.764s)
[246.004190] [037/133] (773s left) gem_spin_batch (spin-all-new)
[246.071627] Starting subtest: spin-all-new
[246.092841] Subtest spin-all-new: SUCCESS (0.021s)
[247.945526] [038/133] (771s left) i915_module_load (reload-with-fault-injection)
[247.980472] Starting subtest: reload-with-fault-injection
[289.822653] Subtest reload-with-fault-injection: SUCCESS (41.841s)
[289.866963] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[289.867697] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[289.870962] [039/133] (729s left) kms_chamelium_frames (dp-crc-fast)
[291.643850] Subtest dp-crc-fast: SKIP (0.000s)
[292.472399] [FACT kms_chamelium_frames (dp-crc-fast)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[292.473672] [FACT kms_chamelium_frames (dp-crc-fast)] new: kernel.kmod_is_loaded.i915: true
[292.477387] [040/133] (727s left) gen7_exec_parse (basic-allowed)
[292.546300] Subtest basic-allowed: SKIP (0.000s)
[292.634526] [041/133] (727s left) gem_tiled_wb
[292.761613] [042/133] (727s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[292.868915] Starting subtest: fbc-psr-sprite-mmap-gtt
[292.871124] Starting dynamic subtest: eDP-1
[292.875193] Dynamic subtest eDP-1: SKIP (0.000s)
[292.879266] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[292.951762] [043/133] (726s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[293.006813] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[293.010819] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[293.208983] [044/133] (726s left) perf (buffer-fill)
[293.345079] Starting subtest: buffer-fill
[293.346922] Starting dynamic subtest: 0-rcs0
[295.594145] Dynamic subtest 0-rcs0: SUCCESS (2.248s)
[295.601964] Starting dynamic subtest: 1-vcs1
[300.042064] Dynamic subtest 1-vcs1: SUCCESS (4.447s)
[300.044941] Subtest buffer-fill: SUCCESS (6.698s)
[300.090732] [045/133] (719s left) kms_vblank (crtc-id)
[300.188027] Starting subtest: crtc-id
[300.190277] Starting dynamic subtest: pipe-A-eDP-1
[300.628058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s)
[300.641078] Starting dynamic subtest: pipe-D-eDP-1
[301.722380] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.091s)
[301.724592] Subtest crtc-id: SUCCESS (1.533s)
[302.569148] [046/133] (717s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[302.671611] Starting subtest: fbcpsr-1p-rte
[309.738249] Subtest fbcpsr-1p-rte: SUCCESS (7.072s)
[309.928846] [047/133] (710s left) kms_flip (2x-blocking-absolute-wf_vblank)
[310.032247] Starting subtest: 2x-blocking-absolute-wf_vblank
[310.041900] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[310.143954] [048/133] (709s left) gem_exec_params (dr1-dirt)
[310.200728] Starting subtest: DR1-dirt
[310.203111] Subtest DR1-dirt: SUCCESS (0.000s)
[310.314348] [049/133] (709s left) i915_pm_rc6_residency (rc6-fence)
[310.366845] Starting subtest: rc6-fence
[310.415650] Starting dynamic subtest: gt0
[322.732438] Dynamic subtest gt0: SUCCESS (12.317s)
[322.743552] Starting dynamic subtest: gt1
[338.836531] Dynamic subtest gt1: SUCCESS (16.101s)
[338.839162] Subtest rc6-fence: SUCCESS (28.471s)
[338.937773] [050/133] (681s left) kms_flip (blocking-wf_vblank)
[339.041397] Starting subtest: blocking-wf_vblank
[339.043349] Starting dynamic subtest: A-eDP1
[347.941468] Dynamic subtest A-eDP1: SUCCESS (8.898s)
[347.950693] Starting dynamic subtest: B-eDP1
[356.876624] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[356.890096] Starting dynamic subtest: C-eDP1
[365.798521] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[365.806685] Starting dynamic subtest: D-eDP1
[374.739583] Dynamic subtest D-eDP1: SUCCESS (8.938s)
[374.741921] Subtest blocking-wf_vblank: SUCCESS (35.699s)
[375.983931] [051/133] (644s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[376.083201] Starting subtest: fbc-psr2-cursor-mmap-cpu
[376.085496] Starting dynamic subtest: eDP-1
[376.089636] Dynamic subtest eDP-1: SKIP (0.000s)
[376.093801] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[376.167367] [052/133] (644s left) gem_basic (multigpu-create-close)
[376.234520] Starting subtest: multigpu-create-close
[376.239628] Subtest multigpu-create-close: SKIP (0.000s)
[376.356281] [053/133] (643s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[376.454898] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[376.457133] Starting dynamic subtest: pipe-A-default-mode
[377.635135] Dynamic subtest pipe-A-default-mode: SKIP (1.178s)
[377.639670] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.180s)
[377.805562] [054/133] (642s left) kms_colorop (plane-xr30-xr30-gamma_2_2_inv_oetf-gamma_2_2_oetf-gamma_2_2_inv_
[377.949297] Subtest plane-XR30-XR30-gamma_2_2_inv_oetf-gamma_2_2_oetf-gamma_2_2_inv_oetf: SKIP (0.000s)
[378.026897] [055/133] (642s left) kms_getfb (getfb2-into-addfb2)
[378.119954] Starting subtest: getfb2-into-addfb2
[378.122341] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[378.226375] [056/133] (642s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[378.315105] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[382.033720] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.722s)
[383.251158] [057/133] (637s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[383.363027] Starting subtest: cursorB-vs-flipA-legacy
[383.367485] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[383.518598] [058/133] (637s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[388.610083] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[388.612334] Starting dynamic subtest: pipe-A-eDP-1
[400.312181] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.702s)
[400.323759] Starting dynamic subtest: pipe-B-eDP-1
[412.040053] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.725s)
[412.042229] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.431s)
[412.923988] [059/133] (607s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[413.033810] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[420.364812] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.332s)
[420.512245] [060/133] (600s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[420.618809] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[424.900888] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.286s)
[426.122567] [061/133] (594s left) gem_exec_reloc (basic-gtt-noreloc)
[426.180783] Subtest basic-gtt-noreloc: SKIP (0.000s)
[426.257337] [062/133] (594s left) gem_exec_schedule (u-semaphore-user)
[426.326630] Starting subtest: u-semaphore-user
[426.379305] Subtest u-semaphore-user: SUCCESS (0.058s)
[427.976302] [063/133] (592s left) kms_lease (lessee-list)
[428.069080] Starting subtest: lessee-list
[428.071342] Starting dynamic subtest: pipe-A-eDP-1
[428.073540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[428.081896] Starting dynamic subtest: pipe-B-eDP-1
[428.084154] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[428.092265] Starting dynamic subtest: pipe-C-eDP-1
[428.094423] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[428.102225] Starting dynamic subtest: pipe-D-eDP-1
[428.104239] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[428.106579] Subtest lessee-list: SUCCESS (0.010s)
[428.199053] [064/133] (592s left) kms_plane_alpha_blend (alpha-opaque-fb)
[428.296332] Starting subtest: alpha-opaque-fb
[428.585697] Starting dynamic subtest: pipe-A-eDP-1
[429.221340] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[429.230067] Starting dynamic subtest: pipe-D-eDP-1
[430.540716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[430.543326] Subtest alpha-opaque-fb: SUCCESS (2.248s)
[431.370014] [065/133] (589s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[431.439838] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[431.442206] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[431.571377] [066/133] (589s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[431.669714] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[431.674048] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[431.786952] [067/133] (589s left) prime_busy (hang-wait)
[431.852167] Starting subtest: hang-wait
[431.854078] Starting dynamic subtest: rcs0
[458.358716] Dynamic subtest rcs0: SUCCESS (26.504s)
[458.371664] Starting dynamic subtest: bcs0
[465.510503] Dynamic subtest bcs0: SUCCESS (7.150s)
[465.521135] Starting dynamic subtest: vcs0
[472.484347] Dynamic subtest vcs0: SUCCESS (6.971s)
[472.494101] Starting dynamic subtest: vcs1
[479.525944] Dynamic subtest vcs1: SUCCESS (7.038s)
[479.535587] Starting dynamic subtest: vecs0
[486.497889] Dynamic subtest vecs0: SUCCESS (6.971s)
[486.507439] Starting dynamic subtest: ccs0
[500.400978] Dynamic subtest ccs0: SUCCESS (13.900s)
[500.403280] Subtest hang-wait: SUCCESS (68.547s)
[500.544098] [068/133] (520s left) kms_invalid_mode (zero-vdisplay)
[500.643157] Starting subtest: zero-vdisplay
[500.645340] Starting dynamic subtest: pipe-A-eDP-1
[500.932494] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[500.941708] Starting dynamic subtest: pipe-B-eDP-1
[500.943599] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[500.951146] Starting dynamic subtest: pipe-C-eDP-1
[500.953035] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[500.960975] Starting dynamic subtest: pipe-D-eDP-1
[500.963185] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[500.965350] Subtest zero-vdisplay: SUCCESS (0.297s)
[501.775558] [069/133] (519s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[501.870621] Starting subtest: fbc-2p-pri-indfb-multidraw
[501.874688] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[501.963081] [070/133] (519s left) gen3_render_tiledx_blits
[502.098414] [071/133] (518s left) syncobj_eventfd (invalid-bad-flags)
[502.148512] Starting subtest: invalid-bad-flags
[502.150669] Subtest invalid-bad-flags: SUCCESS (0.000s)
[502.284941] [072/133] (518s left) kms_content_protection (dp-mst-type-0)
[502.428992] Starting subtest: dp-mst-type-0
[502.433623] Subtest dp-mst-type-0: SKIP (0.000s)
[502.571400] [073/133] (518s left) kms_addfb_basic (addfb25-bad-modifier)
[502.659819] Starting subtest: addfb25-bad-modifier
[502.661599] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[502.795382] [074/133] (518s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[503.042486] Starting subtest: cursor-rapid-movement-512x512
[503.046193] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[503.233432] [075/133] (517s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[503.617918] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[504.397044] [076/133] (516s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[504.517977] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[504.522622] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[504.673607] [077/133] (516s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[504.783060] Starting subtest: psr-rgb565-draw-mmap-wc
[511.733138] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.952s)
[511.869423] [078/133] (509s left) kms_flip (flip-vs-expired-vblank)
[511.964362] Starting subtest: flip-vs-expired-vblank
[511.966598] Starting dynamic subtest: A-eDP1
[520.655078] Dynamic subtest A-eDP1: SUCCESS (8.692s)
[520.664868] Starting dynamic subtest: B-eDP1
[529.294423] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[529.305069] Starting dynamic subtest: C-eDP1
[537.915773] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[537.928713] Starting dynamic subtest: D-eDP1
[546.556565] Dynamic subtest D-eDP1: SUCCESS (8.638s)
[546.561650] Subtest flip-vs-expired-vblank: SUCCESS (34.599s)
[547.748603] [079/133] (473s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[547.849053] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[547.851422] Starting dynamic subtest: pipe-A-default-mode
[549.005398] Dynamic subtest pipe-A-default-mode: SKIP (1.151s)
[549.009783] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.153s)
[549.188891] [080/133] (472s left) gem_create (hog-create)
[549.249877] Starting subtest: hog-create
[549.252265] Starting dynamic subtest: smem0
[582.847601] Dynamic subtest smem0: SUCCESS (33.594s)
[582.850438] Subtest hog-create: SUCCESS (33.596s)
[583.058901] [081/133] (438s left) gem_exec_gttfill (all-engines)
[583.117699] Starting subtest: all-engines
[606.769289] Subtest all-engines: SUCCESS (23.648s)
[606.974837] [082/133] (414s left) api_intel_bb (intel-bb-blit-none)
[607.067455] Starting subtest: intel-bb-blit-none
[611.198585] Subtest intel-bb-blit-none: SUCCESS (4.131s)
[611.336953] [083/133] (410s left) sysfs_defaults (readonly)
[611.411050] Starting subtest: readonly
[611.413353] Starting dynamic subtest: vecs0
[611.415656] Dynamic subtest vecs0: SUCCESS (0.000s)
[611.427221] Starting dynamic subtest: ccs0
[611.429067] Dynamic subtest ccs0: SUCCESS (0.000s)
[611.436994] Starting dynamic subtest: vcs0
[611.438907] Dynamic subtest vcs0: SUCCESS (0.000s)
[611.447933] Starting dynamic subtest: bcs0
[611.449892] Dynamic subtest bcs0: SUCCESS (0.000s)
[611.462279] Starting dynamic subtest: rcs0
[611.464535] Dynamic subtest rcs0: SUCCESS (0.001s)
[611.476903] Starting dynamic subtest: vcs1
[611.478874] Dynamic subtest vcs1: SUCCESS (0.000s)
[611.480785] Subtest readonly: SUCCESS (0.006s)
[611.551814] [084/133] (410s left) gem_lmem_swapping (verify-ccs)
[611.600083] Subtest verify-ccs: SKIP (0.000s)
[611.645444] [085/133] (409s left) kms_async_flips (test-time-stamp)
[611.739152] Starting subtest: test-time-stamp
[612.125390] Starting dynamic subtest: pipe-A-eDP-1
[613.461161] Dynamic subtest pipe-A-eDP-1: FAIL (0.836s)
[613.471863] Starting dynamic subtest: pipe-B-eDP-1
[614.326764] Dynamic subtest pipe-B-eDP-1: FAIL (0.745s)
[614.448901] Starting dynamic subtest: pipe-C-eDP-1
[615.223598] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.782s)
[615.583031] Starting dynamic subtest: pipe-D-eDP-1
[616.361764] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.783s)
[616.364121] Subtest test-time-stamp: FAIL (4.623s)
[617.525785] [086/133] (404s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[617.635890] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[626.171186] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.537s)
[626.319666] [087/133] (395s left) kms_pm_backlight (fade-with-suspend)
[626.417088] Starting subtest: fade-with-suspend
[642.202755] Starting dynamic subtest: eDP-1
[644.879188] Dynamic subtest eDP-1: SUCCESS (2.674s)
[644.881624] Subtest fade-with-suspend: SUCCESS (4.059s)
[645.698961] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

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