[55.324628] Initializing watchdogs [55.324674] /dev/watchdog0 [55.338745] [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.342991] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.345158] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.348395] [001/134] (960s left) syncobj_timeline (invalid-wait-bad-flags) [55.423538] Starting subtest: invalid-wait-bad-flags [55.425905] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [55.560372] [002/134] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [55.660815] Starting subtest: fbcpsr-rgb101010-draw-render [62.356050] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.797s) [62.499242] [003/134] (953s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [62.879734] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [63.691243] [004/134] (952s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [63.780102] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [63.784668] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [63.893390] [005/134] (952s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc) [63.981438] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc [63.983687] Starting dynamic subtest: pipe-A-eDP-1 [64.827174] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.844s) [64.836061] Starting dynamic subtest: pipe-B-eDP-1 [66.439731] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.620s) [66.447063] Starting dynamic subtest: pipe-C-eDP-1 [67.922649] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.488s) [67.931937] Starting dynamic subtest: pipe-D-eDP-1 [69.451993] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.535s) [69.454012] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.491s) [70.631754] [006/134] (945s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [70.744059] Starting subtest: yf-tiled-16bpp-rotate-270 [70.748464] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [70.865742] [007/134] (945s left) kms_async_flips (alternate-sync-async-flip-atomic) [70.962731] Starting subtest: alternate-sync-async-flip-atomic [71.345839] Starting dynamic subtest: pipe-A-eDP-1 [72.698588] Dynamic subtest pipe-A-eDP-1: FAIL (0.770s) [72.707466] Starting dynamic subtest: pipe-B-eDP-1 [73.617481] Dynamic subtest pipe-B-eDP-1: FAIL (0.751s) [73.626945] Starting dynamic subtest: pipe-C-eDP-1 [76.364469] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s) [76.728251] Starting dynamic subtest: pipe-D-eDP-1 [79.488409] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s) [79.490501] Subtest alternate-sync-async-flip-atomic: FAIL (8.543s) [80.670873] [008/134] (935s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [85.653846] Starting subtest: pr-primary-plane-update-sf-dmg-area [85.658628] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s) [86.489487] [009/134] (929s left) gem_exec_reloc (basic-write-cpu) [86.542969] Subtest basic-write-cpu: SKIP (0.000s) [86.610606] [010/134] (929s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [86.708917] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [94.010545] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.302s) [94.191360] [011/134] (922s left) gem_exec_flush (basic-wb-rw-before-default) [94.266652] Starting subtest: basic-wb-rw-before-default [99.750320] Subtest basic-wb-rw-before-default: SUCCESS (5.457s) [99.913346] [012/134] (916s left) kms_colorop (plane-xr30-xr30-pq_125_eotf-pq_125_inv_eotf) [100.038785] Subtest plane-XR30-XR30-pq_125_eotf-pq_125_inv_eotf: SKIP (0.000s) [100.113480] [013/134] (916s left) syncobj_timeline (invalid-signal-bad-pad) [100.171327] Starting subtest: invalid-signal-bad-pad [100.173595] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [100.291186] [014/134] (916s left) kms_getfb (getfb-addfb-different-handles) [100.390787] Starting subtest: getfb-addfb-different-handles [100.393148] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [100.520774] [015/134] (915s left) perf_pmu (module-unload) [100.601772] Starting subtest: module-unload [107.590885] Subtest module-unload: FAIL (6.873s) [107.621026] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true [107.625087] [016/134] (908s left) kms_atomic_transition (modeset-transition) [109.158128] Starting subtest: modeset-transition [109.160438] Starting dynamic subtest: 1x-outputs [120.058643] Dynamic subtest 1x-outputs: SUCCESS (10.900s) [120.061102] Subtest modeset-transition: SUCCESS (10.901s) [120.950155] [FACT kms_atomic_transition (modeset-transition)] new: kernel.kmod_is_loaded.i915: true [120.953717] [017/134] (895s left) kms_cursor_crc (cursor-random-max-size) [121.251795] Starting subtest: cursor-random-max-size [121.258490] Subtest cursor-random-max-size: SKIP (0.000s) [121.375060] [018/134] (895s left) gem_pxp (hw-rejects-pxp-context) [121.519723] Starting subtest: hw-rejects-pxp-context [121.523729] Subtest hw-rejects-pxp-context: SKIP (0.000s) [121.655272] [019/134] (894s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [121.742059] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [121.754009] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s) [121.870444] [020/134] (894s left) gem_exec_params (no-blt) [121.923913] Starting subtest: no-blt [121.926055] Subtest no-blt: SUCCESS (0.002s) [122.070914] [021/134] (894s left) tools_test (tools_test) [122.115197] Starting subtest: tools_test [122.173512] Subtest tools_test: SUCCESS (0.070s) [122.245296] [022/134] (894s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs) [122.331303] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs [122.333500] Starting dynamic subtest: pipe-A-eDP-1 [122.352804] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [122.362794] Starting dynamic subtest: pipe-B-eDP-1 [122.384792] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [122.391893] Starting dynamic subtest: pipe-C-eDP-1 [122.409893] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [122.417093] Starting dynamic subtest: pipe-D-eDP-1 [122.436550] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [122.440295] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s) [124.499146] [023/134] (892s left) gem_lmem_swapping (heavy-random) [124.540265] Subtest heavy-random: SKIP (0.000s) [124.582500] [024/134] (892s left) gem_softpin (evict-prime) [124.631124] Starting subtest: evict-prime [124.633577] Starting dynamic subtest: rcs0 [125.808948] Dynamic subtest rcs0: SUCCESS (1.177s) [125.820307] Starting dynamic subtest: bcs0 [126.959567] Dynamic subtest bcs0: SUCCESS (1.148s) [126.974513] Starting dynamic subtest: vcs0 [128.890469] Dynamic subtest vcs0: SUCCESS (1.928s) [128.901785] Starting dynamic subtest: vcs1 [130.942732] Dynamic subtest vcs1: SUCCESS (2.051s) [130.953966] Starting dynamic subtest: vecs0 [132.886793] Dynamic subtest vecs0: SUCCESS (1.942s) [132.897742] Starting dynamic subtest: ccs0 [134.040953] Dynamic subtest ccs0: SUCCESS (1.154s) [134.052474] Starting dynamic subtest: all [135.917438] Dynamic subtest all: SUCCESS (1.873s) [135.920302] Subtest evict-prime: SUCCESS (11.285s) [136.010703] [025/134] (880s left) prime_mmap (test_userptr) [136.072100] Starting subtest: test_userptr [136.074402] Starting dynamic subtest: test_userptr-smem [136.076688] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [136.078895] Subtest test_userptr: SUCCESS (0.002s) [136.171912] [026/134] (880s left) gem_exec_whisper (basic-fds) [136.230546] Starting subtest: basic-fds [143.861348] Subtest basic-fds: SUCCESS (7.628s) [144.069613] [027/134] (872s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy) [144.193630] Starting subtest: 2x-flip-vs-cursor-legacy [144.198267] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s) [144.359629] [028/134] (872s left) gem_exec_schedule (preempt-hang) [144.528852] Starting subtest: preempt-hang [144.531775] Starting dynamic subtest: rcs0 [144.769473] Dynamic subtest rcs0: SUCCESS (0.239s) [144.780817] Starting dynamic subtest: bcs0 [145.000239] Dynamic subtest bcs0: SUCCESS (0.230s) [145.010641] Starting dynamic subtest: vcs0 [145.228507] Dynamic subtest vcs0: SUCCESS (0.228s) [145.240096] Starting dynamic subtest: vcs1 [145.456172] Dynamic subtest vcs1: SUCCESS (0.227s) [145.465160] Starting dynamic subtest: vecs0 [145.690161] Dynamic subtest vecs0: SUCCESS (0.234s) [145.701118] Starting dynamic subtest: ccs0 [145.926234] Dynamic subtest ccs0: SUCCESS (0.234s) [145.928608] Subtest preempt-hang: SUCCESS (1.396s) [147.031153] [029/134] (869s left) gem_ctx_param (vm) [147.082875] Starting subtest: vm [147.152321] Subtest vm: SUCCESS (0.070s) [147.323865] [030/134] (869s left) kms_psr (fbc-psr-sprite-blt) [147.430034] Starting subtest: fbc-psr-sprite-blt [147.432418] Starting dynamic subtest: eDP-1 [147.436765] Dynamic subtest eDP-1: SKIP (0.000s) [147.441120] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [147.513691] [031/134] (869s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [147.616588] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [154.299118] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.686s) [154.449554] [032/134] (862s left) gem_exec_capture (capture-invisible) [154.512405] Starting subtest: capture-invisible [154.514401] Starting dynamic subtest: smem0 [154.518588] Dynamic subtest smem0: SKIP (0.000s) [154.522812] Subtest capture-invisible: SKIP (0.001s) [154.644154] [033/134] (862s left) vgem_slow (nohang) [154.754148] Starting subtest: nohang [165.029905] Subtest nohang: SUCCESS (10.225s) [165.069525] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true [165.072642] [034/134] (852s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [165.172277] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [165.176564] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [165.277202] [035/134] (851s left) kms_chamelium_color (ctm-negative) [165.371826] Subtest ctm-negative: SKIP (0.000s) [165.415185] [036/134] (851s left) gem_exec_reloc (basic-write-read) [165.478205] Subtest basic-write-read: SKIP (0.000s) [165.540594] [037/134] (851s left) gem_eio (context-create) [165.775504] Starting subtest: context-create [166.117273] Subtest context-create: SUCCESS (0.342s) [166.273560] [038/134] (850s left) perf (gen12-invalid-class-instance) [166.390873] Starting subtest: gen12-invalid-class-instance [166.401111] Subtest gen12-invalid-class-instance: SUCCESS (0.010s) [166.446512] [039/134] (850s left) dmabuf_sync_file (export-multiwait) [166.481504] Starting subtest: export-multiwait [166.483130] Subtest export-multiwait: SUCCESS (0.001s) [166.564355] [040/134] (850s left) kms_psr (fbc-psr-no-drrs) [166.650463] Starting subtest: fbc-psr-no-drrs [166.652345] Starting dynamic subtest: eDP-1 [166.655784] Dynamic subtest eDP-1: SKIP (0.000s) [166.659191] Subtest fbc-psr-no-drrs: SKIP (0.001s) [166.750096] [041/134] (850s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [166.845324] Starting subtest: multiplane-rotation-cropping-bottom [174.148173] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.304s) [174.287730] [042/134] (843s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [174.390893] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [174.394413] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [174.504417] [043/134] (842s left) gem_exec_balancer (bonded-dual) [174.557306] Starting subtest: bonded-dual [174.561234] Subtest bonded-dual: SKIP (0.000s) [174.891322] [044/134] (842s left) kms_hdr (invalid-metadata-sizes) [174.972449] Starting subtest: invalid-metadata-sizes [174.979229] Subtest invalid-metadata-sizes: SKIP (0.000s) [175.059062] [045/134] (842s left) gem_userptr_blits (process-exit) [175.124995] Starting subtest: process-exit [175.130509] Subtest process-exit: SUCCESS (0.007s) [175.281167] [046/134] (842s left) kms_cursor_crc (cursor-offscreen-256x85) [175.550658] Starting subtest: cursor-offscreen-256x85 [175.598577] Subtest cursor-offscreen-256x85: SKIP (0.044s) [175.778962] [047/134] (841s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [175.887218] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [175.889623] Starting dynamic subtest: pipe-A-eDP-1 [175.907449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [175.921470] Starting dynamic subtest: pipe-B-eDP-1 [175.937327] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [175.946885] Starting dynamic subtest: pipe-C-eDP-1 [175.962938] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [175.971663] Starting dynamic subtest: pipe-D-eDP-1 [175.987516] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [175.989311] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [178.182167] [048/134] (839s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [178.247312] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [178.321708] [049/134] (839s left) i915_drm_fdinfo (memory-info-shared) [178.359797] Starting subtest: memory-info-shared [178.361982] Starting dynamic subtest: smem0 [178.412259] Dynamic subtest smem0: SUCCESS (0.056s) [178.414927] Subtest memory-info-shared: SUCCESS (0.057s) [178.497516] [050/134] (839s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [178.595291] Starting subtest: plane-scaler-unity-scaling-with-rotation [178.597651] Starting dynamic subtest: pipe-A [178.822121] Dynamic subtest pipe-A: SUCCESS (0.229s) [178.831488] Starting dynamic subtest: pipe-B [180.132536] Dynamic subtest pipe-B: SUCCESS (1.309s) [180.142104] Starting dynamic subtest: pipe-C [181.475578] Dynamic subtest pipe-C: SUCCESS (1.342s) [181.484285] Starting dynamic subtest: pipe-D [182.807277] Dynamic subtest pipe-D: SUCCESS (1.331s) [182.809660] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.214s) [184.007312] [051/134] (833s left) kms_big_fb (4-tiled-64bpp-rotate-0) [184.099799] Starting subtest: 4-tiled-64bpp-rotate-0 [185.743834] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.645s) [185.960517] [052/134] (831s left) gem_mmap_gtt (big-bo) [186.026871] Subtest big-bo: SKIP (0.000s) [186.090392] [053/134] (831s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [186.138563] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [186.210486] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s) [186.265988] [054/134] (831s left) kms_addfb_basic (addfb25-modifier-no-flag) [186.359624] Starting subtest: addfb25-modifier-no-flag [186.361582] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [186.484311] [055/134] (831s left) kms_chamelium_edid (dp-edid-resolution-list) [186.862516] Subtest dp-edid-resolution-list: SKIP (0.000s) [187.684735] [056/134] (830s left) gem_madvise (dontneed-before-mmap) [187.720260] Starting subtest: dontneed-before-mmap [187.745258] Subtest dontneed-before-mmap: SUCCESS (0.025s) [187.864168] [057/134] (830s left) kms_hdmi_inject (inject-audio) [188.218029] Starting subtest: inject-audio [188.493605] Subtest inject-audio: SUCCESS (0.278s) [189.100170] [058/134] (828s left) core_auth (basic-auth) [189.160791] Starting subtest: basic-auth [189.163108] Subtest basic-auth: SUCCESS (0.001s) [189.282837] [059/134] (828s left) gem_userptr_blits (map-fixed-invalidate-busy) [189.343966] Starting subtest: map-fixed-invalidate-busy [189.348062] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [189.482136] [060/134] (828s left) gem_exec_reloc (basic-concurrent16) [189.549739] Subtest basic-concurrent16: SKIP (0.000s) [189.633162] [061/134] (828s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [189.730684] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [189.734709] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [189.850571] [062/134] (828s left) kms_dp_link_training (non-uhbr-mst) [189.956207] Starting subtest: non-uhbr-mst [189.964988] Subtest non-uhbr-mst: SKIP (0.000s) [190.039800] [063/134] (828s left) kms_scaling_modes (scaling-mode-none) [190.135347] Starting subtest: scaling-mode-none [190.136875] Starting dynamic subtest: pipe-A-eDP-1 [190.227208] Dynamic subtest pipe-A-eDP-1: SKIP (0.091s) [190.241667] Starting dynamic subtest: pipe-B-eDP-1 [190.260470] Dynamic subtest pipe-B-eDP-1: SKIP (0.030s) [190.269899] Starting dynamic subtest: pipe-C-eDP-1 [190.294335] Dynamic subtest pipe-C-eDP-1: SKIP (0.033s) [190.303094] Starting dynamic subtest: pipe-D-eDP-1 [190.327064] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s) [190.330565] Subtest scaling-mode-none: SKIP (0.192s) [190.472456] [064/134] (827s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [190.571219] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [190.574511] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [190.678624] [065/134] (827s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [195.727791] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [195.729994] Starting dynamic subtest: pipe-A-eDP-1 [196.485258] Dynamic subtest pipe-A-eDP-1: SKIP (0.754s) [196.494358] Starting dynamic subtest: pipe-B-eDP-1 [197.595733] Dynamic subtest pipe-B-eDP-1: SKIP (1.108s) [197.600154] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.867s) [198.855358] [066/134] (819s left) syncobj_timeline (single-wait-for-submit-signaled) [198.919603] Starting subtest: single-wait-for-submit-signaled [198.921907] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s) [199.040052] [067/134] (819s left) vgem_basic (dmabuf-export) [199.080353] Starting subtest: dmabuf-export [199.107949] Subtest dmabuf-export: SUCCESS (0.031s) [199.250314] [068/134] (819s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [199.367569] Starting subtest: basic-busy-flip-before-cursor-legacy [199.372085] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [199.537377] [069/134] (818s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [199.637300] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [199.641184] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [199.771028] [070/134] (818s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [204.811862] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [204.816544] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [205.644642] [071/134] (812s left) kms_rotation_crc (sprite-rotation-90) [205.745181] Starting subtest: sprite-rotation-90 [205.749575] Subtest sprite-rotation-90: SKIP (0.001s) [205.831224] [072/134] (812s left) kms_vblank (ts-continuation-modeset-rpm) [205.926221] Starting subtest: ts-continuation-modeset-rpm [205.928370] Starting dynamic subtest: pipe-A-eDP-1 [208.504170] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.576s) [208.519958] Starting dynamic subtest: pipe-D-eDP-1 [210.693865] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.187s) [210.696078] Subtest ts-continuation-modeset-rpm: SUCCESS (4.767s) [211.541157] [073/134] (807s left) gem_exec_schedule (semaphore-user) [211.629115] Starting subtest: semaphore-user [211.677849] Subtest semaphore-user: SUCCESS (0.057s) [212.938081] [074/134] (805s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [213.039367] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [217.248527] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.214s) [218.469936] [075/134] (800s left) kms_flip (dpms-off-confusion) [218.560708] Starting subtest: dpms-off-confusion [218.563205] Starting dynamic subtest: A-eDP1 [227.258937] Dynamic subtest A-eDP1: SUCCESS (8.661s) [227.268560] Starting dynamic subtest: B-eDP1 [235.941856] Dynamic subtest B-eDP1: SUCCESS (8.683s) [235.953442] Starting dynamic subtest: C-eDP1 [244.640602] Dynamic subtest C-eDP1: SUCCESS (8.687s) [244.651064] Starting dynamic subtest: D-eDP1 [253.339163] Dynamic subtest D-eDP1: SUCCESS (8.696s) [253.341241] Subtest dpms-off-confusion: SUCCESS (34.736s) [254.554851] [076/134] (764s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [254.650578] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [254.654991] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [254.771772] [077/134] (764s left) kms_lease (lease-unleased-crtc) [254.866339] Starting subtest: lease-unleased-crtc [254.868583] Starting dynamic subtest: pipe-A-eDP-1 [255.163389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s) [255.172324] Starting dynamic subtest: pipe-B-eDP-1 [255.950884] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.787s) [255.960954] Starting dynamic subtest: pipe-C-eDP-1 [255.963238] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s) [255.972697] Starting dynamic subtest: pipe-D-eDP-1 [255.974873] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s) [255.977047] Subtest lease-unleased-crtc: SUCCESS (1.103s) [256.363959] [078/134] (762s left) kms_cursor_edge_walk (128x128-right-edge) [256.457049] Starting subtest: 128x128-right-edge [256.459376] Starting dynamic subtest: pipe-A-eDP-1 [259.880066] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.424s) [259.892853] Starting dynamic subtest: pipe-D-eDP-1 [263.062296] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.177s) [263.064619] Subtest 128x128-right-edge: SUCCESS (6.605s) [263.947073] [079/134] (754s left) gen9_exec_parse (bb-start-out) [264.006080] Subtest bb-start-out: SKIP (0.000s) [264.086617] [080/134] (754s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [264.184202] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [264.188247] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [264.319052] [081/134] (754s left) i915_pm_rpm (gem-pread) [266.049630] Starting subtest: gem-pread [268.248085] Subtest gem-pread: SUCCESS (2.200s) [268.364688] [082/134] (750s left) kms_plane_alpha_blend (constant-alpha-min) [268.465346] Starting subtest: constant-alpha-min [268.762582] Starting dynamic subtest: pipe-A-eDP-1 [269.462818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s) [269.474869] Starting dynamic subtest: pipe-D-eDP-1 [270.995641] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.530s) [270.998027] Subtest constant-alpha-min: SUCCESS (2.531s) [271.838286] [083/134] (747s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [271.948934] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [271.953334] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [272.070091] [084/134] (747s left) gem_mmap_gtt (cpuset-big-copy-odd) [272.125331] Subtest cpuset-big-copy-odd: SKIP (0.000s) [272.190052] [085/134] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [272.277797] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [280.898262] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.624s) [281.045084] [086/134] (738s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt) [281.157628] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt [285.324299] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.169s) [286.458432] [087/134] (732s left) kms_flip (2x-flip-vs-dpms-on-nop) [286.546871] Starting subtest: 2x-flip-vs-dpms-on-nop [286.555419] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s) [286.658565] [088/134] (732s left) gem_basic (bad-close) [286.716429] Starting subtest: bad-close [286.720949] Subtest bad-close: SUCCESS (0.000s) [286.824443] [089/134] (732s left) kms_psr (psr2-cursor-render) [286.918120] Starting subtest: psr2-cursor-render [286.920397] Starting dynamic subtest: eDP-1 [288.577272] Dynamic subtest eDP-1: SUCCESS (1.657s) [288.579631] Subtest psr2-cursor-render: SUCCESS (1.659s) [289.459497] [090/134] (729s left) api_intel_bb (render-ccs) [289.517930] Starting subtest: render-ccs [289.881270] Subtest render-ccs: SUCCESS (0.362s) [290.015429] [091/134] (729s left) kms_cursor_crc (cursor-offscreen-64x21) [290.215743] Starting subtest: cursor-offscreen-64x21 [290.273855] Subtest cursor-offscreen-64x21: SKIP (0.056s) [290.554995] [092/134] (728s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [290.667649] Starting subtest: basic-busy-flip-before-cursor-atomic [290.672249] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [290.824045] [093/134] (728s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [290.881600] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [290.985970] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s) [291.075272] [094/134] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [291.162768] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [291.167027] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [291.296251] [095/134] (728s left) gem_flink_basic (bad-open) [291.344083] Starting subtest: bad-open [291.346365] Subtest bad-open: SUCCESS (0.000s) [291.478194] [096/134] (728s left) kms_flip (2x-blocking-wf_vblank) [291.575260] Starting subtest: 2x-blocking-wf_vblank [291.586574] Subtest 2x-blocking-wf_vblank: SKIP (0.011s) [291.679613] [097/134] (728s left) kms_big_fb (linear-8bpp-rotate-0) [291.777366] Starting subtest: linear-8bpp-rotate-0 [293.046689] Subtest linear-8bpp-rotate-0: SUCCESS (1.269s) [293.200540] [098/134] (726s left) api_intel_allocator (fork-simple-once) [293.259725] Starting subtest: fork-simple-once [293.275898] Subtest fork-simple-once: SUCCESS (0.017s) [293.437235] [099/134] (726s left) kms_big_fb (y-tiled-32bpp-rotate-180) [293.539787] Starting subtest: y-tiled-32bpp-rotate-180 [293.543553] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [293.633791] [100/134] (726s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [293.691568] Starting subtest: wait-all-for-submit-delayed-submit [293.796388] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s) [293.891424] [101/134] (726s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [293.992248] Starting subtest: plane-downscale-factor-0-75-with-modifiers [293.994429] Starting dynamic subtest: pipe-A [294.330826] Dynamic subtest pipe-A: SUCCESS (0.341s) [294.340158] Starting dynamic subtest: pipe-B [295.713602] Dynamic subtest pipe-B: SUCCESS (1.382s) [295.723628] Starting dynamic subtest: pipe-C [297.104995] Dynamic subtest pipe-C: SUCCESS (1.391s) [297.114740] Starting dynamic subtest: pipe-D [298.495531] Dynamic subtest pipe-D: SUCCESS (1.390s) [298.497760] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.506s) [299.744976] [102/134] (720s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [299.844159] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [299.846354] Starting dynamic subtest: pipe-A-eDP-1 [300.735831] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.881s) [300.746803] Starting dynamic subtest: pipe-B-eDP-1 [302.400674] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.663s) [302.410862] Starting dynamic subtest: pipe-C-eDP-1 [303.902055] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.502s) [303.912249] Starting dynamic subtest: pipe-D-eDP-1 [305.371040] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.466s) [305.373495] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.518s) [306.657513] [103/134] (713s left) kms_big_fb (yf-tiled-addfb) [306.770311] Starting subtest: yf-tiled-addfb [306.774762] Subtest yf-tiled-addfb: SKIP (0.000s) [306.904933] [104/134] (713s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [306.997455] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [316.226674] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.228s) [316.398008] [105/134] (703s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu) [316.494258] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu [323.106579] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.616s) [323.268400] [106/134] (696s left) gem_exec_reloc (basic-wc-gtt-active) [323.332461] Subtest basic-wc-gtt-active: SKIP (0.000s) [323.428226] [107/134] (696s left) perf (global-sseu-config-invalid) [323.517014] Starting subtest: global-sseu-config-invalid [323.521743] Subtest global-sseu-config-invalid: SKIP (0.000s) [323.564085] [108/134] (696s left) kms_pm_rpm (fences-dpms) [325.086591] Starting subtest: fences-dpms [325.091646] Subtest fences-dpms: SKIP (0.000s) [325.866026] [109/134] (694s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [325.963291] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [325.965587] Starting dynamic subtest: pipe-A-default-mode [327.159343] Dynamic subtest pipe-A-default-mode: SKIP (1.193s) [327.163682] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.194s) [327.365121] [110/134] (692s left) kms_pm_rpm (cursor-dpms) [329.098308] Starting subtest: cursor-dpms [329.103843] Subtest cursor-dpms: SKIP (0.000s) [329.637977] [111/134] (690s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [329.691980] Starting subtest: invalid-multi-wait-all-unsubmitted [329.694349] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [329.802326] [112/134] (690s left) kms_psr (fbc-pr-sprite-render) [329.903325] Starting subtest: fbc-pr-sprite-render [329.907329] Subtest fbc-pr-sprite-render: SKIP (0.000s) [329.990376] [113/134] (690s left) kms_big_fb (x-tiled-16bpp-rotate-270) [330.100086] Starting subtest: x-tiled-16bpp-rotate-270 [330.120825] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s) [330.258560] [114/134] (690s left) perf (invalid-remove-userspace-config) [330.352855] Starting subtest: invalid-remove-userspace-config [330.362126] Subtest invalid-remove-userspace-config: SUCCESS (0.008s) [330.412877] [115/134] (690s left) gem_watchdog (default-virtual) [330.476091] Starting subtest: default-virtual [336.754377] Subtest default-virtual: SUCCESS (6.283s) [336.875631] [116/134] (683s left) sw_sync (sync_merge_same) [336.911041] Starting subtest: sync_merge_same [336.913288] Subtest sync_merge_same: SUCCESS (0.000s) [336.985891] [117/134] (683s left) gem_ringfill (basic-all) [342.990568] Starting subtest: basic-all [344.097405] Subtest basic-all: SUCCESS (1.158s) [344.251174] [118/134] (676s left) gem_ccs (suspend-resume) [344.305744] Starting subtest: suspend-resume [344.310538] Subtest suspend-resume: SKIP (0.000s) [344.448421] [119/134] (676s left) gem_workarounds (basic-read) [344.520709] Starting subtest: basic-read [344.538791] Subtest basic-read: SUCCESS (0.018s) [344.680294] [120/134] (676s left) gem_softpin (noreloc-s3) [344.742142] Starting subtest: noreloc-S3 [365.179911] Subtest noreloc-S3: SUCCESS (5.402s) [365.325073] Aborting: Kernel badly tainted (0x4244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [365.347730] [FACT gem_softpin (noreloc-s3)] new: kernel.is_tainted.taint_warn: true [365.348609] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_chamelium_hpd results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_async_flips results: parsing output: 7/ for test: kms_psr2_sf results: parsing output: 8/ for test: gem_exec_reloc results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_exec_flush results: parsing output: 11/ for test: kms_colorop results: parsing output: 12/ for test: syncobj_timeline results: parsing output: 13/ for test: kms_getfb results: parsing output: 14/ for test: perf_pmu results: parsing output: 15/ for test: kms_atomic_transition results: parsing output: 16/ for test: kms_cursor_crc results: parsing output: 17/ for test: gem_pxp results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: gem_exec_params results: parsing output: 20/ for test: tools_test results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: gem_lmem_swapping results: parsing output: 23/ for test: gem_softpin results: parsing output: 24/ for test: prime_mmap results: parsing output: 25/ for test: gem_exec_whisper results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: gem_exec_schedule results: parsing output: 28/ for test: gem_ctx_param results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_exec_capture results: parsing output: 32/ for test: vgem_slow results: parsing output: 33/ for test: kms_big_fb results: parsing output: 34/ for test: kms_chamelium_color results: parsing output: 35/ for test: gem_exec_reloc results: parsing output: 36/ for test: gem_eio results: parsing output: 37/ for test: perf results: parsing output: 38/ for test: dmabuf_sync_file results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: kms_rotation_crc results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_exec_balancer results: parsing output: 43/ for test: kms_hdr results: parsing output: 44/ for test: gem_userptr_blits results: parsing output: 45/ for test: kms_cursor_crc results: parsing output: 46/ for test: kms_ccs results: parsing output: 47/ for test: kms_pipe_b_c_ivb results: parsing output: 48/ for test: i915_drm_fdinfo results: parsing output: 49/ for test: kms_plane_scaling results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: gem_mmap_gtt results: parsing output: 52/ for test: sriov_basic results: parsing output: 53/ for test: kms_addfb_basic results: parsing output: 54/ for test: kms_chamelium_edid results: parsing output: 55/ for test: gem_madvise results: parsing output: 56/ for test: kms_hdmi_inject results: parsing output: 57/ for test: core_auth results: parsing output: 58/ for test: gem_userptr_blits results: parsing output: 59/ for test: gem_exec_reloc results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_dp_link_training results: parsing output: 62/ for test: kms_scaling_modes results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_psr2_sf results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: vgem_basic results: parsing output: 67/ for test: kms_cursor_legacy results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_psr2_sf results: parsing output: 70/ for test: kms_rotation_crc results: parsing output: 71/ for test: kms_vblank results: parsing output: 72/ for test: gem_exec_schedule results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_lease results: parsing output: 77/ for test: kms_cursor_edge_walk results: parsing output: 78/ for test: gen9_exec_parse results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: i915_pm_rpm results: parsing output: 81/ for test: kms_plane_alpha_blend results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: gem_basic results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: api_intel_bb results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: kms_cursor_legacy results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_flink_basic results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: api_intel_allocator results: parsing output: 98/ for test: kms_big_fb results: parsing output: 99/ for test: syncobj_timeline results: parsing output: 100/ for test: kms_plane_scaling results: parsing output: 101/ for test: kms_ccs results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: perf results: parsing output: 107/ for test: kms_pm_rpm results: parsing output: 108/ for test: kms_flip_scaled_crc results: parsing output: 109/ for test: kms_pm_rpm results: parsing output: 110/ for test: syncobj_wait results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: perf results: parsing output: 114/ for test: gem_watchdog results: parsing output: 115/ for test: sw_sync results: parsing output: 116/ for test: gem_ringfill results: parsing output: 117/ for test: gem_ccs results: parsing output: 118/ for test: gem_workarounds results: parsing output: 119/ for test: gem_softpin results: parsing output: 120/ for test: vgem_basic results: no output, setting notrun results: parsing output: 121/ for test: gem_mmap_gtt results: no output, setting notrun results: parsing output: 122/ for test: i915_drm_fdinfo results: no output, setting notrun results: parsing output: 123/ for test: kms_force_connector_basic results: no output, setting notrun results: parsing output: 124/ for test: i915_pm_rps results: no output, setting notrun results: parsing output: 125/ for test: fbdev results: no output, setting notrun results: parsing output: 126/ for test: kms_colorop results: no output, setting notrun results: parsing output: 127/ for test: gem_ctx_persistence results: no output, setting notrun results: parsing output: 128/ for test: prime_mmap results: no output, setting notrun results: parsing output: 129/ for test: gem_pxp results: no output, setting notrun results: parsing output: 130/ for test: kms_colorop results: no output, setting notrun results: parsing output: 131/ for test: gem_partial_pwrite_pread results: no output, setting notrun results: parsing output: 132/ for test: kms_joiner results: no output, setting notrun results: parsing output: 133/ for test: gem_exec_fence results: no output, setting notrun Done.