[111.322960] Initializing watchdogs [111.323324] /dev/watchdog0 [111.365818] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [111.380724] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [111.389098] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [111.395228] [001/156] (960s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [111.604062] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [111.617035] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [114.467193] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (2.850s) [114.489314] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [116.671532] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (2.202s) [116.693762] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [118.785164] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (2.105s) [118.789040] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (7.174s) [119.164535] [002/156] (952s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-render) [119.376667] Starting subtest: hdr-rgb101010-draw-render [119.379249] Subtest hdr-rgb101010-draw-render: SKIP (0.000s) [119.519357] [003/156] (952s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render) [119.727340] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render [119.730588] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [119.868272] [004/156] (952s left) gem_exec_whisper (basic-queues-all) [120.017813] Starting subtest: basic-queues-all [128.264312] Subtest basic-queues-all: SUCCESS (8.247s) [128.525255] [005/156] (943s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [128.735226] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [128.738340] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [128.873448] [006/156] (943s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [129.068850] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-wc [129.073108] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [129.206750] [007/156] (943s left) prime_vgem (fence-flip-hang) [129.432075] Subtest fence-flip-hang: SKIP (0.000s) [129.607714] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true [129.613781] [008/156] (942s left) gem_mmap_offset (bad-extensions) [129.718329] Starting subtest: bad-extensions [129.720202] Subtest bad-extensions: SUCCESS (0.000s) [129.867786] [009/156] (942s left) kms_content_protection (mei-interface) [130.082468] Starting subtest: mei-interface [130.114760] Subtest mei-interface: SKIP (0.023s) [130.269488] [010/156] (942s left) kms_getfb (getfb2-into-addfb2) [130.459413] Starting subtest: getfb2-into-addfb2 [130.461466] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [130.617788] [011/156] (942s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [130.826378] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu [130.830175] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [131.056893] [012/156] (941s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [131.253937] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [131.258842] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [131.400247] [013/156] (941s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [131.588090] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [131.590636] Starting dynamic subtest: pipe-A-HDMI-A-1 [131.693470] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s) [131.737582] Starting dynamic subtest: pipe-A-HDMI-A-2 [131.839936] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.011s) [131.862223] Starting dynamic subtest: pipe-B-HDMI-A-1 [131.911416] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.011s) [131.931960] Starting dynamic subtest: pipe-B-HDMI-A-2 [131.980605] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.011s) [132.001239] Starting dynamic subtest: pipe-C-HDMI-A-1 [132.052238] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.011s) [132.072786] Starting dynamic subtest: pipe-C-HDMI-A-2 [132.121771] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.011s) [132.125049] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.082s) [132.788235] [014/156] (940s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [133.003182] Starting subtest: fbcpsr-shrfb-scaledprimary [133.006928] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s) [133.157714] [015/156] (940s left) kms_plane (pixel-format-linear-modifier) [133.335167] Starting subtest: pixel-format-linear-modifier [133.559399] Starting dynamic subtest: pipe-A-plane-0 [134.127153] Dynamic subtest pipe-A-plane-0: SUCCESS (0.569s) [134.149506] Starting dynamic subtest: pipe-A-plane-1 [134.694517] Dynamic subtest pipe-A-plane-1: SUCCESS (0.564s) [134.715405] Starting dynamic subtest: pipe-A-plane-2 [135.241381] Dynamic subtest pipe-A-plane-2: SUCCESS (0.548s) [135.263560] Starting dynamic subtest: pipe-A-plane-3 [135.793227] Dynamic subtest pipe-A-plane-3: SUCCESS (0.549s) [135.814459] Starting dynamic subtest: pipe-A-plane-4 [136.008350] Dynamic subtest pipe-A-plane-4: SUCCESS (0.216s) [136.437935] Starting dynamic subtest: pipe-B-plane-0 [136.967267] Dynamic subtest pipe-B-plane-0: SUCCESS (0.550s) [136.989064] Starting dynamic subtest: pipe-B-plane-1 [137.552179] Dynamic subtest pipe-B-plane-1: SUCCESS (0.581s) [137.573374] Starting dynamic subtest: pipe-B-plane-2 [138.102326] Dynamic subtest pipe-B-plane-2: SUCCESS (0.549s) [138.123488] Starting dynamic subtest: pipe-B-plane-3 [138.668763] Dynamic subtest pipe-B-plane-3: SUCCESS (0.566s) [138.689963] Starting dynamic subtest: pipe-B-plane-4 [138.884327] Dynamic subtest pipe-B-plane-4: SUCCESS (0.216s) [139.105623] Subtest pixel-format-linear-modifier: SUCCESS (5.765s) [139.446808] [016/156] (933s left) gem_fence_thrash (bo-write-verify-x) [139.547195] Starting subtest: bo-write-verify-x [140.850598] Subtest bo-write-verify-x: SUCCESS (1.302s) [141.016894] [017/156] (932s left) kms_psr (pr-cursor-mmap-cpu) [141.201653] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [141.320129] [018/156] (932s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [141.512031] Starting subtest: plane-upscale-20x20-with-pixel-format [141.516087] Starting dynamic subtest: pipe-A [142.582297] Dynamic subtest pipe-A: SUCCESS (1.072s) [142.627263] Starting dynamic subtest: pipe-B [143.729240] Dynamic subtest pipe-B: SUCCESS (1.146s) [143.755693] Starting dynamic subtest: pipe-C [144.191311] Dynamic subtest pipe-C: SUCCESS (0.460s) [144.193362] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (2.682s) [144.750228] [019/156] (928s left) perf_pmu (rc6) [144.867779] Starting subtest: rc6 [144.869227] Starting dynamic subtest: gt0 [151.224266] Dynamic subtest gt0: SUCCESS (6.349s) [151.259093] Starting dynamic subtest: runtime-pm-gt0 [159.085336] Dynamic subtest runtime-pm-gt0: SUCCESS (7.863s) [159.109489] Starting dynamic subtest: runtime-pm-long-gt0 [171.531853] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.447s) [171.581606] Starting dynamic subtest: other-idle-gt0 [171.590061] Dynamic subtest other-idle-gt0: SKIP (0.000s) [171.594072] Subtest rc6: SUCCESS (26.665s) [172.279442] [020/156] (901s left) syncobj_wait (wait-for-submit-complex) [172.393071] Starting subtest: wait-for-submit-complex [172.462606] Subtest wait-for-submit-complex: SUCCESS (0.069s) [172.580053] [021/156] (901s left) i915_module_load (resize-bar) [172.678629] Starting subtest: resize-bar [172.695466] Subtest resize-bar: SKIP (0.016s) [172.804475] [022/156] (901s left) kms_plane_cursor (overlay) [172.994313] Starting subtest: overlay [173.000040] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64 [175.732912] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.737s) [175.826411] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128 [178.382569] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.582s) [178.477525] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256 [181.013908] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.565s) [181.320228] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64 [184.032687] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.742s) [184.106066] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128 [186.699499] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.615s) [186.771141] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256 [189.382802] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.632s) [189.661055] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64 [192.288332] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.673s) [192.360534] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128 [194.889088] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.549s) [194.959812] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256 [197.505212] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.566s) [197.760679] Subtest overlay: SUCCESS (24.773s) [198.068145] [023/156] (875s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [198.298135] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [198.301916] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [198.420696] [024/156] (875s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [198.607113] Starting subtest: modeset-transition-nonblocking-fencing [198.609109] Starting dynamic subtest: 1x-outputs [202.287219] Dynamic subtest 1x-outputs: SUCCESS (3.685s) [202.311862] Starting dynamic subtest: 2x-outputs [209.982911] Dynamic subtest 2x-outputs: SUCCESS (7.693s) [209.984486] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.384s) [210.365555] [025/156] (863s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render) [210.578232] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render [210.581472] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [210.709688] [026/156] (863s left) sw_sync (sync_busy_fork) [210.812071] Starting subtest: sync_busy_fork [211.846149] Subtest sync_busy_fork: SUCCESS (1.030s) [211.938929] [027/156] (862s left) gem_exec_balancer (nohangcheck) [212.196135] Starting subtest: nohangcheck [216.515154] Subtest nohangcheck: SUCCESS (4.316s) [216.626175] [028/156] (857s left) gem_mmap (bad-offset) [216.727146] Starting subtest: bad-offset [216.728821] Subtest bad-offset: SUCCESS (0.001s) [216.837553] [029/156] (857s left) dumb_buffer (map-valid) [216.942431] Starting subtest: map-valid [216.945190] Subtest map-valid: SUCCESS (0.001s) [217.054399] [030/156] (857s left) gem_workarounds (reset) [217.193019] Starting subtest: reset [217.227783] Subtest reset: SUCCESS (0.032s) [217.356149] [031/156] (857s left) kms_scaling_modes (scaling-mode-full-aspect) [217.548286] Starting subtest: scaling-mode-full-aspect [217.560480] Subtest scaling-mode-full-aspect: SKIP (0.003s) [217.671202] [032/156] (857s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [217.890308] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [220.511430] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SUCCESS (2.617s) [220.673692] [033/156] (854s left) gem_exec_fence (submit-chain) [220.950308] Starting subtest: submit-chain [220.974622] Subtest submit-chain: SUCCESS (0.033s) [221.670158] [034/156] (853s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt) [221.869677] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt [221.873137] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [221.991439] [035/156] (853s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [222.190869] Starting subtest: cursorA-vs-flipB-atomic [233.513093] Subtest cursorA-vs-flipB-atomic: SUCCESS (11.319s) [233.827077] [036/156] (841s left) kms_dp_link_training (uhbr-mst) [234.025864] Starting subtest: uhbr-mst [234.028330] Subtest uhbr-mst: SKIP (0.000s) [234.150329] [037/156] (841s left) gem_lmem_swapping (massive-random) [234.269859] Subtest massive-random: SKIP (0.000s) [234.372580] [038/156] (841s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [234.572087] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [234.577259] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [234.689347] [039/156] (840s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [234.880139] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [234.882686] Starting dynamic subtest: pipe-A-valid-mode [236.007123] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.120s) [236.009319] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (1.127s) [236.399946] [040/156] (839s left) kms_flip (flip-vs-modeset-vs-hang) [236.600071] Starting subtest: flip-vs-modeset-vs-hang [236.602245] Starting dynamic subtest: A-HDMI-A1 [250.670509] Dynamic subtest A-HDMI-A1: SUCCESS (14.066s) [250.695849] Starting dynamic subtest: C-HDMI-A1 [264.622944] Dynamic subtest C-HDMI-A1: SUCCESS (13.946s) [264.647162] Starting dynamic subtest: A-HDMI-A2 [278.636737] Dynamic subtest A-HDMI-A2: SUCCESS (14.008s) [278.663075] Starting dynamic subtest: C-HDMI-A2 [292.653503] Dynamic subtest C-HDMI-A2: SUCCESS (14.010s) [292.655195] Subtest flip-vs-modeset-vs-hang: SUCCESS (56.057s) [292.981166] [041/156] (782s left) gem_exec_fence (syncobj-wait) [293.550822] Starting subtest: syncobj-wait [293.589784] Subtest syncobj-wait: SUCCESS (0.040s) [293.951838] [042/156] (781s left) syncobj_timeline (etime-multi-wait-all-submitted) [294.061946] Starting subtest: etime-multi-wait-all-submitted [294.168935] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s) [294.287742] [043/156] (781s left) kms_big_fb (linear-16bpp-rotate-90) [294.496293] Starting subtest: linear-16bpp-rotate-90 [294.868312] Subtest linear-16bpp-rotate-90: SKIP (0.367s) [295.128550] [044/156] (780s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [295.332214] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [295.335150] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [296.069196] [045/156] (780s left) i915_suspend (fence-restore-tiled2untiled) [296.178684] Starting subtest: fence-restore-tiled2untiled [315.701584] Subtest fence-restore-tiled2untiled: SUCCESS (4.207s) [325.834333] [046/156] (760s left) gem_exec_reloc (basic-gtt-wc) [325.958678] Starting subtest: basic-gtt-wc [325.978401] Subtest basic-gtt-wc: SUCCESS (0.019s) [326.186218] [047/156] (760s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [326.402887] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [328.812691] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (2.408s) [329.092583] [048/156] (757s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc) [329.312737] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc [329.316744] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [329.437478] [049/156] (757s left) kms_force_connector_basic (prune-stale-modes) [329.737882] Starting subtest: prune-stale-modes [329.913483] Subtest prune-stale-modes: SUCCESS (0.178s) [330.268492] [050/156] (756s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite) [330.500570] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite [330.505065] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [330.634660] [051/156] (756s left) i915_drm_fdinfo (context-close-stress) [330.761200] Starting subtest: context-close-stress [341.524323] Subtest context-close-stress: SUCCESS (10.760s) [341.638933] [052/156] (745s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt) [341.859241] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt [341.864798] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [341.988356] [053/156] (745s left) gem_ringfill (engines-basic) [342.376197] Starting subtest: engines-basic [342.380846] Starting dynamic subtest: rcs0 [342.397557] Dynamic subtest rcs0: SUCCESS (0.022s) [342.433007] Starting dynamic subtest: bcs0 [342.434240] Dynamic subtest bcs0: SUCCESS (0.027s) [342.467091] Starting dynamic subtest: vcs0 [342.468185] Dynamic subtest vcs0: SUCCESS (0.020s) [342.495161] Starting dynamic subtest: vecs0 [342.496437] Dynamic subtest vecs0: SUCCESS (0.018s) [342.497530] Subtest engines-basic: SUCCESS (0.110s) [342.620966] [054/156] (744s left) prime_busy (hang) [342.735497] Starting subtest: hang [342.737313] Starting dynamic subtest: rcs0 [349.955887] Dynamic subtest rcs0: SUCCESS (7.214s) [349.987945] Starting dynamic subtest: bcs0 [356.995796] Dynamic subtest bcs0: SUCCESS (7.033s) [357.024488] Starting dynamic subtest: vcs0 [363.969290] Dynamic subtest vcs0: SUCCESS (6.973s) [363.995598] Starting dynamic subtest: vecs0 [370.945110] Dynamic subtest vecs0: SUCCESS (6.975s) [370.946795] Subtest hang: SUCCESS (28.211s) [371.067874] [055/156] (716s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [371.289159] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [373.112476] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.828s) [373.384484] [056/156] (713s left) gem_exec_reloc (basic-write-read-noreloc) [373.505056] Starting subtest: basic-write-read-noreloc [373.512763] Subtest basic-write-read-noreloc: SUCCESS (0.007s) [373.733303] [057/156] (713s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt) [373.936047] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt [373.939889] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s) [374.077775] [058/156] (713s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [374.274254] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [374.284954] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [375.103650] [059/156] (712s left) sysfs_heartbeat_interval (precise) [375.222429] Starting subtest: precise [375.225532] Starting dynamic subtest: vecs0 [376.692015] Dynamic subtest vecs0: SUCCESS (1.467s) [376.730153] Starting dynamic subtest: vcs0 [378.146366] Dynamic subtest vcs0: SUCCESS (1.451s) [378.181366] Starting dynamic subtest: bcs0 [379.621401] Dynamic subtest bcs0: SUCCESS (1.470s) [379.658133] Starting dynamic subtest: rcs0 [381.073546] Dynamic subtest rcs0: SUCCESS (1.446s) [381.075660] Subtest precise: SUCCESS (5.854s) [381.194835] [060/156] (706s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff) [381.414016] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff [381.419798] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [381.547514] [061/156] (706s left) kms_plane (plane-position-covered) [381.746079] Starting subtest: plane-position-covered [382.497101] Starting dynamic subtest: pipe-A-plane-1 [383.100930] Dynamic subtest pipe-A-plane-1: SUCCESS (0.603s) [383.155364] Starting dynamic subtest: pipe-A-plane-2 [383.656942] Dynamic subtest pipe-A-plane-2: SUCCESS (0.554s) [383.723675] Starting dynamic subtest: pipe-A-plane-3 [384.208216] Dynamic subtest pipe-A-plane-3: SUCCESS (0.548s) [384.241048] Starting dynamic subtest: pipe-A-plane-4 [384.245234] Dynamic subtest pipe-A-plane-4: SUCCESS (0.008s) [384.822336] Starting dynamic subtest: pipe-B-plane-1 [385.277950] Dynamic subtest pipe-B-plane-1: SUCCESS (0.510s) [385.333335] Starting dynamic subtest: pipe-B-plane-2 [385.788787] Dynamic subtest pipe-B-plane-2: SUCCESS (0.500s) [385.844048] Starting dynamic subtest: pipe-B-plane-3 [386.320764] Dynamic subtest pipe-B-plane-3: SUCCESS (0.531s) [386.351985] Starting dynamic subtest: pipe-B-plane-4 [386.360818] Dynamic subtest pipe-B-plane-4: SUCCESS (0.010s) [386.366586] Subtest plane-position-covered: SUCCESS (4.595s) [386.693288] [062/156] (701s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [386.912815] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu [386.916203] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [387.037849] [063/156] (701s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-fullscreen) [387.255217] Starting subtest: psrhdr-1p-primscrn-spr-indfb-fullscreen [387.258321] Subtest psrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [387.386892] [064/156] (700s left) kms_chamelium_frames (hdmi-aspect-ratio) [388.013261] Subtest hdmi-aspect-ratio: SKIP (0.000s) [388.345111] [065/156] (699s left) kms_color (ctm-0-50) [388.536614] Starting subtest: ctm-0-50 [388.538842] Starting dynamic subtest: pipe-A-HDMI-A-1 [390.117983] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.578s) [390.180947] Starting dynamic subtest: pipe-A-HDMI-A-2 [391.420576] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.294s) [391.478149] Starting dynamic subtest: pipe-B-HDMI-A-1 [392.767132] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.343s) [392.823964] Starting dynamic subtest: pipe-B-HDMI-A-2 [394.067893] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.299s) [394.119335] Starting dynamic subtest: pipe-C-HDMI-A-1 [395.376673] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.305s) [395.408986] Starting dynamic subtest: pipe-C-HDMI-A-2 [396.696529] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.311s) [396.704375] Subtest ctm-0-50: SUCCESS (8.167s) [397.009333] [066/156] (691s left) kms_feature_discovery (dp-mst) [397.217379] Starting subtest: dp-mst [397.220935] Subtest dp-mst: SKIP (0.001s) [397.337330] [067/156] (691s left) kms_cursor_crc (cursor-onscreen-512x170) [397.555248] Starting subtest: cursor-onscreen-512x170 [397.566051] Subtest cursor-onscreen-512x170: SKIP (0.005s) [397.698230] [068/156] (690s left) kms_addfb_basic (unused-offsets) [397.810094] Starting subtest: unused-offsets [397.812845] Subtest unused-offsets: SUCCESS (0.000s) [398.021375] [069/156] (690s left) dmabuf_sync_file (import-basic) [398.133835] Starting subtest: import-basic [398.141728] Subtest import-basic: SUCCESS (0.009s) [398.246638] [070/156] (690s left) gem_userptr_blits (sync-overlap) [398.390846] Starting subtest: sync-overlap [398.392897] Subtest sync-overlap: SUCCESS (0.001s) [398.547648] [071/156] (690s left) gem_ctx_persistence (engines-mixed) [398.664189] Starting subtest: engines-mixed [398.665814] Starting dynamic subtest: rcs0 [398.714452] Dynamic subtest rcs0: SUCCESS (0.049s) [398.755065] Starting dynamic subtest: bcs0 [398.756155] Dynamic subtest bcs0: SUCCESS (0.038s) [398.796054] Starting dynamic subtest: vcs0 [398.797308] Dynamic subtest vcs0: SUCCESS (0.037s) [398.829308] Starting dynamic subtest: vecs0 [398.850359] Dynamic subtest vecs0: SUCCESS (0.047s) [398.857061] Subtest engines-mixed: SUCCESS (0.191s) [399.001411] [072/156] (689s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe) [399.552901] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s) [399.901801] [073/156] (689s left) gem_exec_params (invalid-bsd2-flag-on-blt) [400.024681] Starting subtest: invalid-bsd2-flag-on-blt [400.027147] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.001s) [400.149973] [074/156] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [400.346123] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [400.349037] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [400.518395] [075/156] (688s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-pri-indfb-multidraw) [400.779814] Starting subtest: fbcpsrhdr-2p-pri-indfb-multidraw [400.785864] Subtest fbcpsrhdr-2p-pri-indfb-multidraw: SKIP (0.000s) [400.902258] [076/156] (688s left) kms_addfb_basic (bad-pitch-128) [401.010790] Starting subtest: bad-pitch-128 [401.011967] Subtest bad-pitch-128: SUCCESS (0.000s) [401.220347] [077/156] (688s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-pwrite) [401.439987] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-pwrite [401.444683] Subtest psrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [401.574140] [078/156] (688s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [401.779045] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [401.782696] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [401.903351] [079/156] (687s left) api_intel_allocator (two-level-inception-interruptible) [402.013873] Starting subtest: two-level-inception-interruptible [407.570244] Subtest two-level-inception-interruptible: SUCCESS (5.559s) [407.690557] [080/156] (682s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [407.904046] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [409.629560] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.725s) [409.912574] [081/156] (680s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render) [410.131989] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render [410.136188] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [410.256894] [082/156] (679s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [410.472674] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [411.983130] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.507s) [412.284527] [083/156] (677s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [412.475962] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [412.595232] [084/156] (677s left) kms_lease (lease-unleased-connector) [412.797786] Starting subtest: lease-unleased-connector [412.801077] Starting dynamic subtest: pipe-A-HDMI-A-1 [412.877393] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.076s) [412.942807] Starting dynamic subtest: pipe-A-HDMI-A-2 [412.970829] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.077s) [413.035820] Starting dynamic subtest: pipe-B-HDMI-A-1 [413.037803] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.066s) [413.128833] Starting dynamic subtest: pipe-B-HDMI-A-2 [413.130819] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.064s) [413.190879] Starting dynamic subtest: pipe-C-HDMI-A-1 [413.195815] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.064s) [413.251792] Starting dynamic subtest: pipe-C-HDMI-A-2 [413.256332] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.065s) [413.258801] Subtest lease-unleased-connector: SUCCESS (0.460s) [413.377942] [085/156] (677s left) gem_exec_reloc (basic-gtt-cpu) [413.515120] Starting subtest: basic-gtt-cpu [413.528567] Subtest basic-gtt-cpu: SUCCESS (0.017s) [413.740793] [086/156] (676s left) kms_invalid_mode (bad-htotal) [413.926911] Starting subtest: bad-htotal [413.938242] Starting dynamic subtest: pipe-A-HDMI-A-1 [414.371069] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.439s) [414.440386] Starting dynamic subtest: pipe-A-HDMI-A-2 [414.442126] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.004s) [414.496261] Starting dynamic subtest: pipe-B-HDMI-A-1 [414.500209] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s) [414.554353] Starting dynamic subtest: pipe-B-HDMI-A-2 [414.556844] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s) [414.585059] Starting dynamic subtest: pipe-C-HDMI-A-1 [414.586265] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s) [414.614349] Starting dynamic subtest: pipe-C-HDMI-A-2 [414.615538] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s) [414.616756] Subtest bad-htotal: SUCCESS (0.498s) [414.769268] [087/156] (675s left) gem_exec_schedule (noreorder) [415.049349] Starting subtest: noreorder [415.055864] Starting dynamic subtest: rcs0 [415.101821] Dynamic subtest rcs0: SUCCESS (0.047s) [415.159920] Starting dynamic subtest: bcs0 [415.167253] Dynamic subtest bcs0: SUCCESS (0.058s) [415.218991] Starting dynamic subtest: vcs0 [415.225767] Dynamic subtest vcs0: SUCCESS (0.058s) [415.281303] Starting dynamic subtest: vecs0 [415.288081] Dynamic subtest vecs0: SUCCESS (0.056s) [415.289296] Subtest noreorder: SUCCESS (0.239s) [415.533361] [088/156] (675s left) gem_mmap_wc (write) [415.633667] Starting subtest: write [415.751650] Subtest write: SUCCESS (0.117s) [415.874228] [089/156] (674s left) gem_exec_reloc (basic-cpu-read-active) [415.994426] Starting subtest: basic-cpu-read-active [416.133945] Subtest basic-cpu-read-active: SUCCESS (0.138s) [416.353498] [090/156] (674s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt) [416.563286] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt [416.566933] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [416.690344] [091/156] (674s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [416.902826] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [418.183552] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.279s) [418.531933] [092/156] (672s left) kms_big_fb (4-tiled-16bpp-rotate-90) [418.752843] Starting subtest: 4-tiled-16bpp-rotate-90 [418.756039] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s) [418.875322] [093/156] (672s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render) [419.074761] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render [419.078379] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [419.212343] [094/156] (672s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-cpu) [419.435922] Starting subtest: psrhdr-rgb101010-draw-mmap-cpu [419.439784] Subtest psrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [419.562470] [095/156] (671s left) api_intel_bb (object-noreloc-keep-cache-simple) [419.666780] Starting subtest: object-noreloc-keep-cache-simple [419.674220] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.008s) [419.805238] [096/156] (671s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [420.019781] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [422.167475] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SUCCESS (2.147s) [422.359632] [097/156] (669s left) i915_query (query-topology-known-pci-ids) [422.472808] Starting subtest: query-topology-known-pci-ids [422.476810] Subtest query-topology-known-pci-ids: SKIP (0.000s) [422.590674] [098/156] (669s left) gem_pxp (hw-rejects-pxp-context) [425.235953] Starting subtest: hw-rejects-pxp-context [425.238457] Subtest hw-rejects-pxp-context: SUCCESS (0.001s) [425.371575] [099/156] (666s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [425.557081] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [425.694359] [100/156] (666s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [425.894980] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [425.897797] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s) [426.027197] [101/156] (666s left) gem_exec_alignment (forked) [426.154146] Starting subtest: forked [473.950612] Subtest forked: SUCCESS (47.793s) [474.082376] [102/156] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [474.462811] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [474.467809] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [474.591993] [103/156] (617s left) gem_ctx_engines (invalid-engines) [474.730454] Starting subtest: invalid-engines [474.743901] Subtest invalid-engines: SUCCESS (0.016s) [474.973235] [104/156] (617s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [475.175862] Starting subtest: cursorB-vs-flipA-varying-size [486.495803] Subtest cursorB-vs-flipA-varying-size: SUCCESS (11.316s) [486.851611] [105/156] (605s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [487.043391] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [487.045508] Starting dynamic subtest: pipe-A-HDMI-A-1 [487.069023] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [487.137022] Starting dynamic subtest: pipe-A-HDMI-A-2 [487.173861] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [487.207969] Starting dynamic subtest: pipe-B-HDMI-A-1 [487.220965] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [487.249675] Starting dynamic subtest: pipe-B-HDMI-A-2 [487.262686] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [487.291361] Starting dynamic subtest: pipe-C-HDMI-A-1 [487.303767] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [487.332265] Starting dynamic subtest: pipe-C-HDMI-A-2 [487.344268] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [487.346787] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.035s) [488.164218] [106/156] (604s left) kms_pm_rpm (basic-pci-d3-state) [490.093294] Starting subtest: basic-pci-d3-state [490.694584] Subtest basic-pci-d3-state: SUCCESS (0.589s) [491.039482] [107/156] (601s left) perf_pmu (busy-check-all) [491.159511] Starting subtest: busy-check-all [491.161542] Starting dynamic subtest: rcs0 [491.692653] Dynamic subtest rcs0: SUCCESS (0.530s) [491.722874] Starting dynamic subtest: bcs0 [492.224746] Dynamic subtest bcs0: SUCCESS (0.533s) [492.263527] Starting dynamic subtest: vcs0 [492.767598] Dynamic subtest vcs0: SUCCESS (0.539s) [492.805536] Starting dynamic subtest: vecs0 [493.303736] Dynamic subtest vecs0: SUCCESS (0.529s) [493.306455] Subtest busy-check-all: SUCCESS (2.150s) [493.441079] [108/156] (599s left) gem_sync (basic-store-all) [493.577190] Starting subtest: basic-store-all [495.988930] Subtest basic-store-all: SUCCESS (2.413s) [496.227482] [109/156] (596s left) gem_ctx_param (set-priority-invalid-size) [496.337114] Starting subtest: set-priority-invalid-size [496.338732] Subtest set-priority-invalid-size: SUCCESS (0.000s) [496.461835] [110/156] (596s left) kms_psr (psr-cursor-blt) [496.660084] Subtest psr-cursor-blt: SKIP (0.000s) [496.786676] [111/156] (596s left) gem_exec_reloc (basic-write-read-active) [496.906667] Starting subtest: basic-write-read-active [497.046579] Subtest basic-write-read-active: SUCCESS (0.137s) [497.264529] [112/156] (595s left) kms_chamelium_color (ctm-max) [497.451010] Subtest ctm-max: SKIP (0.000s) [497.569121] [113/156] (595s left) syncobj_wait (signal) [497.694960] Starting subtest: signal [497.699241] Subtest signal: SUCCESS (0.000s) [497.810970] [114/156] (595s left) kms_vblank (ts-continuation-modeset-rpm) [497.998888] Starting subtest: ts-continuation-modeset-rpm [498.000331] Starting dynamic subtest: pipe-A-HDMI-A-1 [500.371811] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.372s) [500.437835] Starting dynamic subtest: pipe-A-HDMI-A-2 [501.531482] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.154s) [501.575921] Starting dynamic subtest: pipe-C-HDMI-A-1 [502.770535] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.223s) [502.843190] Starting dynamic subtest: pipe-C-HDMI-A-2 [503.979925] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.193s) [503.983815] Subtest ts-continuation-modeset-rpm: SUCCESS (5.980s) [504.283206] [115/156] (589s left) gen9_exec_parse (secure-batches) [504.419100] Starting subtest: secure-batches [504.420290] Subtest secure-batches: SUCCESS (0.000s) [504.660830] [116/156] (589s left) gem_userptr_blits (mmap-offset-banned) [504.800926] Starting subtest: mmap-offset-banned [504.808674] Starting dynamic subtest: gtt [504.810906] Dynamic subtest gtt: SUCCESS (0.001s) [504.853743] Starting dynamic subtest: wb [504.855307] Dynamic subtest wb: SUCCESS (0.001s) [504.885453] Starting dynamic subtest: wc [504.887191] Dynamic subtest wc: SUCCESS (0.001s) [504.915502] Starting dynamic subtest: uc [504.917524] Dynamic subtest uc: SUCCESS (0.001s) [504.919690] Subtest mmap-offset-banned: SUCCESS (0.021s) [505.015697] [117/156] (588s left) kms_async_flips (alternate-sync-async-flip) [505.209566] Starting subtest: alternate-sync-async-flip [505.846068] Starting dynamic subtest: pipe-A-HDMI-A-1 [508.054832] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.207s) [508.424294] Starting dynamic subtest: pipe-A-HDMI-A-2 [510.623200] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.225s) [510.995402] Starting dynamic subtest: pipe-B-HDMI-A-1 [513.175692] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.211s) [513.525529] Starting dynamic subtest: pipe-B-HDMI-A-2 [515.676540] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.182s) [516.034104] Starting dynamic subtest: pipe-C-HDMI-A-1 [518.185234] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.183s) [518.565629] Starting dynamic subtest: pipe-C-HDMI-A-2 [520.774945] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.247s) [520.776407] Subtest alternate-sync-async-flip: SUCCESS (15.565s) [521.435650] [118/156] (572s left) gem_exec_fence (expired-history) [521.979032] Starting subtest: expired-history [527.779536] Subtest expired-history: SUCCESS (5.761s) [528.306305] [119/156] (565s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [528.418460] Starting subtest: multi-wait-for-submit-available-submitted [528.420043] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.002s) [528.542149] [120/156] (565s left) kms_pm_rpm (package-g7) [530.465109] Starting subtest: package-g7 [530.469056] Subtest package-g7: SKIP (0.000s) [530.870659] [121/156] (563s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [530.995823] Starting subtest: writes-after-reads-snoop [552.058336] Subtest writes-after-reads-snoop: SUCCESS (21.064s) [552.191188] [122/156] (542s left) kms_flip (2x-wf_vblank-ts-check) [552.384737] Starting subtest: 2x-wf_vblank-ts-check [552.390345] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [563.692076] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.302s) [563.729512] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [574.887325] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.188s) [574.921611] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [586.094391] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (11.200s) [586.103860] Subtest 2x-wf_vblank-ts-check: SUCCESS (33.719s) [586.808659] [123/156] (507s left) syncobj_timeline (single-wait-for-submit-available-submitted) [586.916522] Starting subtest: single-wait-for-submit-available-submitted [586.919342] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s) [587.047479] [124/156] (507s left) gem_softpin (evict-snoop) [587.169019] Starting subtest: evict-snoop [587.172843] Subtest evict-snoop: SKIP (0.000s) [587.294823] [125/156] (507s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [587.508853] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [587.511480] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [587.651052] [126/156] (507s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [587.833387] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [589.196781] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.359s) [589.513283] [127/156] (505s left) gem_pwrite (basic-exhaustion) [589.626156] Starting subtest: basic-exhaustion [615.797876] Subtest basic-exhaustion: SUCCESS (26.167s) [615.919803] [128/156] (479s left) kms_selftest (drm_plane_helper) [616.045125] Starting subtest: drm_plane_helper [616.067503] Starting dynamic subtest: drm_test_check_plane_state [616.143009] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.072s) [616.174915] Starting dynamic subtest: drm_test_check_invalid_plane_state [616.184502] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.038s) [616.189088] Subtest drm_plane_helper: SUCCESS (0.143s) [616.350828] [129/156] (478s left) kms_big_fb (y-tiled-64bpp-rotate-270) [616.563124] Starting subtest: y-tiled-64bpp-rotate-270 [616.911585] Subtest y-tiled-64bpp-rotate-270: SKIP (0.345s) [617.195819] [130/156] (477s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [617.406044] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [617.410150] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [617.539525] [131/156] (477s left) kms_cursor_legacy (forked-bo) [617.737142] Starting subtest: forked-bo [617.739878] Starting dynamic subtest: pipe-A [623.247342] Dynamic subtest pipe-A: SUCCESS (5.507s) [623.307897] Starting dynamic subtest: pipe-B [628.676680] Dynamic subtest pipe-B: SUCCESS (5.422s) [628.712372] Starting dynamic subtest: pipe-C [634.107923] Dynamic subtest pipe-C: SUCCESS (5.425s) [634.140868] Starting dynamic subtest: all-pipes [639.539825] Dynamic subtest all-pipes: SUCCESS (5.429s) [639.541188] Subtest forked-bo: SUCCESS (21.800s) [639.674792] [132/156] (455s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt) [639.885680] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt [639.890593] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [640.022805] [133/156] (455s left) gem_exec_schedule (semaphore-user) [640.176877] Starting subtest: semaphore-user [640.189985] Subtest semaphore-user: SUCCESS (0.017s) [640.578520] [134/156] (455s left) gem_fence_thrash (bo-write-verify-threaded-none) [640.675986] Starting subtest: bo-write-verify-threaded-none [645.818052] Subtest bo-write-verify-threaded-none: SUCCESS (5.140s) [645.947524] [135/156] (449s left) syncobj_timeline (invalid-wait-illegal-handle) [646.057449] Starting subtest: invalid-wait-illegal-handle [646.059157] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [646.182435] [136/156] (449s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [646.380031] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [646.385926] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [646.517066] [137/156] (449s left) kms_cursor_crc (cursor-rapid-movement-256x85) [646.740790] Starting subtest: cursor-rapid-movement-256x85 [646.826515] Starting dynamic subtest: pipe-A-HDMI-A-1 [647.746052] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.914s) [647.850169] Starting dynamic subtest: pipe-C-HDMI-A-1 [648.444166] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.625s) [648.445740] Subtest cursor-rapid-movement-256x85: SUCCESS (1.704s) [648.861123] [138/156] (447s left) gem_exec_flush (basic-wb-rw-before-default) [649.070777] Starting subtest: basic-wb-rw-before-default [654.499055] Subtest basic-wb-rw-before-default: SUCCESS (5.426s) [654.744172] [139/156] (441s left) gem_partial_pwrite_pread (write-snoop) [654.872122] Starting subtest: write-snoop [668.906039] Subtest write-snoop: SUCCESS (14.038s) [669.042976] [140/156] (427s left) gem_basic (bad-close) [669.148632] Starting subtest: bad-close [669.153128] Subtest bad-close: SUCCESS (0.000s) [669.278220] [141/156] (427s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite) [669.485806] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite [669.490106] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [669.624582] [142/156] (426s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [669.849502] Starting subtest: fbc-indfb-scaledprimary [671.152565] Subtest fbc-indfb-scaledprimary: SUCCESS (1.299s) [671.438589] [143/156] (425s left) i915_pm_rpm (system-suspend-execbuf) [673.416304] Starting subtest: system-suspend-execbuf [698.012746] Subtest system-suspend-execbuf: SUCCESS (9.011s) [702.520564] [144/156] (398s left) kms_flip (2x-blocking-wf_vblank) [702.723575] Starting subtest: 2x-blocking-wf_vblank [702.725776] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [713.830404] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.103s) [713.866556] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [724.917765] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.077s) [724.972338] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [736.399840] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (11.473s) [736.409819] Subtest 2x-blocking-wf_vblank: SUCCESS (33.684s) [737.058906] [145/156] (363s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [737.255856] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [740.167617] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.911s) [740.354283] [146/156] (360s left) perf_pmu (most-busy-check-all) [740.469062] Starting subtest: most-busy-check-all [740.470419] Starting dynamic subtest: rcs0 [740.991348] Dynamic subtest rcs0: SUCCESS (0.523s) [741.027137] Starting dynamic subtest: bcs0 [741.513283] Dynamic subtest bcs0: SUCCESS (0.515s) [741.543157] Starting dynamic subtest: vcs0 [742.036081] Dynamic subtest vcs0: SUCCESS (0.522s) [742.069466] Starting dynamic subtest: vecs0 [742.561489] Dynamic subtest vecs0: SUCCESS (0.520s) [742.563556] Subtest most-busy-check-all: SUCCESS (2.096s) [742.695325] [147/156] (358s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [742.906902] Starting subtest: psr-rgb565-draw-mmap-gtt [742.910822] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [743.042433] [148/156] (358s left) gem_ctx_persistence (hostile) [743.164481] Starting subtest: hostile [745.252244] Subtest hostile: SUCCESS (2.084s) [745.393893] [149/156] (355s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [745.592225] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s) [745.720188] [150/156] (355s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [745.918156] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s) [746.048814] [151/156] (355s left) kms_psr (pr-primary-mmap-cpu) [746.236294] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [746.351233] [152/156] (355s left) kms_plane_multiple (tiling-none) [746.551108] Starting subtest: tiling-none [746.553285] Starting dynamic subtest: pipe-A-HDMI-A-1 [748.394960] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.840s) [748.465511] Starting dynamic subtest: pipe-A-HDMI-A-2 [750.088632] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.688s) [750.157897] Starting dynamic subtest: pipe-B-HDMI-A-1 [751.811094] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.714s) [751.874072] Starting dynamic subtest: pipe-B-HDMI-A-2 [753.598945] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.785s) [753.666574] Starting dynamic subtest: pipe-C-HDMI-A-1 [755.376901] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.764s) [755.441873] Starting dynamic subtest: pipe-C-HDMI-A-2 [757.025336] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.641s) [757.028735] Subtest tiling-none: SUCCESS (10.476s) [757.359363] [153/156] (344s left) gem_tiled_wb [804.916994] [154/156] (296s left) gem_spin_batch (spin-all) [805.045764] Starting subtest: spin-all [805.080845] Subtest spin-all: SUCCESS (0.032s) [805.346242] [155/156] (296s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [805.454079] Starting subtest: etime-single-wait-all-available-unsubmitted [805.562357] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.105s) [805.682551] [156/156] (296s left) kms_frontbuffer_tracking (pipe-fbc-rte) [805.904469] Starting subtest: pipe-fbc-rte [805.913345] Subtest pipe-fbc-rte: SKIP (0.002s) [806.039988] Closing watchdogs results: parsing output: 0/ for test: kms_flip results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_exec_whisper results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: prime_vgem results: parsing output: 7/ for test: gem_mmap_offset results: parsing output: 8/ for test: kms_content_protection results: parsing output: 9/ for test: kms_getfb results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_ccs results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_plane results: parsing output: 15/ for test: gem_fence_thrash results: parsing output: 16/ for test: kms_psr results: parsing output: 17/ for test: kms_plane_scaling results: parsing output: 18/ for test: perf_pmu results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: i915_module_load results: parsing output: 21/ for test: kms_plane_cursor results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_atomic_transition results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: sw_sync results: parsing output: 26/ for test: gem_exec_balancer results: parsing output: 27/ for test: gem_mmap results: parsing output: 28/ for test: dumb_buffer results: parsing output: 29/ for test: gem_workarounds results: parsing output: 30/ for test: kms_scaling_modes results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: gem_exec_fence results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_cursor_legacy results: parsing output: 35/ for test: kms_dp_link_training results: parsing output: 36/ for test: gem_lmem_swapping results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_flip_scaled_crc results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: gem_exec_fence results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: kms_big_fb results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: i915_suspend results: parsing output: 45/ for test: gem_exec_reloc results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_force_connector_basic results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: i915_drm_fdinfo results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_ringfill results: parsing output: 53/ for test: prime_busy results: parsing output: 54/ for test: kms_big_fb results: parsing output: 55/ for test: gem_exec_reloc results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: sysfs_heartbeat_interval results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_plane results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_chamelium_frames results: parsing output: 64/ for test: kms_color results: parsing output: 65/ for test: kms_feature_discovery results: parsing output: 66/ for test: kms_cursor_crc results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: dmabuf_sync_file results: parsing output: 69/ for test: gem_userptr_blits results: parsing output: 70/ for test: gem_ctx_persistence results: parsing output: 71/ for test: kms_chamelium_hpd results: parsing output: 72/ for test: gem_exec_params results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: api_intel_allocator results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: kms_psr2_sf results: parsing output: 83/ for test: kms_lease results: parsing output: 84/ for test: gem_exec_reloc results: parsing output: 85/ for test: kms_invalid_mode results: parsing output: 86/ for test: gem_exec_schedule results: parsing output: 87/ for test: gem_mmap_wc results: parsing output: 88/ for test: gem_exec_reloc results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_big_fb results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: api_intel_bb results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: i915_query results: parsing output: 97/ for test: gem_pxp results: parsing output: 98/ for test: kms_psr2_sf results: parsing output: 99/ for test: kms_flip_scaled_crc results: parsing output: 100/ for test: gem_exec_alignment results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: gem_ctx_engines results: parsing output: 103/ for test: kms_cursor_legacy results: parsing output: 104/ for test: kms_ccs results: parsing output: 105/ for test: kms_pm_rpm results: parsing output: 106/ for test: perf_pmu results: parsing output: 107/ for test: gem_sync results: parsing output: 108/ for test: gem_ctx_param results: parsing output: 109/ for test: kms_psr results: parsing output: 110/ for test: gem_exec_reloc results: parsing output: 111/ for test: kms_chamelium_color results: parsing output: 112/ for test: syncobj_wait results: parsing output: 113/ for test: kms_vblank results: parsing output: 114/ for test: gen9_exec_parse results: parsing output: 115/ for test: gem_userptr_blits results: parsing output: 116/ for test: kms_async_flips results: parsing output: 117/ for test: gem_exec_fence results: parsing output: 118/ for test: syncobj_timeline results: parsing output: 119/ for test: kms_pm_rpm results: parsing output: 120/ for test: gem_partial_pwrite_pread results: parsing output: 121/ for test: kms_flip results: parsing output: 122/ for test: syncobj_timeline results: parsing output: 123/ for test: gem_softpin results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_cursor_legacy results: parsing output: 126/ for test: gem_pwrite results: parsing output: 127/ for test: kms_selftest results: parsing output: 128/ for test: kms_big_fb results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_cursor_legacy results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: gem_exec_schedule results: parsing output: 133/ for test: gem_fence_thrash results: parsing output: 134/ for test: syncobj_timeline results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_cursor_crc results: parsing output: 137/ for test: gem_exec_flush results: parsing output: 138/ for test: gem_partial_pwrite_pread results: parsing output: 139/ for test: gem_basic results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: i915_pm_rpm results: parsing output: 143/ for test: kms_flip results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: perf_pmu results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: gem_ctx_persistence results: parsing output: 148/ for test: kms_psr2_sf results: parsing output: 149/ for test: kms_psr results: parsing output: 150/ for test: kms_psr results: parsing output: 151/ for test: kms_plane_multiple results: parsing output: 152/ for test: gem_tiled_wb results: parsing output: 153/ for test: gem_spin_batch results: parsing output: 154/ for test: syncobj_timeline results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.