[59.669425] Initializing watchdogs [59.669472] /dev/watchdog0 [59.684378] [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] [59.689436] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.691836] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.695531] [001/132] (960s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [59.773840] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [59.776202] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s) [59.885196] [002/132] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [59.989472] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [66.581690] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.555s) [66.690865] [003/132] (953s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier) [66.791069] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier [66.795408] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s) [66.858942] [004/132] (953s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [66.959172] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [66.961596] Starting dynamic subtest: pipe-A-eDP-1 [67.020892] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s) [67.027920] Starting dynamic subtest: pipe-B-eDP-1 [67.084643] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s) [67.093311] Starting dynamic subtest: pipe-C-eDP-1 [67.151781] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s) [67.160303] Starting dynamic subtest: pipe-D-eDP-1 [67.217807] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s) [67.222394] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.020s) [69.289845] [005/132] (951s left) vgem_basic (dmabuf-fence) [69.365587] Starting subtest: dmabuf-fence [69.367525] Subtest dmabuf-fence: SUCCESS (0.001s) [69.417520] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true [69.420938] [006/132] (950s left) kms_big_fb (x-tiled-64bpp-rotate-270) [69.519263] Starting subtest: x-tiled-64bpp-rotate-270 [69.540245] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s) [69.640287] [007/132] (950s left) kms_chamelium_hpd (vga-hpd) [70.020573] Subtest vga-hpd: SKIP (0.000s) [70.817174] [008/132] (949s left) gem_fence_thrash (bo-write-verify-threaded-none) [70.860997] Starting subtest: bo-write-verify-threaded-none [70.884674] Subtest bo-write-verify-threaded-none: SKIP (0.019s) [70.951040] [009/132] (949s left) kms_frontbuffer_tracking (psr-2p-rte) [71.046949] Starting subtest: psr-2p-rte [71.051224] Subtest psr-2p-rte: SKIP (0.000s) [71.144814] [010/132] (949s left) syncobj_wait (invalid-multi-wait-unsubmitted) [71.207888] Starting subtest: invalid-multi-wait-unsubmitted [71.210149] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [71.291119] [011/132] (949s left) kms_force_connector_basic (force-connector-state) [71.372871] Starting subtest: force-connector-state [71.980335] Subtest force-connector-state: SUCCESS (0.608s) [73.005817] [012/132] (947s left) kms_properties (colorop-properties-legacy) [73.232910] Starting subtest: colorop-properties-legacy [73.235876] Starting dynamic subtest: pipe-A-eDP-1 [73.657582] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.425s) [73.669675] Starting dynamic subtest: pipe-B-eDP-1 [74.699190] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.040s) [74.708911] Starting dynamic subtest: pipe-C-eDP-1 [75.798512] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.096s) [75.807135] Starting dynamic subtest: pipe-D-eDP-1 [76.893079] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.091s) [76.895429] Subtest colorop-properties-legacy: SUCCESS (3.656s) [77.760704] [013/132] (942s left) gem_tiled_partial_pwrite_pread (reads) [77.832685] Subtest reads: SKIP (0.000s) [77.895237] [014/132] (942s left) gem_ctx_persistence (heartbeat-hostile) [77.952480] Starting subtest: heartbeat-hostile [77.957320] Subtest heartbeat-hostile: SKIP (0.000s) [78.060913] [015/132] (942s left) gem_exec_schedule (u-submit-golden-slice) [78.128762] Starting subtest: u-submit-golden-slice [78.131213] Starting dynamic subtest: rcs0 [78.156362] Dynamic subtest rcs0: SUCCESS (0.035s) [78.166685] Starting dynamic subtest: bcs0 [78.193491] Dynamic subtest bcs0: SUCCESS (0.037s) [78.204308] Starting dynamic subtest: vcs0 [78.222889] Dynamic subtest vcs0: SUCCESS (0.029s) [78.231036] Starting dynamic subtest: vcs1 [78.254287] Dynamic subtest vcs1: SUCCESS (0.031s) [78.262195] Starting dynamic subtest: vecs0 [78.285648] Dynamic subtest vecs0: SUCCESS (0.031s) [78.293647] Starting dynamic subtest: ccs0 [78.325875] Dynamic subtest ccs0: SUCCESS (0.040s) [78.328209] Subtest u-submit-golden-slice: SUCCESS (0.205s) [79.391393] [016/132] (941s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [79.491035] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [86.824122] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.332s) [86.947659] [017/132] (933s left) gem_exec_reloc (basic-wc-read-active) [87.014689] Subtest basic-wc-read-active: SKIP (0.000s) [87.100875] [018/132] (933s left) kms_force_connector_basic (force-load-detect) [87.167609] Starting subtest: force-load-detect [87.172052] Subtest force-load-detect: SKIP (0.000s) [87.302244] [019/132] (933s left) kms_big_fb (y-tiled-64bpp-rotate-0) [87.393925] Starting subtest: y-tiled-64bpp-rotate-0 [87.398291] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [87.479530] [020/132] (933s left) kms_joiner (basic-max-non-joiner) [87.571037] Starting subtest: basic-max-non-joiner [87.575619] Subtest basic-max-non-joiner: SKIP (0.000s) [87.659675] [021/132] (933s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [87.725263] Starting subtest: invalid-multi-wait-all-unsubmitted [87.727602] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [87.823720] [022/132] (933s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [87.906738] Starting subtest: modeset-transition-nonblocking-fencing [87.908422] Starting dynamic subtest: 1x-outputs [98.938846] Dynamic subtest 1x-outputs: SUCCESS (11.029s) [98.941461] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.030s) [99.767347] [023/132] (921s left) gem_wait (await) [99.839694] Starting subtest: await [99.841912] Starting dynamic subtest: all-engines [100.932419] Dynamic subtest all-engines: SUCCESS (1.094s) [100.947987] Starting dynamic subtest: rcs0 [101.987644] Dynamic subtest rcs0: SUCCESS (1.054s) [102.003509] Starting dynamic subtest: bcs0 [103.044192] Dynamic subtest bcs0: SUCCESS (1.055s) [103.059252] Starting dynamic subtest: vcs0 [104.097177] Dynamic subtest vcs0: SUCCESS (1.052s) [104.112629] Starting dynamic subtest: vcs1 [105.150931] Dynamic subtest vcs1: SUCCESS (1.052s) [105.165455] Starting dynamic subtest: vecs0 [106.205893] Dynamic subtest vecs0: SUCCESS (1.054s) [106.221157] Starting dynamic subtest: ccs0 [107.263437] Dynamic subtest ccs0: SUCCESS (1.055s) [107.265912] Subtest await: SUCCESS (7.425s) [107.457759] [024/132] (913s left) gem_basic (bad-close) [107.511877] Starting subtest: bad-close [107.516418] Subtest bad-close: SUCCESS (0.000s) [107.605655] [025/132] (913s left) syncobj_timeline (invalid-wait-illegal-handle) [107.661710] Starting subtest: invalid-wait-illegal-handle [107.663817] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [107.787970] [026/132] (913s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [107.879669] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [107.883680] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [107.951349] [027/132] (913s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [108.048443] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [108.052754] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [108.122395] [028/132] (913s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [108.217836] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [108.220133] Starting dynamic subtest: pipe-A-eDP-1 [108.240086] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [108.248668] Starting dynamic subtest: pipe-B-eDP-1 [108.267103] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [108.274474] Starting dynamic subtest: pipe-C-eDP-1 [108.293066] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [108.300681] Starting dynamic subtest: pipe-D-eDP-1 [108.319084] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [108.321129] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [110.478550] [029/132] (910s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [110.585138] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [117.892204] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.312s) [118.031323] [030/132] (903s left) gem_exec_balancer (noheartbeat) [118.296277] Starting subtest: noheartbeat [118.301023] Subtest noheartbeat: SKIP (0.000s) [118.379986] [031/132] (903s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [118.479839] Starting subtest: psr2-overlay-plane-move-continuous-sf [118.482122] Starting dynamic subtest: pipe-A-eDP-1 [124.459391] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.982s) [124.471882] Starting dynamic subtest: pipe-B-eDP-1 [131.111429] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.652s) [131.113899] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.637s) [131.967869] [032/132] (889s left) prime_vgem (basic-fence-mmap) [132.039450] Starting subtest: basic-fence-mmap [132.044151] Subtest basic-fence-mmap: SKIP (0.000s) [132.134185] [033/132] (889s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [132.237554] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [132.241721] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [132.338885] [034/132] (889s left) kms_pipe_crc_basic (read-crc-frame-sequence) [132.432132] Starting subtest: read-crc-frame-sequence [132.434304] Starting dynamic subtest: pipe-A-eDP-1 [133.145758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s) [133.155758] Starting dynamic subtest: pipe-B-eDP-1 [134.543441] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.396s) [134.553564] Starting dynamic subtest: pipe-C-eDP-1 [135.864054] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.319s) [135.872590] Starting dynamic subtest: pipe-D-eDP-1 [137.177127] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s) [137.179453] Subtest read-crc-frame-sequence: SUCCESS (4.746s) [137.969726] [035/132] (883s left) kms_plane_multiple (tiling-none) [138.075885] Starting subtest: tiling-none [138.077790] Starting dynamic subtest: pipe-A-eDP-1 [141.901495] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.824s) [141.912163] Starting dynamic subtest: pipe-B-eDP-1 [146.530240] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.628s) [146.539072] Starting dynamic subtest: pipe-C-eDP-1 [151.101777] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.570s) [151.109936] Starting dynamic subtest: pipe-D-eDP-1 [155.687720] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.585s) [155.689929] Subtest tiling-none: SUCCESS (17.611s) [156.570328] [036/132] (865s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [156.670457] Starting subtest: psr-rgb565-draw-mmap-cpu [163.417132] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.749s) [163.556309] [037/132] (858s left) dmabuf_sync_file (export-wait-after-attach) [163.607486] Starting subtest: export-wait-after-attach [163.609654] Subtest export-wait-after-attach: SUCCESS (0.001s) [163.661909] [038/132] (858s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [163.752071] Starting subtest: crc-primary-basic-y-tiled-ccs [163.754206] Starting dynamic subtest: pipe-A-eDP-1 [163.778210] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [163.787707] Starting dynamic subtest: pipe-B-eDP-1 [163.808983] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [163.816590] Starting dynamic subtest: pipe-C-eDP-1 [163.837181] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [163.844661] Starting dynamic subtest: pipe-D-eDP-1 [163.867267] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [163.871267] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s) [165.985441] [039/132] (855s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [166.079452] Starting subtest: 2x-flip-vs-absolute-wf_vblank [166.091154] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s) [166.185843] [040/132] (855s left) kms_getfb (getfb-repeated-different-handles) [166.270832] Starting subtest: getfb-repeated-different-handles [166.273065] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [166.376534] [041/132] (855s left) kms_flip (dpms-vs-vblank-race) [166.482657] Starting subtest: dpms-vs-vblank-race [166.484986] Starting dynamic subtest: A-eDP1 [170.328313] Dynamic subtest A-eDP1: SUCCESS (3.845s) [170.338952] Starting dynamic subtest: B-eDP1 [173.824434] Dynamic subtest B-eDP1: SUCCESS (3.495s) [173.832514] Starting dynamic subtest: C-eDP1 [177.322675] Dynamic subtest C-eDP1: SUCCESS (3.494s) [177.331500] Starting dynamic subtest: D-eDP1 [180.817800] Dynamic subtest D-eDP1: SUCCESS (3.493s) [180.822624] Subtest dpms-vs-vblank-race: SUCCESS (14.340s) [181.673115] [042/132] (840s left) kms_cursor_crc (cursor-random-256x85) [181.917672] Starting subtest: cursor-random-256x85 [181.966429] Subtest cursor-random-256x85: SKIP (0.044s) [182.134207] [043/132] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [182.219575] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [182.223675] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [182.316743] [044/132] (839s left) gem_softpin (evict-snoop-interruptible) [182.372313] Starting subtest: evict-snoop-interruptible [182.376894] Subtest evict-snoop-interruptible: SKIP (0.000s) [182.495560] [045/132] (839s left) kms_content_protection (uevent) [182.631097] Starting subtest: uevent [182.634883] Subtest uevent: SKIP (0.000s) [182.755780] [046/132] (839s left) kms_psr (fbc-psr2-sprite-blt) [182.847639] Starting subtest: fbc-psr2-sprite-blt [182.849580] Starting dynamic subtest: eDP-1 [182.853150] Dynamic subtest eDP-1: SKIP (0.000s) [182.856801] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [182.918825] [047/132] (839s left) kms_cursor_edge_walk (128x128-top-bottom) [183.010156] Starting subtest: 128x128-top-bottom [183.012202] Starting dynamic subtest: pipe-A-eDP-1 [186.504599] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s) [186.513039] Starting dynamic subtest: pipe-D-eDP-1 [189.686442] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.178s) [189.688578] Subtest 128x128-top-bottom: SUCCESS (6.676s) [190.563360] [048/132] (831s left) perf_pmu (busy-double-start) [190.621727] Starting subtest: busy-double-start [190.623671] Starting dynamic subtest: rcs0 [194.262294] Dynamic subtest rcs0: FAIL (3.592s) [194.270648] Starting dynamic subtest: bcs0 [197.800979] Dynamic subtest bcs0: SUCCESS (3.588s) [197.812563] Starting dynamic subtest: vcs0 [201.807904] Dynamic subtest vcs0: SUCCESS (4.004s) [201.818600] Starting dynamic subtest: vcs1 [205.853196] Dynamic subtest vcs1: SUCCESS (4.042s) [205.864659] Starting dynamic subtest: vecs0 [209.819061] Dynamic subtest vecs0: SUCCESS (3.963s) [209.833901] Starting dynamic subtest: ccs0 [213.454778] Dynamic subtest ccs0: FAIL (3.567s) [213.457078] Subtest busy-double-start: FAIL (22.768s) [213.502435] [049/132] (808s left) gem_exec_parallel (engines) [213.583034] Starting subtest: engines [213.585420] Starting dynamic subtest: basic [215.314790] Dynamic subtest basic: SUCCESS (1.733s) [215.325828] Starting dynamic subtest: contexts [219.601894] Dynamic subtest contexts: SUCCESS (4.284s) [219.610643] Starting dynamic subtest: fds [223.434740] Dynamic subtest fds: SUCCESS (3.831s) [223.444470] Starting dynamic subtest: userptr [225.288355] Dynamic subtest userptr: SUCCESS (1.851s) [225.290918] Subtest engines: SUCCESS (11.708s) [225.487466] [050/132] (796s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu) [225.594053] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu [232.223223] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.631s) [232.336216] [051/132] (789s left) gem_mmap_gtt (zero-extend) [232.397259] Subtest zero-extend: SKIP (0.000s) [232.460913] [052/132] (789s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [232.557736] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [239.416384] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.860s) [239.571529] [053/132] (782s left) gem_exec_whisper (basic-queues-forked) [239.635372] Starting subtest: basic-queues-forked [262.635172] Subtest basic-queues-forked: SUCCESS (22.995s) [262.816164] [054/132] (759s left) gem_render_copy (yf-tiled) [262.867532] Starting subtest: yf-tiled [262.872102] Subtest yf-tiled: SKIP (0.000s) [263.049458] [055/132] (759s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [263.160308] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [263.164329] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [263.268760] [056/132] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [263.375816] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [263.380103] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [263.463993] [057/132] (759s left) prime_self_import (basic-with_one_bo_two_files) [263.505345] Starting subtest: basic-with_one_bo_two_files [263.528108] Subtest basic-with_one_bo_two_files: SUCCESS (0.022s) [263.628632] [058/132] (758s left) gem_close_race (multigpu-basic-process) [263.704070] Starting subtest: multigpu-basic-process [263.708352] Subtest multigpu-basic-process: SKIP (0.000s) [263.918708] [059/132] (758s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [264.012891] Starting subtest: crc-primary-suspend-yf-tiled-ccs [264.015173] Starting dynamic subtest: pipe-A-eDP-1 [264.023737] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [264.033236] Starting dynamic subtest: pipe-B-eDP-1 [264.041771] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [264.050448] Starting dynamic subtest: pipe-C-eDP-1 [264.058677] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [264.066673] Starting dynamic subtest: pipe-D-eDP-1 [264.074876] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [264.079192] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s) [266.254372] [060/132] (756s left) gem_madvise (dontneed-after-mmap) [266.299846] Starting subtest: dontneed-after-mmap [266.330564] Subtest dontneed-after-mmap: SUCCESS (0.030s) [266.443226] [061/132] (756s left) api_intel_bb (destroy-bb) [266.495851] Starting subtest: destroy-bb [266.505457] Subtest destroy-bb: SUCCESS (0.011s) [266.642375] [062/132] (756s left) gem_media_fill (media-fill) [266.706256] Subtest media-fill: SKIP (0.000s) [266.823389] [063/132] (756s left) kms_plane (plane-panning-bottom-right) [266.919106] Starting subtest: plane-panning-bottom-right [266.920995] Starting dynamic subtest: pipe-A [268.590291] Dynamic subtest pipe-A: SUCCESS (1.671s) [268.599737] Starting dynamic subtest: pipe-B [270.995058] Dynamic subtest pipe-B: SUCCESS (2.404s) [270.997231] Subtest plane-panning-bottom-right: SUCCESS (4.078s) [271.864894] [064/132] (751s left) gen9_exec_parse (bb-start-param) [271.928177] Subtest bb-start-param: SKIP (0.000s) [271.996752] [065/132] (750s left) kms_chamelium_edid (dp-edid-read) [272.375797] Subtest dp-edid-read: SKIP (0.000s) [273.154452] [066/132] (749s left) syncobj_timeline (multi-wait-signaled) [273.210286] Starting subtest: multi-wait-signaled [273.212597] Subtest multi-wait-signaled: SUCCESS (0.000s) [273.303722] [067/132] (749s left) kms_flip (flip-vs-panning) [273.393761] Starting subtest: flip-vs-panning [273.395791] Starting dynamic subtest: A-eDP1 [282.132621] Dynamic subtest A-eDP1: SUCCESS (8.741s) [282.140870] Starting dynamic subtest: B-eDP1 [290.840689] Dynamic subtest B-eDP1: SUCCESS (8.706s) [290.851621] Starting dynamic subtest: C-eDP1 [299.523834] Dynamic subtest C-eDP1: SUCCESS (8.681s) [299.534626] Starting dynamic subtest: D-eDP1 [308.221962] Dynamic subtest D-eDP1: SUCCESS (8.695s) [308.226546] Subtest flip-vs-panning: SUCCESS (34.836s) [309.473575] [068/132] (713s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [309.573854] Starting subtest: yf-tiled-32bpp-rotate-180 [309.578419] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [309.658671] [069/132] (713s left) kms_cursor_legacy (torture-bo) [309.785530] Starting subtest: torture-bo [309.787743] Starting dynamic subtest: pipe-A [315.937866] Dynamic subtest pipe-A: SUCCESS (6.149s) [315.948782] Starting dynamic subtest: pipe-B [323.246428] Dynamic subtest pipe-B: SUCCESS (7.307s) [323.259632] Starting dynamic subtest: pipe-C [330.153983] Dynamic subtest pipe-C: SUCCESS (6.905s) [330.164966] Starting dynamic subtest: pipe-D [336.953945] Dynamic subtest pipe-D: SUCCESS (6.797s) [336.969714] Starting dynamic subtest: all-pipes [343.526965] Dynamic subtest all-pipes: SUCCESS (6.570s) [343.529632] Subtest torture-bo: SUCCESS (33.740s) [343.693172] [070/132] (679s left) kms_selftest (drm_dp_mst_helper) [343.742985] Starting subtest: drm_dp_mst_helper [343.781796] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [343.875938] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.094s) [343.886039] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [343.974508] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.097s) [343.983770] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [344.086379] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.110s) [344.088245] Subtest drm_dp_mst_helper: SUCCESS (0.342s) [344.254654] [071/132] (678s left) kms_chamelium_audio (dp-audio) [344.643880] Subtest dp-audio: SKIP (0.000s) [345.430525] [072/132] (677s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [345.488081] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [345.492697] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [345.675731] [073/132] (677s left) gen9_exec_parse (unaligned-access) [345.730215] Subtest unaligned-access: SKIP (0.000s) [345.801046] [074/132] (677s left) syncobj_wait (multi-wait-all-for-submit-signaled) [345.853848] Starting subtest: multi-wait-all-for-submit-signaled [345.856106] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [345.950491] [075/132] (677s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [346.043869] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [352.659036] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.619s) [352.760178] [076/132] (670s left) gem_exec_async (forked-writes) [352.836384] Starting subtest: forked-writes [352.838801] Starting dynamic subtest: rcs0 [352.863459] Dynamic subtest rcs0: SUCCESS (0.027s) [352.874191] Starting dynamic subtest: bcs0 [352.889428] Dynamic subtest bcs0: SUCCESS (0.025s) [352.899642] Starting dynamic subtest: vcs0 [352.914409] Dynamic subtest vcs0: SUCCESS (0.024s) [352.923863] Starting dynamic subtest: vcs1 [352.939203] Dynamic subtest vcs1: SUCCESS (0.024s) [352.948333] Starting dynamic subtest: vecs0 [352.963265] Dynamic subtest vecs0: SUCCESS (0.023s) [352.975592] Starting dynamic subtest: ccs0 [352.986401] Dynamic subtest ccs0: SUCCESS (0.022s) [352.988674] Subtest forked-writes: SUCCESS (0.150s) [354.286994] [077/132] (669s left) i915_selftest (live) [357.587398] Starting subtest: live [357.589873] Starting dynamic subtest: sanitycheck [361.910734] Dynamic subtest sanitycheck: SUCCESS (4.323s) [361.920284] Starting dynamic subtest: uncore [366.291812] Dynamic subtest uncore: SUCCESS (4.380s) [366.301599] Starting dynamic subtest: workarounds [369.389536] Dynamic subtest workarounds: SUCCESS (3.096s) [369.398767] Starting dynamic subtest: gt_engines [372.454278] Dynamic subtest gt_engines: SUCCESS (3.063s) [372.469705] Starting dynamic subtest: gt_timelines [388.046356] Dynamic subtest gt_timelines: SUCCESS (15.588s) [388.060240] Starting dynamic subtest: gt_contexts [392.360077] Dynamic subtest gt_contexts: SUCCESS (4.312s) [392.374977] Starting dynamic subtest: gt_lrc [396.736900] Dynamic subtest gt_lrc: SUCCESS (4.375s) [396.746861] Starting dynamic subtest: gt_mocs [399.720084] Dynamic subtest gt_mocs: SUCCESS (2.982s) [399.729425] Starting dynamic subtest: gt_pm [406.465019] Dynamic subtest gt_pm: SUCCESS (6.742s) [406.474494] Starting dynamic subtest: gt_heartbeat [410.807663] Dynamic subtest gt_heartbeat: SUCCESS (4.342s) [410.817593] Starting dynamic subtest: gt_tlb [420.070621] Dynamic subtest gt_tlb: SUCCESS (9.261s) [420.079730] Starting dynamic subtest: requests [433.496854] Dynamic subtest requests: SUCCESS (13.424s) [433.506604] Starting dynamic subtest: migrate [441.241405] Dynamic subtest migrate: SUCCESS (7.741s) [441.256534] Starting dynamic subtest: active [445.530366] Dynamic subtest active: SUCCESS (4.287s) [445.540256] Starting dynamic subtest: objects [450.370977] Dynamic subtest objects: SUCCESS (4.839s) [450.380896] Starting dynamic subtest: mman [455.166194] Dynamic subtest mman: SUCCESS (4.793s) [455.175284] Starting dynamic subtest: dmabuf [459.491086] Dynamic subtest dmabuf: SUCCESS (4.323s) [459.500814] Starting dynamic subtest: vma [463.795037] Dynamic subtest vma: SUCCESS (4.303s) [463.804092] Starting dynamic subtest: coherency [467.463851] Dynamic subtest coherency: SUCCESS (3.666s) [467.473669] Starting dynamic subtest: gtt [479.338389] Dynamic subtest gtt: SUCCESS (11.871s) [479.348060] Starting dynamic subtest: gem [486.949062] Dynamic subtest gem: SUCCESS (7.609s) [486.958171] Starting dynamic subtest: evict [492.391932] Dynamic subtest evict: SUCCESS (5.442s) [492.401032] Starting dynamic subtest: hugepages [503.292077] Dynamic subtest hugepages: SUCCESS (10.898s) [503.301073] Starting dynamic subtest: gem_contexts [531.867363] Dynamic subtest gem_contexts: SUCCESS (28.573s) [531.876867] Starting dynamic subtest: client [536.245430] Dynamic subtest client: SUCCESS (4.376s) [536.259933] Starting dynamic subtest: gem_migrate [540.633040] Dynamic subtest gem_migrate: SUCCESS (4.386s) [540.642835] Starting dynamic subtest: reset [543.450207] Dynamic subtest reset: SUCCESS (2.815s) [543.460058] Starting dynamic subtest: memory_region [547.849644] Dynamic subtest memory_region: SUCCESS (4.398s) [547.859682] Starting dynamic subtest: hangcheck [560.752544] Dynamic subtest hangcheck: SUCCESS (12.900s) [560.762247] Starting dynamic subtest: execlists [565.028625] Dynamic subtest execlists: SUCCESS (4.274s) [565.038342] Starting dynamic subtest: ring_submission [569.368622] Dynamic subtest ring_submission: SUCCESS (4.339s) [569.379883] Starting dynamic subtest: perf [572.151688] Dynamic subtest perf: SUCCESS (2.779s) [572.161538] Starting dynamic subtest: slpc [586.133759] Dynamic subtest slpc: SUCCESS (13.980s) [586.141974] Starting dynamic subtest: guc [590.052454] Dynamic subtest guc: SUCCESS (3.917s) [590.066925] Starting dynamic subtest: guc_multi_lrc [594.410986] Dynamic subtest guc_multi_lrc: SUCCESS (4.358s) [594.418862] Starting dynamic subtest: guc_hang [599.321967] Dynamic subtest guc_hang: SUCCESS (4.907s) [599.331437] Starting dynamic subtest: late_gt_pm [603.592593] Dynamic subtest late_gt_pm: SUCCESS (4.269s) [603.595367] Subtest live: SUCCESS (245.995s) [603.624350] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [603.625084] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [603.628282] [078/132] (419s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [605.201321] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [605.205461] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [605.296760] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [605.298113] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true [605.301882] [079/132] (418s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [605.410745] Starting subtest: pr-overlay-plane-move-continuous-sf [605.414822] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [605.480426] [080/132] (418s left) kms_psr (psr-primary-blt) [605.569363] Starting subtest: psr-primary-blt [605.571692] Starting dynamic subtest: eDP-1 [607.307581] Dynamic subtest eDP-1: SUCCESS (1.738s) [607.309819] Subtest psr-primary-blt: SUCCESS (1.739s) [608.164247] [081/132] (415s left) gem_ctx_bad_destroy (invalid-pad) [608.210904] Starting subtest: invalid-pad [608.213343] Subtest invalid-pad: SUCCESS (0.000s) [608.284705] [082/132] (415s left) kms_pm_lpsp (kms-lpsp) [609.378447] Starting subtest: kms-lpsp [609.380717] Starting dynamic subtest: pipe-A-eDP-1 [609.524304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s) [609.826358] Subtest kms-lpsp: SUCCESS (0.449s) [610.683203] [083/132] (412s left) gem_barrier_race (remote-request) [610.747631] Starting subtest: remote-request [610.749673] Starting dynamic subtest: rcs0 [615.950994] Dynamic subtest rcs0: SUCCESS (5.205s) [615.953544] Subtest remote-request: SUCCESS (5.207s) [616.072980] [084/132] (407s left) kms_flip (bo-too-big) [616.162827] Starting subtest: bo-too-big [616.164431] Starting dynamic subtest: A-eDP1 [617.444008] Dynamic subtest A-eDP1: SUCCESS (1.280s) [617.454813] Starting dynamic subtest: B-eDP1 [618.766743] Dynamic subtest B-eDP1: SUCCESS (1.322s) [618.778301] Starting dynamic subtest: C-eDP1 [620.119531] Dynamic subtest C-eDP1: SUCCESS (1.349s) [620.133291] Starting dynamic subtest: D-eDP1 [621.458400] Dynamic subtest D-eDP1: SUCCESS (1.338s) [621.460791] Subtest bo-too-big: SUCCESS (5.300s) [622.683579] [085/132] (401s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy) [622.813424] Starting subtest: 2x-flip-vs-cursor-legacy [622.817843] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s) [622.955180] [086/132] (400s left) gem_exec_fence (parallel) [623.134023] Starting subtest: parallel [623.136479] Starting dynamic subtest: rcs0 [625.282705] Dynamic subtest rcs0: SUCCESS (2.149s) [625.291502] Starting dynamic subtest: bcs0 [627.437501] Dynamic subtest bcs0: SUCCESS (2.154s) [627.446605] Starting dynamic subtest: vcs0 [629.589921] Dynamic subtest vcs0: SUCCESS (2.151s) [629.601577] Starting dynamic subtest: vcs1 [631.745080] Dynamic subtest vcs1: SUCCESS (2.154s) [631.754801] Starting dynamic subtest: vecs0 [633.894999] Dynamic subtest vecs0: SUCCESS (2.149s) [633.905741] Starting dynamic subtest: ccs0 [636.046511] Dynamic subtest ccs0: SUCCESS (2.151s) [636.048359] Subtest parallel: SUCCESS (12.914s) [637.394693] [087/132] (386s left) gem_exec_reloc (basic-cpu-gtt) [637.458809] Subtest basic-cpu-gtt: SKIP (0.000s) [637.526723] [088/132] (386s left) gem_exec_schedule (preempt-user) [637.593686] Starting subtest: preempt-user [637.595812] Starting dynamic subtest: rcs0 [637.626757] Dynamic subtest rcs0: SUCCESS (0.039s) [637.637266] Starting dynamic subtest: bcs0 [637.656270] Dynamic subtest bcs0: SUCCESS (0.029s) [637.665774] Starting dynamic subtest: vcs0 [637.680784] Dynamic subtest vcs0: SUCCESS (0.025s) [637.692959] Starting dynamic subtest: vcs1 [637.709495] Dynamic subtest vcs1: SUCCESS (0.028s) [637.719290] Starting dynamic subtest: vecs0 [637.735393] Dynamic subtest vecs0: SUCCESS (0.025s) [637.745682] Starting dynamic subtest: ccs0 [637.773240] Dynamic subtest ccs0: SUCCESS (0.037s) [637.775659] Subtest preempt-user: SUCCESS (0.187s) [639.379886] [089/132] (384s left) gem_set_tiling_vs_blt (untiled-to-tiled) [639.438144] Subtest untiled-to-tiled: SKIP (0.000s) [639.511388] [090/132] (384s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [639.611262] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [644.099039] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.491s) [645.279495] [091/132] (378s left) kms_flip (flip-vs-panning-vs-hang) [645.373131] Starting subtest: flip-vs-panning-vs-hang [645.375248] Starting dynamic subtest: A-eDP1 [696.750593] Dynamic subtest A-eDP1: SUCCESS (51.377s) [696.764233] Starting dynamic subtest: D-eDP1 [736.755292] Dynamic subtest D-eDP1: SUCCESS (40.000s) [736.760975] Subtest flip-vs-panning-vs-hang: SUCCESS (91.385s) [737.951901] [092/132] (286s left) gem_eio (in-flight-internal-1us) [738.164567] Starting subtest: in-flight-internal-1us [739.415367] Subtest in-flight-internal-1us: SUCCESS (1.250s) [739.544705] [093/132] (284s left) kms_addfb_basic (basic) [739.598092] Starting subtest: basic [739.600314] Subtest basic: SUCCESS (0.000s) [739.732449] [094/132] (284s left) kms_psr (fbc-psr2-suspend) [739.834578] Starting subtest: fbc-psr2-suspend [739.837063] Starting dynamic subtest: eDP-1 [739.841655] Dynamic subtest eDP-1: SKIP (0.000s) [739.846220] Subtest fbc-psr2-suspend: SKIP (0.001s) [739.921793] [095/132] (284s left) gem_exec_fence (basic-await) [740.096978] Starting subtest: basic-await [740.099363] Starting dynamic subtest: rcs0 [740.172116] Dynamic subtest rcs0: SUCCESS (0.075s) [740.184528] Starting dynamic subtest: bcs0 [740.247612] Dynamic subtest bcs0: SUCCESS (0.073s) [740.260119] Starting dynamic subtest: vcs0 [740.322132] Dynamic subtest vcs0: SUCCESS (0.073s) [740.334961] Starting dynamic subtest: vcs1 [740.396197] Dynamic subtest vcs1: SUCCESS (0.072s) [740.408878] Starting dynamic subtest: vecs0 [740.469334] Dynamic subtest vecs0: SUCCESS (0.072s) [740.482748] Starting dynamic subtest: ccs0 [740.542356] Dynamic subtest ccs0: SUCCESS (0.071s) [740.545186] Subtest basic-await: SUCCESS (0.446s) [741.408987] [096/132] (282s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [741.501082] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [741.503331] Starting dynamic subtest: pipe-A-eDP-1 [741.525773] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [741.537630] Starting dynamic subtest: pipe-B-eDP-1 [741.559044] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [741.568563] Starting dynamic subtest: pipe-C-eDP-1 [741.590355] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [741.600855] Starting dynamic subtest: pipe-D-eDP-1 [741.623182] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [741.627532] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [743.842690] [097/132] (280s left) kms_setmode (basic-clone-single-crtc) [743.895135] Starting subtest: basic-clone-single-crtc [743.901745] Subtest basic-clone-single-crtc: SKIP (0.000s) [743.989427] [098/132] (280s left) gem_workarounds (suspend-resume-fd) [744.057364] Starting subtest: suspend-resume-fd [760.458058] Subtest suspend-resume-fd: SUCCESS (2.065s) [760.605707] [099/132] (263s left) kms_fb_coherency (memset-crc) [760.718975] Starting subtest: memset-crc [760.721160] Starting dynamic subtest: mmap-offset-wc [761.109892] Dynamic subtest mmap-offset-wc: SUCCESS (0.388s) [761.412255] Starting dynamic subtest: mmap-offset-uc [767.433945] Dynamic subtest mmap-offset-uc: SUCCESS (6.027s) [767.725782] Subtest memset-crc: SUCCESS (6.999s) [768.592605] [100/132] (255s left) prime_vgem (coherency-blt) [768.668707] Starting subtest: coherency-blt [769.796992] Subtest coherency-blt: SUCCESS (1.129s) [769.938050] [101/132] (254s left) kms_atomic_interruptible (legacy-dpms) [770.040204] Starting subtest: legacy-dpms [770.042368] Starting dynamic subtest: pipe-A-eDP-1 [777.426851] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.384s) [777.429119] Subtest legacy-dpms: SUCCESS (7.386s) [778.261598] [102/132] (246s left) kms_cursor_crc (cursor-onscreen-32x32) [778.443044] Starting subtest: cursor-onscreen-32x32 [778.488922] Subtest cursor-onscreen-32x32: SKIP (0.041s) [778.763437] [103/132] (245s left) kms_lease (lease-invalid-connector) [778.855568] Starting subtest: lease-invalid-connector [778.857867] Starting dynamic subtest: pipe-A-eDP-1 [778.860114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [778.870543] Starting dynamic subtest: pipe-B-eDP-1 [778.872759] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [778.882749] Starting dynamic subtest: pipe-C-eDP-1 [778.885090] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [778.894786] Starting dynamic subtest: pipe-D-eDP-1 [778.897066] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [778.899274] Subtest lease-invalid-connector: SUCCESS (0.004s) [778.939072] [104/132] (245s left) i915_pm_rpm (system-suspend-execbuf) [780.766260] Starting subtest: system-suspend-execbuf [839.363306] Subtest system-suspend-execbuf: SUCCESS (43.001s) [839.755816] [105/132] (184s left) kms_addfb_basic (bad-pitch-128) [839.818890] Starting subtest: bad-pitch-128 [839.820879] Subtest bad-pitch-128: SUCCESS (0.000s) [839.952251] [106/132] (184s left) syncobj_timeline (wait-all-for-submit-snapshot) [840.014435] Starting subtest: wait-all-for-submit-snapshot [840.095312] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [840.176073] [107/132] (184s left) syncobj_timeline (32bits-limit) [840.234199] Starting subtest: 32bits-limit [840.236546] Subtest 32bits-limit: SUCCESS (0.001s) [840.355668] [108/132] (184s left) gem_eio (in-flight-contexts-10ms) [840.588009] Starting subtest: in-flight-contexts-10ms [854.297938] Subtest in-flight-contexts-10ms: SUCCESS (13.707s) [854.439360] [109/132] (170s left) api_intel_allocator (reloc-allocator) [854.499857] Starting subtest: reloc-allocator [854.501809] Starting dynamic subtest: basic [854.504113] Dynamic subtest basic: SUCCESS (0.003s) [854.516362] Starting dynamic subtest: parallel-one [854.518376] Dynamic subtest parallel-one: SUCCESS (0.008s) [854.529090] Starting dynamic subtest: print [854.531388] Dynamic subtest print: SUCCESS (0.000s) [854.544156] Starting dynamic subtest: reuse [854.546312] Dynamic subtest reuse: SUCCESS (0.000s) [854.556171] Starting dynamic subtest: fork-reopen-allocator [854.558172] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [854.560092] Subtest reloc-allocator: SUCCESS (0.029s) [854.665395] [110/132] (170s left) kms_psr (psr2-primary-blt) [854.771356] Starting subtest: psr2-primary-blt [854.773535] Starting dynamic subtest: eDP-1 [856.523519] Dynamic subtest eDP-1: SUCCESS (1.749s) [856.526158] Subtest psr2-primary-blt: SUCCESS (1.750s) [857.399477] [111/132] (167s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt) [857.501075] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt [861.690361] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.192s) [862.810628] [112/132] (162s left) kms_frontbuffer_tracking (fbc-suspend) [862.900023] Starting subtest: fbc-suspend [900.937284] Subtest fbc-suspend: SUCCESS (7.466s) [902.148413] [113/132] (122s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [902.206955] Starting subtest: invalid-smem-bo-on-discrete [902.211446] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s) [902.340743] [114/132] (122s left) i915_hangman (gt-error-state-capture) [902.410853] Starting subtest: gt-error-state-capture [902.413192] Starting dynamic subtest: rcs0 [912.756135] Dynamic subtest rcs0: SUCCESS (10.334s) [912.772651] Starting dynamic subtest: bcs0 [924.724249] Dynamic subtest bcs0: SUCCESS (11.958s) [924.738422] Starting dynamic subtest: vcs0 [936.693198] Dynamic subtest vcs0: SUCCESS (11.967s) [936.707296] Starting dynamic subtest: vcs1 [947.700739] Dynamic subtest vcs1: SUCCESS (11.005s) [947.714787] Starting dynamic subtest: vecs0 [958.773855] Dynamic subtest vecs0: SUCCESS (11.068s) [958.787706] Starting dynamic subtest: ccs0 [970.741560] Dynamic subtest ccs0: SUCCESS (11.962s) [970.744610] Subtest gt-error-state-capture: SUCCESS (68.310s) [970.827342] [115/132] ( 54s left) sysfs_defaults (readonly) [970.885611] Starting subtest: readonly [970.887964] Starting dynamic subtest: vecs0 [970.890188] Dynamic subtest vecs0: SUCCESS (0.000s) [970.902517] Starting dynamic subtest: ccs0 [970.904744] Dynamic subtest ccs0: SUCCESS (0.000s) [970.915311] Starting dynamic subtest: vcs0 [970.917517] Dynamic subtest vcs0: SUCCESS (0.000s) [970.927917] Starting dynamic subtest: bcs0 [970.930090] Dynamic subtest bcs0: SUCCESS (0.000s) [970.940727] Starting dynamic subtest: rcs0 [970.942623] Dynamic subtest rcs0: SUCCESS (0.000s) [970.954449] Starting dynamic subtest: vcs1 [970.956695] Dynamic subtest vcs1: SUCCESS (0.000s) [970.958988] Subtest readonly: SUCCESS (0.006s) [971.005653] [116/132] ( 54s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [971.098749] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [971.217088] [117/132] ( 53s left) gem_exec_schedule (pi-common) [971.397798] Starting subtest: pi-common [971.400196] Starting dynamic subtest: rcs0 [971.436463] Dynamic subtest rcs0: SUCCESS (0.042s) [971.452949] Starting dynamic subtest: bcs0 [971.473346] Dynamic subtest bcs0: SUCCESS (0.036s) [971.487912] Starting dynamic subtest: vcs0 [971.505168] Dynamic subtest vcs0: SUCCESS (0.031s) [971.519746] Starting dynamic subtest: vcs1 [971.534320] Dynamic subtest vcs1: SUCCESS (0.028s) [971.548939] Starting dynamic subtest: vecs0 [971.563348] Dynamic subtest vecs0: SUCCESS (0.028s) [971.578467] Starting dynamic subtest: ccs0 [971.591739] Dynamic subtest ccs0: SUCCESS (0.028s) [971.593897] Subtest pi-common: SUCCESS (0.198s) [971.820235] [118/132] ( 53s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [971.915245] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [971.919340] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [972.014435] [119/132] ( 53s left) kms_big_fb (yf-tiled-addfb-size-overflow) [972.104190] Starting subtest: yf-tiled-addfb-size-overflow [972.108528] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [972.201980] [120/132] ( 53s left) kms_color (ctm-signed) [972.296721] Starting subtest: ctm-signed [972.298862] Starting dynamic subtest: pipe-A-eDP-1 [974.429705] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.132s) [974.441039] Starting dynamic subtest: pipe-B-eDP-1 [977.222508] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.793s) [977.236896] Starting dynamic subtest: pipe-C-eDP-1 [979.938969] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.714s) [979.949907] Starting dynamic subtest: pipe-D-eDP-1 [982.596048] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.656s) [982.598358] Subtest ctm-signed: SUCCESS (10.298s) [983.421751] [121/132] ( 41s left) gem_spin_batch (resubmit) [983.500448] Starting subtest: resubmit [983.502768] Starting dynamic subtest: rcs0 [983.507669] Dynamic subtest rcs0: SUCCESS (0.006s) [983.518729] Starting dynamic subtest: bcs0 [983.521080] Dynamic subtest bcs0: SUCCESS (0.002s) [983.532065] Starting dynamic subtest: vcs0 [983.533940] Dynamic subtest vcs0: SUCCESS (0.003s) [983.543752] Starting dynamic subtest: vcs1 [983.545716] Dynamic subtest vcs1: SUCCESS (0.003s) [983.555789] Starting dynamic subtest: vecs0 [983.557856] Dynamic subtest vecs0: SUCCESS (0.003s) [983.567660] Starting dynamic subtest: ccs0 [983.569619] Dynamic subtest ccs0: SUCCESS (0.003s) [983.571543] Subtest resubmit: SUCCESS (0.026s) [983.771130] [122/132] ( 41s left) kms_vblank (wait-forked-hang) [983.871935] Starting subtest: wait-forked-hang [983.873839] Starting dynamic subtest: pipe-A-eDP-1 [1010.574627] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.702s) [1010.590781] Starting dynamic subtest: pipe-D-eDP-1 [1034.574403] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.997s) [1034.576314] Subtest wait-forked-hang: SUCCESS (50.703s) [1035.358415] Overall timeout time exceeded, stopping. [1035.402226] 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_plane results: parsing output: 3/ for test: kms_ccs results: parsing output: 4/ for test: vgem_basic results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_chamelium_hpd results: parsing output: 7/ for test: gem_fence_thrash results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: syncobj_wait results: parsing output: 10/ for test: kms_force_connector_basic results: parsing output: 11/ for test: kms_properties results: parsing output: 12/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 13/ for test: gem_ctx_persistence results: parsing output: 14/ for test: gem_exec_schedule results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_exec_reloc results: parsing output: 17/ for test: kms_force_connector_basic results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: kms_joiner results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: kms_atomic_transition results: parsing output: 22/ for test: gem_wait results: parsing output: 23/ for test: gem_basic results: parsing output: 24/ for test: syncobj_timeline results: parsing output: 25/ for test: kms_flip_scaled_crc results: parsing output: 26/ for test: kms_flip_scaled_crc results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: gem_exec_balancer results: parsing output: 30/ for test: kms_psr2_sf results: parsing output: 31/ for test: prime_vgem results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_pipe_crc_basic results: parsing output: 34/ for test: kms_plane_multiple results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: dmabuf_sync_file results: parsing output: 37/ for test: kms_ccs results: parsing output: 38/ for test: kms_flip results: parsing output: 39/ for test: kms_getfb results: parsing output: 40/ for test: kms_flip results: parsing output: 41/ for test: kms_cursor_crc results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_softpin results: parsing output: 44/ for test: kms_content_protection results: parsing output: 45/ for test: kms_psr results: parsing output: 46/ for test: kms_cursor_edge_walk results: parsing output: 47/ for test: perf_pmu results: parsing output: 48/ for test: gem_exec_parallel results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_mmap_gtt results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_exec_whisper results: parsing output: 53/ for test: gem_render_copy results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: prime_self_import results: parsing output: 57/ for test: gem_close_race results: parsing output: 58/ for test: kms_ccs results: parsing output: 59/ for test: gem_madvise results: parsing output: 60/ for test: api_intel_bb results: parsing output: 61/ for test: gem_media_fill results: parsing output: 62/ for test: kms_plane results: parsing output: 63/ for test: gen9_exec_parse results: parsing output: 64/ for test: kms_chamelium_edid results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: kms_cursor_legacy results: parsing output: 69/ for test: kms_selftest results: parsing output: 70/ for test: kms_chamelium_audio results: parsing output: 71/ for test: gem_render_copy results: parsing output: 72/ for test: gen9_exec_parse results: parsing output: 73/ for test: syncobj_wait results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: gem_exec_async results: parsing output: 76/ for test: i915_selftest results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_psr2_sf results: parsing output: 79/ for test: kms_psr results: parsing output: 80/ for test: gem_ctx_bad_destroy results: parsing output: 81/ for test: kms_pm_lpsp results: parsing output: 82/ for test: gem_barrier_race results: parsing output: 83/ for test: kms_flip results: parsing output: 84/ for test: kms_cursor_legacy results: parsing output: 85/ for test: gem_exec_fence results: parsing output: 86/ for test: gem_exec_reloc results: parsing output: 87/ for test: gem_exec_schedule results: parsing output: 88/ for test: gem_set_tiling_vs_blt results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_flip results: parsing output: 91/ for test: gem_eio results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: kms_psr results: parsing output: 94/ for test: gem_exec_fence results: parsing output: 95/ for test: kms_ccs results: parsing output: 96/ for test: kms_setmode results: parsing output: 97/ for test: gem_workarounds results: parsing output: 98/ for test: kms_fb_coherency results: parsing output: 99/ for test: prime_vgem results: parsing output: 100/ for test: kms_atomic_interruptible results: parsing output: 101/ for test: kms_cursor_crc results: parsing output: 102/ for test: kms_lease results: parsing output: 103/ for test: i915_pm_rpm results: parsing output: 104/ for test: kms_addfb_basic results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: syncobj_timeline results: parsing output: 107/ for test: gem_eio results: parsing output: 108/ for test: api_intel_allocator results: parsing output: 109/ for test: kms_psr results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_addfb_basic results: parsing output: 113/ for test: i915_hangman results: parsing output: 114/ for test: sysfs_defaults results: parsing output: 115/ for test: kms_addfb_basic results: parsing output: 116/ for test: gem_exec_schedule results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: kms_color results: parsing output: 120/ for test: gem_spin_batch results: parsing output: 121/ for test: kms_vblank results: parsing output: 122/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 123/ for test: gem_ctx_param 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: perf_pmu results: no output, setting notrun results: parsing output: 126/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 127/ for test: kms_psr results: no output, setting notrun results: parsing output: 128/ for test: gem_mmap_gtt results: no output, setting notrun results: parsing output: 129/ for test: kms_plane_scaling results: no output, setting notrun results: parsing output: 130/ for test: kms_rotation_crc results: no output, setting notrun results: parsing output: 131/ for test: gem_mmap_wc results: no output, setting notrun Done.