[62.953406] Initializing watchdogs [62.953454] /dev/watchdog0 [62.968905] [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] [62.973511] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.975955] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.979629] [001/156] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [63.112054] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [66.701068] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.596s) [67.875548] [002/156] (955s left) gem_exec_reloc (basic-scanout) [67.935396] Subtest basic-scanout: SKIP (0.000s) [68.007196] [003/156] (955s left) kms_feature_discovery (display-1x) [68.102485] Starting subtest: display-1x [68.104681] Subtest display-1x: SUCCESS (0.000s) [68.196815] [004/156] (955s left) api_intel_allocator (reloc-allocator) [68.248915] Starting subtest: reloc-allocator [68.251218] Starting dynamic subtest: basic [68.253160] Dynamic subtest basic: SUCCESS (0.003s) [68.262294] Starting dynamic subtest: parallel-one [68.264156] Dynamic subtest parallel-one: SUCCESS (0.008s) [68.272402] Starting dynamic subtest: print [68.274621] Dynamic subtest print: SUCCESS (0.000s) [68.284208] Starting dynamic subtest: reuse [68.286307] Dynamic subtest reuse: SUCCESS (0.000s) [68.293767] Starting dynamic subtest: fork-reopen-allocator [68.295960] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [68.298147] Subtest reloc-allocator: SUCCESS (0.026s) [68.394612] [005/156] (955s left) kms_psr (fbc-pr-sprite-mmap-cpu) [68.493680] Starting subtest: fbc-pr-sprite-mmap-cpu [68.497647] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [68.562289] [006/156] (955s left) prime_busy (before) [68.618917] Starting subtest: before [68.623906] Starting dynamic subtest: rcs0 [68.658076] Dynamic subtest rcs0: SUCCESS (0.036s) [68.668374] Starting dynamic subtest: bcs0 [68.711344] Dynamic subtest bcs0: SUCCESS (0.053s) [68.721226] Starting dynamic subtest: vcs0 [68.751282] Dynamic subtest vcs0: SUCCESS (0.040s) [68.760149] Starting dynamic subtest: vcs1 [68.792441] Dynamic subtest vcs1: SUCCESS (0.041s) [68.801091] Starting dynamic subtest: vecs0 [68.833593] Dynamic subtest vecs0: SUCCESS (0.041s) [68.842087] Starting dynamic subtest: ccs0 [68.873805] Dynamic subtest ccs0: SUCCESS (0.040s) [68.982324] Subtest before: SUCCESS (0.361s) [69.059901] [007/156] (954s left) i915_pm_sseu (full-enable) [69.123728] Subtest full-enable: SKIP (0.000s) [69.236835] [008/156] (954s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [69.342771] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [69.346941] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [69.459501] [009/156] (954s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [69.558181] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [69.562747] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [69.670441] [010/156] (954s left) gem_basic (create-fd-close) [69.731164] Starting subtest: create-fd-close [69.735673] Subtest create-fd-close: SUCCESS (0.000s) [69.844870] [011/156] (954s left) kms_pm_dc (dc3co-vpb-simulation) [70.942975] Starting subtest: dc3co-vpb-simulation [80.335504] Subtest dc3co-vpb-simulation: SKIP (9.389s) [80.477337] [012/156] (943s left) gem_mmap_gtt (basic-write-read) [80.534879] Subtest basic-write-read: SKIP (0.000s) [80.597542] [013/156] (943s left) prime_self_import (export-vs-gem_close-race) [80.631205] Starting subtest: export-vs-gem_close-race [85.725168] Subtest export-vs-gem_close-race: SUCCESS (5.096s) [85.797232] [014/156] (938s left) kms_legacy_colorkey (basic) [85.895816] Starting subtest: basic [85.898092] Starting dynamic subtest: pipe-A [85.939859] Dynamic subtest pipe-A: SUCCESS (0.045s) [85.950722] Starting dynamic subtest: pipe-B [85.952614] Dynamic subtest pipe-B: SUCCESS (0.001s) [85.960289] Starting dynamic subtest: pipe-C [85.962718] Dynamic subtest pipe-C: SUCCESS (0.000s) [85.971677] Starting dynamic subtest: pipe-D [85.973793] Dynamic subtest pipe-D: SUCCESS (0.000s) [85.975969] Subtest basic: SUCCESS (0.048s) [86.013283] [015/156] (938s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs) [86.103087] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs [86.105360] Starting dynamic subtest: pipe-A-eDP-1 [86.131331] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [86.142609] Starting dynamic subtest: pipe-B-eDP-1 [86.165737] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [86.173676] Starting dynamic subtest: pipe-C-eDP-1 [86.196949] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [86.204834] Starting dynamic subtest: pipe-D-eDP-1 [86.229035] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [86.233467] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s) [88.672855] [016/156] (935s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite) [88.776622] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite [88.781054] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [88.866436] [017/156] (935s left) kms_scaling_modes (scaling-mode-center) [88.956972] Starting subtest: scaling-mode-center [88.959405] Starting dynamic subtest: pipe-A-eDP-1 [89.050355] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s) [89.060442] Starting dynamic subtest: pipe-B-eDP-1 [90.196250] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.145s) [90.206337] Starting dynamic subtest: pipe-C-eDP-1 [91.397588] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s) [91.407620] Starting dynamic subtest: pipe-D-eDP-1 [92.531591] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s) [92.533950] Subtest scaling-mode-center: SUCCESS (3.576s) [93.688326] [018/156] (930s left) i915_pm_rpm (gem-idle) [95.450724] Starting subtest: gem-idle [101.652319] Subtest gem-idle: SUCCESS (6.204s) [101.991880] [019/156] (922s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [103.314540] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [103.318890] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [103.420928] [020/156] (920s left) kms_frontbuffer_tracking (fbchdr-shrfb-scaledprimary) [103.532080] Starting subtest: fbchdr-shrfb-scaledprimary [103.536598] Subtest fbchdr-shrfb-scaledprimary: SKIP (0.000s) [103.620379] [021/156] (920s left) gem_tiled_blits (normal) [103.674656] Subtest normal: SKIP (0.000s) [103.751193] [022/156] (920s left) kms_selftest (drm_plane_helper) [103.785812] Starting subtest: drm_plane_helper [103.797645] Starting dynamic subtest: drm_test_check_plane_state [103.912744] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.114s) [103.922499] Starting dynamic subtest: drm_test_check_invalid_plane_state [104.011596] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.098s) [104.013589] Subtest drm_plane_helper: SUCCESS (0.225s) [104.167455] [023/156] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [104.264294] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [104.268530] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [104.358984] [024/156] (920s left) core_getversion (basic) [104.396956] Starting subtest: basic [104.401461] Subtest basic: SUCCESS (0.000s) [104.473004] [025/156] (919s left) gem_exec_balancer (bonded-true-hang) [104.743947] Starting subtest: bonded-true-hang [104.748180] Subtest bonded-true-hang: SKIP (0.000s) [104.827743] [026/156] (919s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y) [104.931653] Starting subtest: fbcpsrhdr-tiling-y [104.935796] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s) [105.037823] [027/156] (919s left) prime_vgem (basic-fence-read) [105.147807] Starting subtest: basic-fence-read [105.153588] Subtest basic-fence-read: SKIP (0.006s) [105.248106] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [105.251027] [028/156] (919s left) kms_cursor_crc (cursor-onscreen-32x10) [105.411324] Starting subtest: cursor-onscreen-32x10 [105.459251] Subtest cursor-onscreen-32x10: SKIP (0.043s) [105.712905] [029/156] (918s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [105.814094] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [105.817424] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [105.885322] [030/156] (918s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [105.974138] Starting subtest: primary-yf-tiled-reflect-x-180 [106.033625] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [106.134884] [031/156] (918s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt) [106.224544] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt [106.227861] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [106.334615] [032/156] (918s left) kms_frontbuffer_tracking (psrhdr-1p-rte) [106.435759] Starting subtest: psrhdr-1p-rte [106.439367] Subtest psrhdr-1p-rte: SKIP (0.000s) [106.537351] [033/156] (918s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [106.652428] Starting subtest: cursorA-vs-flipA-toggle [117.780811] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.127s) [118.627126] [034/156] (906s left) kms_cursor_crc (cursor-rapid-movement-128x128) [118.844441] Starting subtest: cursor-rapid-movement-128x128 [118.849108] Starting dynamic subtest: pipe-A-eDP-1 [119.397544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s) [119.427680] Starting dynamic subtest: pipe-D-eDP-1 [120.660399] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s) [120.662324] Subtest cursor-rapid-movement-128x128: SUCCESS (1.814s) [121.513327] [035/156] (903s left) i915_drm_fdinfo (virtual-busy-idle) [121.558233] Starting subtest: virtual-busy-idle [121.562735] Subtest virtual-busy-idle: SKIP (0.000s) [121.620468] [036/156] (903s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [121.710722] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [121.713483] Starting dynamic subtest: A-eDP1 [125.346919] Dynamic subtest A-eDP1: SUCCESS (3.633s) [125.356724] Starting dynamic subtest: B-eDP1 [128.649719] Dynamic subtest B-eDP1: SUCCESS (3.304s) [128.659141] Starting dynamic subtest: C-eDP1 [131.891191] Dynamic subtest C-eDP1: SUCCESS (3.241s) [131.900706] Starting dynamic subtest: D-eDP1 [135.103365] Dynamic subtest D-eDP1: SUCCESS (3.210s) [135.105705] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.395s) [135.914347] [037/156] (888s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [136.016608] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [136.020691] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [136.111498] [038/156] (888s left) gem_mmap_offset (open-flood) [136.168223] Starting subtest: open-flood [157.656492] Subtest open-flood: SUCCESS (21.490s) [157.761360] [039/156] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render) [157.861675] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render [157.865262] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [157.946930] [040/156] (867s left) sysfs_preempt_timeout (idempotent) [158.004636] Starting subtest: idempotent [158.006696] Starting dynamic subtest: vecs0 [158.008643] Dynamic subtest vecs0: SUCCESS (0.000s) [158.018366] Starting dynamic subtest: ccs0 [158.020213] Dynamic subtest ccs0: SUCCESS (0.000s) [158.028205] Starting dynamic subtest: vcs0 [158.030085] Dynamic subtest vcs0: SUCCESS (0.000s) [158.038053] Starting dynamic subtest: bcs0 [158.039902] Dynamic subtest bcs0: SUCCESS (0.000s) [158.047950] Starting dynamic subtest: rcs0 [158.049574] Dynamic subtest rcs0: SUCCESS (0.000s) [158.057066] Starting dynamic subtest: vcs1 [158.059104] Dynamic subtest vcs1: SUCCESS (0.000s) [158.061029] Subtest idempotent: SUCCESS (0.006s) [158.107522] [041/156] (866s left) gem_lmem_swapping (parallel-multi) [158.143672] Subtest parallel-multi: SKIP (0.000s) [158.181667] [042/156] (866s left) kms_psr (fbc-psr-cursor-mmap-gtt) [158.274149] Starting subtest: fbc-psr-cursor-mmap-gtt [158.276029] Starting dynamic subtest: eDP-1 [158.279522] Dynamic subtest eDP-1: SKIP (0.000s) [158.282981] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s) [158.344526] [043/156] (866s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [158.403700] Starting subtest: multi-wait-for-submit-available-submitted [158.405728] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s) [158.515076] [044/156] (866s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [158.608594] Starting subtest: fbc-dirtyfb-ioctl [158.610553] Starting dynamic subtest: A-eDP-1 [161.197601] Dynamic subtest A-eDP-1: SUCCESS (2.586s) [161.199575] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.587s) [162.084755] [045/156] (863s left) kms_invalid_mode (zero-hdisplay) [162.189100] Starting subtest: zero-hdisplay [162.191418] Starting dynamic subtest: pipe-A-eDP-1 [162.479199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [162.488925] Starting dynamic subtest: pipe-B-eDP-1 [162.491317] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [162.503143] Starting dynamic subtest: pipe-C-eDP-1 [162.505902] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [162.514611] Starting dynamic subtest: pipe-D-eDP-1 [162.516838] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [162.519128] Subtest zero-hdisplay: SUCCESS (0.298s) [163.308674] [046/156] (861s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt) [163.405192] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt [163.409224] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [163.510171] [047/156] (861s left) gem_vm_create (invalid-destroy) [163.571575] Starting subtest: invalid-destroy [163.573755] Subtest invalid-destroy: SUCCESS (0.002s) [163.671912] [048/156] (861s left) gem_compute (compute-square) [163.736593] Starting subtest: compute-square [163.740673] Subtest compute-square: SUCCESS (0.007s) [163.885541] [049/156] (861s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [163.988694] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [163.993138] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [164.093166] [050/156] (861s left) kms_vblank (wait-forked-busy-hang) [164.193822] Starting subtest: wait-forked-busy-hang [164.196046] Starting dynamic subtest: pipe-A-eDP-1 [192.090721] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.895s) [192.103828] Starting dynamic subtest: pipe-D-eDP-1 [207.042481] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.948s) [207.044477] Subtest wait-forked-busy-hang: SUCCESS (42.848s) [207.875329] [051/156] (817s left) kms_flip (absolute-wf_vblank) [207.967918] Starting subtest: absolute-wf_vblank [207.970254] Starting dynamic subtest: A-eDP1 [216.722165] Dynamic subtest A-eDP1: SUCCESS (8.755s) [216.732899] Starting dynamic subtest: B-eDP1 [225.459703] Dynamic subtest B-eDP1: SUCCESS (8.736s) [225.471215] Starting dynamic subtest: C-eDP1 [234.168733] Dynamic subtest C-eDP1: SUCCESS (8.707s) [234.180079] Starting dynamic subtest: D-eDP1 [242.908617] Dynamic subtest D-eDP1: SUCCESS (8.736s) [242.910573] Subtest absolute-wf_vblank: SUCCESS (34.945s) [244.119792] [052/156] (781s left) perf_pmu (busy-no-semaphores) [244.165917] Starting subtest: busy-no-semaphores [244.167863] Starting dynamic subtest: rcs0 [244.714430] Dynamic subtest rcs0: SUCCESS (0.549s) [244.726314] Starting dynamic subtest: bcs0 [245.267571] Dynamic subtest bcs0: SUCCESS (0.551s) [245.279917] Starting dynamic subtest: vcs0 [245.817055] Dynamic subtest vcs0: SUCCESS (0.547s) [245.829572] Starting dynamic subtest: vcs1 [247.813695] Dynamic subtest vcs1: SUCCESS (1.993s) [247.824632] Starting dynamic subtest: vecs0 [249.795231] Dynamic subtest vecs0: SUCCESS (1.979s) [249.807660] Starting dynamic subtest: ccs0 [251.843663] Dynamic subtest ccs0: SUCCESS (2.045s) [251.846579] Subtest busy-no-semaphores: SUCCESS (7.680s) [251.964165] [053/156] (773s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [252.071147] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [252.073481] Starting dynamic subtest: pipe-A-eDP-1 [252.096672] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [252.107902] Starting dynamic subtest: pipe-B-eDP-1 [252.129525] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [252.138328] Starting dynamic subtest: pipe-C-eDP-1 [252.160020] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [252.171045] Starting dynamic subtest: pipe-D-eDP-1 [252.194745] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [252.199230] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s) [254.385193] [054/156] (771s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [254.452177] Starting subtest: y-tiled-ccs-to-x-tiled [254.458385] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [254.641873] [055/156] (770s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render) [254.739117] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render [254.743393] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [254.853187] [056/156] (770s left) kms_plane (pixel-format-linear-modifier-source-clamping) [254.950139] Starting subtest: pixel-format-linear-modifier-source-clamping [254.976137] Starting dynamic subtest: pipe-A-plane-0 [255.519916] Dynamic subtest pipe-A-plane-0: SUCCESS (0.544s) [255.530329] Starting dynamic subtest: pipe-A-plane-3 [255.953487] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s) [257.065572] Starting dynamic subtest: pipe-B-plane-0 [257.619498] Dynamic subtest pipe-B-plane-0: SUCCESS (0.566s) [257.629065] Starting dynamic subtest: pipe-B-plane-3 [258.063652] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s) [258.380388] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.433s) [259.236980] [057/156] (766s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [259.340037] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [259.344186] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [259.445508] [058/156] (766s left) kms_pm_lpsp (kms-lpsp) [260.541223] Starting subtest: kms-lpsp [260.543137] Starting dynamic subtest: pipe-A-eDP-1 [260.691472] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s) [260.988825] Subtest kms-lpsp: SUCCESS (0.445s) [261.865392] [059/156] (763s left) kms_chamelium_edid (dp-mode-timings) [262.256749] Subtest dp-mode-timings: SKIP (0.000s) [263.072730] [060/156] (762s left) kms_addfb_basic (invalid-set-prop) [263.132049] Starting subtest: invalid-set-prop [263.133943] Subtest invalid-set-prop: SUCCESS (0.000s) [263.296415] [061/156] (762s left) kms_big_fb (4-tiled-8bpp-rotate-0) [263.402893] Starting subtest: 4-tiled-8bpp-rotate-0 [264.628709] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.225s) [264.763525] [062/156] (761s left) gem_mmap_wc (bad-object) [264.821997] Subtest bad-object: SKIP (0.000s) [264.887666] [063/156] (761s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [264.999056] Starting subtest: verify-pxp-stale-buf-optout-execution [266.062336] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.063s) [266.214875] [064/156] (759s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [266.313052] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [266.315398] Starting dynamic subtest: pipe-A-default-mode [269.015096] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s) [269.017252] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.702s) [269.883821] [065/156] (756s left) gen9_exec_parse (unaligned-access) [269.952363] Subtest unaligned-access: SKIP (0.000s) [270.022500] [066/156] (756s left) kms_addfb_basic (no-handle) [270.072256] Starting subtest: no-handle [270.074119] Subtest no-handle: SUCCESS (0.000s) [270.211481] [067/156] (755s left) fbdev (eof) [270.245639] Starting subtest: eof [270.248061] Subtest eof: SUCCESS (0.000s) [270.330394] [068/156] (755s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [270.436689] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [270.440900] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [270.523580] [069/156] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [270.615696] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [270.620208] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [270.714603] [070/156] (755s left) gem_mmap_gtt (big-copy) [270.764742] Subtest big-copy: SKIP (0.000s) [270.826611] [071/156] (755s left) gem_basic (create-close) [270.871745] Starting subtest: create-close [270.875287] Subtest create-close: SUCCESS (0.000s) [270.982203] [072/156] (755s left) kms_psr (pr-primary-blt) [271.084105] Starting subtest: pr-primary-blt [271.087799] Subtest pr-primary-blt: SKIP (0.000s) [271.174863] [073/156] (755s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [271.240581] Starting subtest: yf-tiled-to-vebox-yf-tiled [271.244204] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [271.460649] [074/156] (754s left) gem_mmap_gtt (big-bo-tiledy) [271.515676] Subtest big-bo-tiledY: SKIP (0.000s) [271.577385] [075/156] (754s left) kms_chamelium_hpd (hdmi-hpd-fast) [271.958542] Subtest hdmi-hpd-fast: SKIP (0.000s) [272.790015] [076/156] (753s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [272.878057] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [272.880376] Starting dynamic subtest: pipe-A-eDP-1 [272.976854] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [272.986736] Starting dynamic subtest: pipe-B-eDP-1 [274.101742] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s) [274.106203] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.226s) [275.389846] [077/156] (751s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [275.493247] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt [275.497570] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [275.603508] [078/156] (751s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [275.690046] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [275.692356] Starting dynamic subtest: pipe-A-eDP-1 [275.715925] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [275.727336] Starting dynamic subtest: pipe-B-eDP-1 [275.749251] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [275.758159] Starting dynamic subtest: pipe-C-eDP-1 [275.780099] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [275.788916] Starting dynamic subtest: pipe-D-eDP-1 [275.811958] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [275.816082] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s) [277.954028] [079/156] (748s left) syncobj_wait (wait-any-snapshot) [278.020381] Starting subtest: wait-any-snapshot [278.100515] Subtest wait-any-snapshot: SUCCESS (0.082s) [278.193287] [080/156] (748s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [278.295682] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [278.300217] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [278.400134] [081/156] (748s left) kms_big_fb (linear-8bpp-rotate-270) [278.495247] Starting subtest: linear-8bpp-rotate-270 [278.517608] Subtest linear-8bpp-rotate-270: SKIP (0.020s) [278.629513] [082/156] (748s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu) [278.731662] Starting subtest: hdr-rgb565-draw-mmap-cpu [278.735980] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [278.825443] [083/156] (748s left) gem_exec_reloc (basic-cpu-gtt-active) [278.880671] Subtest basic-cpu-gtt-active: SKIP (0.000s) [278.955079] [084/156] (747s left) syncobj_timeline (invalid-query-one-illegal-handle) [279.015615] Starting subtest: invalid-query-one-illegal-handle [279.017769] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s) [279.129630] [085/156] (747s left) gem_userptr_blits (dmabuf-sync) [279.185929] Starting subtest: dmabuf-sync [279.190639] Subtest dmabuf-sync: SKIP (0.002s) [279.327687] [086/156] (747s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render) [279.422821] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render [279.426363] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [279.520478] [087/156] (747s left) kms_cursor_edge_walk (256x256-right-edge) [279.616381] Starting subtest: 256x256-right-edge [279.618267] Starting dynamic subtest: pipe-A-eDP-1 [283.114524] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.496s) [283.124745] Starting dynamic subtest: pipe-D-eDP-1 [286.338819] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.223s) [286.341184] Subtest 256x256-right-edge: SUCCESS (6.723s) [287.149542] [088/156] (739s left) gem_lmem_swapping (random-engines) [287.192124] Subtest random-engines: SKIP (0.000s) [287.237638] [089/156] (739s left) gem_ctx_isolation (clean) [287.293684] Starting subtest: clean [287.296134] Starting dynamic subtest: rcs0 [287.352988] Dynamic subtest rcs0: SUCCESS (0.059s) [287.363756] Starting dynamic subtest: bcs0 [287.421336] Dynamic subtest bcs0: SUCCESS (0.067s) [287.431309] Starting dynamic subtest: vcs0 [287.483815] Dynamic subtest vcs0: SUCCESS (0.061s) [287.494872] Starting dynamic subtest: vcs1 [289.278474] Dynamic subtest vcs1: SUCCESS (1.793s) [289.288644] Starting dynamic subtest: vecs0 [291.291878] Dynamic subtest vecs0: SUCCESS (2.012s) [291.301090] Starting dynamic subtest: ccs0 [293.340150] Dynamic subtest ccs0: SUCCESS (2.047s) [293.342484] Subtest clean: SUCCESS (6.046s) [293.598362] [090/156] (733s left) gem_exec_whisper (basic-queues) [293.669612] Starting subtest: basic-queues [300.770092] Subtest basic-queues: SUCCESS (7.097s) [300.967464] [091/156] (726s left) api_intel_bb (lot-of-buffers) [301.043672] Starting subtest: lot-of-buffers [302.131445] Subtest lot-of-buffers: SUCCESS (1.087s) [302.554114] [092/156] (724s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt) [302.652748] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt [302.656871] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [302.745378] [093/156] (724s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [302.848691] Starting subtest: plane-primary-toggle-with-vblank-wait [302.850810] Starting dynamic subtest: pipe-A-eDP-1 [303.023311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s) [303.331853] Starting dynamic subtest: pipe-B-eDP-1 [304.257336] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.936s) [304.572849] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.723s) [305.423429] [094/156] (721s left) gem_readwrite (beyond-eob) [305.482583] Subtest beyond-EOB: SKIP (0.000s) [305.540107] [095/156] (721s left) gem_exec_fence (basic-wait-all) [305.601295] Starting subtest: basic-wait-all [305.697557] Subtest basic-wait-all: SUCCESS (0.098s) [307.343942] [096/156] (720s left) gem_exec_balancer (parallel-keep-in-fence) [307.610372] Starting subtest: parallel-keep-in-fence [308.809126] Subtest parallel-keep-in-fence: SUCCESS (1.200s) [308.934543] [097/156] (718s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [309.036733] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [309.040826] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [309.136648] [098/156] (718s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-fullscreen) [309.239293] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-fullscreen [309.243436] Subtest psrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [309.342410] [099/156] (718s left) perf (invalid-oa-metric-set-id) [309.470185] Starting subtest: invalid-oa-metric-set-id [309.482843] Subtest invalid-oa-metric-set-id: SUCCESS (0.014s) [309.525258] [100/156] (718s left) kms_color_pipeline (plane-ctm3x4-lut1d) [309.618073] Starting subtest: plane-ctm3x4-lut1d [309.764217] Starting dynamic subtest: pipe-A-plane-0 [309.941242] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s) [309.951061] Starting dynamic subtest: pipe-A-plane-1 [310.107959] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s) [310.117538] Starting dynamic subtest: pipe-A-plane-2 [310.274636] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [311.540792] Starting dynamic subtest: pipe-B-plane-0 [311.710325] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [311.720641] Starting dynamic subtest: pipe-B-plane-1 [311.899210] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [311.909394] Starting dynamic subtest: pipe-B-plane-2 [312.088119] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s) [313.364191] Starting dynamic subtest: pipe-C-plane-0 [313.511778] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [313.522178] Starting dynamic subtest: pipe-C-plane-1 [313.667473] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [313.677404] Starting dynamic subtest: pipe-C-plane-2 [313.822900] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [315.081566] Starting dynamic subtest: pipe-D-plane-0 [315.218657] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [315.229853] Starting dynamic subtest: pipe-D-plane-1 [315.373735] Dynamic subtest pipe-D-plane-1: SUCCESS (0.153s) [315.384269] Starting dynamic subtest: pipe-D-plane-2 [315.518077] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s) [315.822746] Subtest plane-ctm3x4-lut1d: SUCCESS (6.205s) [316.639440] [101/156] (711s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping) [316.731095] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping [316.735392] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s) [316.805369] [102/156] (710s left) kms_big_fb (y-tiled-8bpp-rotate-180) [316.912065] Starting subtest: y-tiled-8bpp-rotate-180 [316.916440] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [317.024402] [103/156] (710s left) gem_exec_params (invalid-bsd2-flag-on-render) [317.078925] Starting subtest: invalid-bsd2-flag-on-render [317.081311] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s) [317.177966] [104/156] (710s left) perf_pmu (busy-start) [317.218122] Starting subtest: busy-start [317.219964] Starting dynamic subtest: rcs0 [319.765525] Dynamic subtest rcs0: SUCCESS (2.549s) [319.777099] Starting dynamic subtest: bcs0 [322.315091] Dynamic subtest bcs0: SUCCESS (2.548s) [322.326312] Starting dynamic subtest: vcs0 [326.272235] Dynamic subtest vcs0: SUCCESS (3.953s) [326.285058] Starting dynamic subtest: vcs1 [330.306279] Dynamic subtest vcs1: SUCCESS (4.031s) [330.316736] Starting dynamic subtest: vecs0 [334.273542] Dynamic subtest vecs0: SUCCESS (3.964s) [334.286517] Starting dynamic subtest: ccs0 [336.823828] Dynamic subtest ccs0: SUCCESS (2.549s) [336.826806] Subtest busy-start: SUCCESS (19.608s) [336.942024] [105/156] (690s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc) [337.055401] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc [337.059464] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [337.151569] [106/156] (690s left) syncobj_basic (bad-handle-to-fd) [337.212714] Starting subtest: bad-handle-to-fd [337.214906] Subtest bad-handle-to-fd: SUCCESS (0.000s) [337.318679] [107/156] (690s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [337.367565] Starting subtest: wait-all-for-submit-delayed-submit [337.470058] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [337.550241] [108/156] (690s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt) [337.650619] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt [337.655131] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [337.742791] [109/156] (690s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite) [337.845485] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite [337.849076] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [337.945680] [110/156] (690s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [338.009154] Starting subtest: map-fixed-invalidate-overlap-busy [338.013132] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [338.132580] [111/156] (689s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-pri-indfb-multidraw) [338.231483] Starting subtest: fbcpsrhdr-2p-pri-indfb-multidraw [338.234924] Subtest fbcpsrhdr-2p-pri-indfb-multidraw: SKIP (0.000s) [338.332775] [112/156] (689s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [338.448556] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [345.086295] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.643s) [345.201876] [113/156] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [345.309152] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [345.313139] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [345.420760] [114/156] (682s left) gem_userptr_blits (unsync-overlap) [345.477124] Subtest unsync-overlap: SKIP (0.000s) [345.604115] [115/156] (682s left) gem_ctx_sseu (mmap-args) [345.662969] Subtest mmap-args: SKIP (0.000s) [345.730578] [116/156] (682s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [345.820313] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [345.822691] Starting dynamic subtest: pipe-A-eDP-1 [345.881515] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [345.891674] Starting dynamic subtest: pipe-B-eDP-1 [345.949249] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [345.960037] Starting dynamic subtest: pipe-C-eDP-1 [346.017194] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [346.027227] Starting dynamic subtest: pipe-D-eDP-1 [346.073942] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [346.077414] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s) [348.098363] [117/156] (680s left) gem_mmap_gtt (medium-copy) [348.157152] Subtest medium-copy: SKIP (0.000s) [348.218798] [118/156] (680s left) kms_flip (bo-too-big-interruptible) [348.317949] Starting subtest: bo-too-big-interruptible [348.320126] Starting dynamic subtest: A-eDP1 [349.648476] Dynamic subtest A-eDP1: SUCCESS (1.329s) [349.663356] Starting dynamic subtest: B-eDP1 [350.875825] Dynamic subtest B-eDP1: SUCCESS (1.224s) [350.890715] Starting dynamic subtest: C-eDP1 [352.209702] Dynamic subtest C-eDP1: SUCCESS (1.331s) [352.220652] Starting dynamic subtest: D-eDP1 [353.547409] Dynamic subtest D-eDP1: SUCCESS (1.336s) [353.553376] Subtest bo-too-big-interruptible: SUCCESS (5.234s) [354.754444] [119/156] (673s left) kms_atomic (plane-invalid-params-fence) [354.855054] Starting subtest: plane-invalid-params-fence [354.857406] Starting dynamic subtest: pipe-A-eDP-1 [355.218974] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.364s) [355.221162] Subtest plane-invalid-params-fence: SUCCESS (0.365s) [356.095620] [120/156] (672s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [356.184828] Starting subtest: plane-scaler-unity-scaling-with-rotation [356.187149] Starting dynamic subtest: pipe-A [356.410746] Dynamic subtest pipe-A: SUCCESS (0.228s) [356.420546] Starting dynamic subtest: pipe-B [357.685594] Dynamic subtest pipe-B: SUCCESS (1.274s) [357.695633] Starting dynamic subtest: pipe-C [359.025490] Dynamic subtest pipe-C: SUCCESS (1.339s) [359.034837] Starting dynamic subtest: pipe-D [360.373532] Dynamic subtest pipe-D: SUCCESS (1.347s) [360.376088] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.191s) [361.539627] [121/156] (666s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [361.590838] Starting subtest: etime-single-wait-available-unsubmitted [361.691718] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s) [361.784559] [122/156] (666s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc) [361.876413] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc [361.880568] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [361.976231] [123/156] (666s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-pgflip-blt) [362.071910] Starting subtest: psrhdr-2p-primscrn-shrfb-pgflip-blt [362.075775] Subtest psrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [362.182022] [124/156] (666s left) kms_atomic_interruptible (universal-setplane-cursor) [362.274791] Starting subtest: universal-setplane-cursor [362.277128] Starting dynamic subtest: pipe-A-eDP-1 [369.658974] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.382s) [369.661254] Subtest universal-setplane-cursor: SUCCESS (7.384s) [370.495850] [125/156] (658s left) kms_frontbuffer_tracking (hdr-2p-rte) [370.586537] Starting subtest: hdr-2p-rte [370.590962] Subtest hdr-2p-rte: SKIP (0.000s) [370.679113] [126/156] (658s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [370.782977] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [371.574708] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.792s) [371.736936] [127/156] (657s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [371.839100] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [371.841412] Starting dynamic subtest: pipe-A-eDP-1 [374.132659] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.295s) [374.142582] Starting dynamic subtest: pipe-B-eDP-1 [376.624425] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.491s) [376.633896] Starting dynamic subtest: pipe-C-eDP-1 [378.848059] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.222s) [378.858123] Starting dynamic subtest: pipe-D-eDP-1 [381.073319] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.223s) [381.075224] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (9.237s) [382.252447] [128/156] (646s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render) [382.358227] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render [386.644450] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.291s) [387.863527] [129/156] (640s left) gem_exec_schedule (preempt-self) [387.937126] Starting subtest: preempt-self [387.939096] Starting dynamic subtest: rcs0 [387.950748] Dynamic subtest rcs0: SUCCESS (0.021s) [387.961486] Starting dynamic subtest: bcs0 [387.969453] Dynamic subtest bcs0: SUCCESS (0.018s) [387.979133] Starting dynamic subtest: vcs0 [388.001559] Dynamic subtest vcs0: SUCCESS (0.030s) [388.011781] Starting dynamic subtest: vcs1 [388.021276] Dynamic subtest vcs1: SUCCESS (0.019s) [388.031960] Starting dynamic subtest: vecs0 [388.038427] Dynamic subtest vecs0: SUCCESS (0.016s) [388.053173] Starting dynamic subtest: ccs0 [388.059809] Dynamic subtest ccs0: SUCCESS (0.020s) [388.062302] Subtest preempt-self: SUCCESS (0.130s) [389.415034] [130/156] (639s left) gem_ctx_shared (detached-shared-gtt) [389.483536] Starting subtest: detached-shared-gtt [391.639225] Subtest detached-shared-gtt: SUCCESS (2.154s) [391.956416] [131/156] (636s left) kms_pm_rpm (system-suspend-idle) [393.497732] Starting subtest: system-suspend-idle [413.224972] Subtest system-suspend-idle: SUCCESS (4.802s) [413.611819] [132/156] (615s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [413.729678] Starting subtest: psr-indfb-scaledprimary [419.457661] Subtest psr-indfb-scaledprimary: SUCCESS (5.726s) [419.574451] [133/156] (609s left) kms_flip (bo-too-big) [419.667696] Starting subtest: bo-too-big [419.669938] Starting dynamic subtest: A-eDP1 [421.003090] Dynamic subtest A-eDP1: SUCCESS (1.333s) [421.018239] Starting dynamic subtest: B-eDP1 [422.335659] Dynamic subtest B-eDP1: SUCCESS (1.330s) [422.346438] Starting dynamic subtest: C-eDP1 [423.677388] Dynamic subtest C-eDP1: SUCCESS (1.339s) [423.688021] Starting dynamic subtest: D-eDP1 [425.024168] Dynamic subtest D-eDP1: SUCCESS (1.344s) [425.029682] Subtest bo-too-big: SUCCESS (5.359s) [426.241058] [134/156] (602s left) gen9_exec_parse (shadow-peek) [426.304421] Subtest shadow-peek: SKIP (0.000s) [426.372130] [135/156] (602s left) gem_tiled_fence_blits (basic) [426.432169] Subtest basic: SKIP (0.000s) [426.510263] [136/156] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [426.609922] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [426.614319] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [426.718539] [137/156] (602s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt) [426.817664] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt [426.822090] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s) [426.916760] [138/156] (602s left) gem_exec_fence (parallel) [427.090279] Starting subtest: parallel [427.092539] Starting dynamic subtest: rcs0 [429.236881] Dynamic subtest rcs0: SUCCESS (2.149s) [429.248478] Starting dynamic subtest: bcs0 [431.391686] Dynamic subtest bcs0: SUCCESS (2.153s) [431.406710] Starting dynamic subtest: vcs0 [433.540528] Dynamic subtest vcs0: SUCCESS (2.148s) [433.552572] Starting dynamic subtest: vcs1 [435.696835] Dynamic subtest vcs1: SUCCESS (2.155s) [435.707310] Starting dynamic subtest: vecs0 [437.852853] Dynamic subtest vecs0: SUCCESS (2.154s) [437.864020] Starting dynamic subtest: ccs0 [440.005112] Dynamic subtest ccs0: SUCCESS (2.151s) [440.007008] Subtest parallel: SUCCESS (12.915s) [442.356795] [139/156] (586s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [442.453193] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [442.457591] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [442.526160] [140/156] (586s left) gem_reg_read (timestamp-moving) [442.571719] Starting subtest: timestamp-moving [443.570549] Subtest timestamp-moving: SUCCESS (1.001s) [443.649333] [141/156] (585s left) gem_softpin (allocator-nopin-reserve) [443.708827] Starting subtest: allocator-nopin-reserve [443.808526] Subtest allocator-nopin-reserve: SUCCESS (0.098s) [443.930063] [142/156] (585s left) kms_psr (psr-primary-mmap-cpu) [444.032118] Starting subtest: psr-primary-mmap-cpu [444.034921] Starting dynamic subtest: eDP-1 [445.731904] Dynamic subtest eDP-1: SUCCESS (1.701s) [445.734265] Subtest psr-primary-mmap-cpu: SUCCESS (1.702s) [446.595193] [143/156] (582s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip) [446.697619] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip [446.701653] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [446.793413] [144/156] (582s left) kms_psr (fbc-psr2-sprite-plane-move) [446.888236] Starting subtest: fbc-psr2-sprite-plane-move [446.890554] Starting dynamic subtest: eDP-1 [446.894442] Dynamic subtest eDP-1: SKIP (0.000s) [446.898402] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [446.977573] [145/156] (582s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [447.071395] Starting subtest: psr-1p-pri-indfb-multidraw [470.631792] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.563s) [470.760497] [146/156] (558s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite) [470.879641] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite [470.882885] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [470.982054] [147/156] (558s left) kms_pipe_crc_basic (read-crc) [471.080519] Starting subtest: read-crc [471.082456] Starting dynamic subtest: pipe-A-eDP-1 [471.792266] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s) [471.804219] Starting dynamic subtest: pipe-B-eDP-1 [473.214944] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s) [473.226036] Starting dynamic subtest: pipe-C-eDP-1 [474.598670] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s) [474.609392] Starting dynamic subtest: pipe-D-eDP-1 [475.933028] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s) [475.935641] Subtest read-crc: SUCCESS (4.854s) [476.768979] [148/156] (552s left) kms_content_protection (dp-mst-type-0) [476.907569] Starting subtest: dp-mst-type-0 [476.912069] Subtest dp-mst-type-0: SKIP (0.000s) [477.031966] [149/156] (552s left) i915_query (query-topology-unsupported) [477.099094] Starting subtest: query-topology-unsupported [477.103680] Subtest query-topology-unsupported: SKIP (0.000s) [477.209287] [150/156] (552s left) gem_exec_schedule (pi-ringfull) [477.385019] Starting subtest: pi-ringfull [477.387290] Starting dynamic subtest: rcs0 [477.412147] Dynamic subtest rcs0: SUCCESS (0.029s) [477.425549] Starting dynamic subtest: bcs0 [477.443589] Dynamic subtest bcs0: SUCCESS (0.031s) [477.459163] Starting dynamic subtest: vcs0 [477.472625] Dynamic subtest vcs0: SUCCESS (0.028s) [477.488382] Starting dynamic subtest: vcs1 [477.500154] Dynamic subtest vcs1: SUCCESS (0.027s) [477.516202] Starting dynamic subtest: vecs0 [477.528132] Dynamic subtest vecs0: SUCCESS (0.027s) [477.543996] Starting dynamic subtest: ccs0 [477.555001] Dynamic subtest ccs0: SUCCESS (0.026s) [477.557168] Subtest pi-ringfull: SUCCESS (0.173s) [477.787131] [151/156] (551s left) kms_async_flips (alternate-sync-async-flip) [477.894116] Starting subtest: alternate-sync-async-flip [478.283637] Starting dynamic subtest: pipe-A-eDP-1 [481.066172] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.784s) [481.456863] Starting dynamic subtest: pipe-B-eDP-1 [484.209816] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.763s) [484.580765] Starting dynamic subtest: pipe-C-eDP-1 [487.332114] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.762s) [487.700187] Starting dynamic subtest: pipe-D-eDP-1 [490.461903] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.773s) [490.464435] Subtest alternate-sync-async-flip: SUCCESS (12.568s) [491.639032] [152/156] (538s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [491.700105] Starting subtest: etime-multi-wait-all-available-unsubmitted [491.801445] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s) [491.879763] [153/156] (537s left) kms_hdr (static-swap) [491.969717] Starting subtest: static-swap [491.972093] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [491.976587] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [491.988012] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [491.992509] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [491.996954] Subtest static-swap: SKIP (0.003s) [492.050952] [154/156] (537s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [492.142654] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [492.147077] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [492.264159] [155/156] (537s left) kms_flip (flip-vs-fences) [492.366587] Starting subtest: flip-vs-fences [492.371075] Subtest flip-vs-fences: SKIP (0.000s) [492.473435] [156/156] (537s left) gem_softpin (noreloc-interruptible) [492.529371] Starting subtest: noreloc-interruptible [497.918660] Subtest noreloc-interruptible: SUCCESS (5.387s) [498.040840] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: gem_exec_reloc results: parsing output: 2/ for test: kms_feature_discovery results: parsing output: 3/ for test: api_intel_allocator results: parsing output: 4/ for test: kms_psr results: parsing output: 5/ for test: prime_busy results: parsing output: 6/ for test: i915_pm_sseu results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: gem_basic results: parsing output: 10/ for test: kms_pm_dc results: parsing output: 11/ for test: gem_mmap_gtt results: parsing output: 12/ for test: prime_self_import results: parsing output: 13/ for test: kms_legacy_colorkey results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_scaling_modes results: parsing output: 17/ for test: i915_pm_rpm results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: gem_tiled_blits results: parsing output: 21/ for test: kms_selftest results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: core_getversion results: parsing output: 24/ for test: gem_exec_balancer results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: prime_vgem results: parsing output: 27/ for test: kms_cursor_crc results: parsing output: 28/ for test: kms_psr2_sf results: parsing output: 29/ for test: kms_rotation_crc results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_cursor_legacy results: parsing output: 33/ for test: kms_cursor_crc results: parsing output: 34/ for test: i915_drm_fdinfo results: parsing output: 35/ for test: kms_flip results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_mmap_offset results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: sysfs_preempt_timeout results: parsing output: 40/ for test: gem_lmem_swapping results: parsing output: 41/ for test: kms_psr results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: kms_dirtyfb results: parsing output: 44/ for test: kms_invalid_mode results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_vm_create results: parsing output: 47/ for test: gem_compute results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_vblank results: parsing output: 50/ for test: kms_flip results: parsing output: 51/ for test: perf_pmu results: parsing output: 52/ for test: kms_ccs 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_plane results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_pm_lpsp results: parsing output: 58/ for test: kms_chamelium_edid results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: gem_mmap_wc results: parsing output: 62/ for test: gem_pxp results: parsing output: 63/ for test: kms_flip_scaled_crc results: parsing output: 64/ for test: gen9_exec_parse results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: fbdev results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: gem_mmap_gtt results: parsing output: 70/ for test: gem_basic results: parsing output: 71/ for test: kms_psr results: parsing output: 72/ for test: gem_render_copy results: parsing output: 73/ for test: gem_mmap_gtt results: parsing output: 74/ for test: kms_chamelium_hpd results: parsing output: 75/ for test: kms_psr2_sf results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: syncobj_wait results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: gem_exec_reloc results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: gem_userptr_blits results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_cursor_edge_walk results: parsing output: 87/ for test: gem_lmem_swapping results: parsing output: 88/ for test: gem_ctx_isolation results: parsing output: 89/ for test: gem_exec_whisper results: parsing output: 90/ for test: api_intel_bb results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_atomic_transition results: parsing output: 93/ for test: gem_readwrite results: parsing output: 94/ for test: gem_exec_fence results: parsing output: 95/ for test: gem_exec_balancer results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: perf results: parsing output: 99/ for test: kms_color_pipeline results: parsing output: 100/ for test: kms_plane results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: gem_exec_params results: parsing output: 103/ for test: perf_pmu results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: syncobj_basic results: parsing output: 106/ for test: syncobj_timeline results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_userptr_blits 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_frontbuffer_tracking results: parsing output: 113/ for test: gem_userptr_blits results: parsing output: 114/ for test: gem_ctx_sseu results: parsing output: 115/ for test: kms_ccs results: parsing output: 116/ for test: gem_mmap_gtt results: parsing output: 117/ for test: kms_flip results: parsing output: 118/ for test: kms_atomic results: parsing output: 119/ for test: kms_plane_scaling results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_atomic_interruptible results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_big_fb results: parsing output: 126/ for test: kms_ccs results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_exec_schedule results: parsing output: 129/ for test: gem_ctx_shared results: parsing output: 130/ for test: kms_pm_rpm results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_flip results: parsing output: 133/ for test: gen9_exec_parse results: parsing output: 134/ for test: gem_tiled_fence_blits results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: gem_exec_fence results: parsing output: 138/ for test: kms_flip_scaled_crc results: parsing output: 139/ for test: gem_reg_read results: parsing output: 140/ for test: gem_softpin results: parsing output: 141/ for test: kms_psr results: parsing output: 142/ for test: kms_big_fb results: parsing output: 143/ for test: kms_psr results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: kms_pipe_crc_basic results: parsing output: 147/ for test: kms_content_protection results: parsing output: 148/ for test: i915_query results: parsing output: 149/ for test: gem_exec_schedule results: parsing output: 150/ for test: kms_async_flips results: parsing output: 151/ for test: syncobj_timeline results: parsing output: 152/ for test: kms_hdr results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: kms_flip results: parsing output: 155/ for test: gem_softpin Done.