[60.658400] Initializing watchdogs [60.658446] /dev/watchdog0 [60.673669] [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] [60.678589] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.680993] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.684355] [001/156] (960s left) i915_drm_fdinfo (virtual-busy-idle) [60.767071] Starting subtest: virtual-busy-idle [60.772154] Subtest virtual-busy-idle: SKIP (0.000s) [60.841958] [002/156] (960s left) gem_render_linear_blits (basic) [60.910997] Starting subtest: basic [60.945859] Subtest basic: SUCCESS (0.037s) [61.042401] [003/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-cpu) [61.146375] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-cpu [61.150649] Subtest fbcpsrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [61.240645] [004/156] (960s left) kms_big_fb (linear-addfb) [61.342329] Starting subtest: linear-addfb [61.344278] Subtest linear-addfb: SUCCESS (0.000s) [61.440051] [005/156] (959s left) gem_mmap_offset (partial-mmap) [61.485290] Starting subtest: partial-mmap [61.487161] Starting dynamic subtest: smem0 [61.489090] Dynamic subtest smem0: SUCCESS (0.004s) [61.490721] Subtest partial-mmap: SUCCESS (0.004s) [61.573214] [006/156] (959s left) prime_mmap (test_reprime) [61.621306] Starting subtest: test_reprime [61.623222] Starting dynamic subtest: test_reprime-smem [61.654497] Dynamic subtest test_reprime-smem: SUCCESS (0.034s) [61.656621] Subtest test_reprime: SUCCESS (0.034s) [61.758511] [007/156] (959s left) gem_mmap (basic) [61.819069] Subtest basic: SKIP (0.000s) [61.882229] [008/156] (959s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt) [61.983363] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt [61.986716] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [62.086718] [009/156] (959s left) gem_fence_thrash (bo-write-verify-threaded-none) [62.122618] Starting subtest: bo-write-verify-threaded-none [62.148263] Subtest bo-write-verify-threaded-none: SKIP (0.022s) [62.204000] [010/156] (959s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [62.262364] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [62.264463] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s) [62.372789] [011/156] (959s left) kms_chamelium_edid (dp-edid-change-during-suspend) [62.768586] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [63.553682] [012/156] (958s left) kms_pm_rpm (system-suspend-idle) [65.510126] Starting subtest: system-suspend-idle [85.682003] Subtest system-suspend-idle: SUCCESS (5.115s) [90.074006] [013/156] (935s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render) [90.201322] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render [90.205677] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [90.299233] [014/156] (935s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [90.362136] Starting subtest: invalid-bsd1-flag-on-vebox [90.364580] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [90.477321] [015/156] (935s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [90.586161] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [90.590478] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [90.681895] [016/156] (935s left) gem_lmem_swapping (parallel-random) [90.724261] Subtest parallel-random: SKIP (0.000s) [90.763343] [017/156] (935s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [90.813032] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [90.817590] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [90.997993] [018/156] (934s left) syncobj_timeline (invalid-signal-zero-handles) [91.057693] Starting subtest: invalid-signal-zero-handles [91.060193] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [91.146205] [019/156] (934s left) core_sysfs (read-all-entries) [91.198051] Starting subtest: read-all-entries [91.200287] Subtest read-all-entries: SUCCESS (0.003s) [91.298395] [020/156] (934s left) kms_flip (2x-flip-vs-rmfb-interruptible) [91.405637] Starting subtest: 2x-flip-vs-rmfb-interruptible [91.417446] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s) [91.504192] [021/156] (934s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt) [91.616433] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt [91.620811] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [91.712031] [022/156] (934s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff) [91.825642] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff [91.830296] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [91.914530] [023/156] (934s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [92.010320] Starting subtest: compare-crc-sanitycheck-xr24 [92.012462] Starting dynamic subtest: pipe-A-eDP-1 [92.664394] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s) [92.675268] Starting dynamic subtest: pipe-B-eDP-1 [93.989176] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.286s) [93.998287] Starting dynamic subtest: pipe-C-eDP-1 [95.263703] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.246s) [95.276003] Starting dynamic subtest: pipe-D-eDP-1 [96.510204] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s) [96.512602] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.390s) [97.386404] [024/156] (928s left) i915_query (query-topology-garbage-items) [97.436925] Starting subtest: query-topology-garbage-items [97.439117] Subtest query-topology-garbage-items: SUCCESS (0.001s) [97.536484] [025/156] (928s left) gem_mmap (bad-object) [97.597071] Subtest bad-object: SKIP (0.000s) [97.654589] [026/156] (928s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [97.748727] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [97.751154] Starting dynamic subtest: pipe-A-default-mode [98.964729] Dynamic subtest pipe-A-default-mode: SKIP (1.195s) [98.969186] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.196s) [99.101513] [027/156] (927s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-plflip-blt) [99.199310] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-plflip-blt [99.203852] Subtest fbcpsrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [99.294546] [028/156] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [99.387608] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [107.174268] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.729s) [107.297707] [029/156] (919s left) gem_pxp (reject-modify-context-protection-off-3) [107.422939] Starting subtest: reject-modify-context-protection-off-3 [107.425386] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s) [107.535406] [030/156] (918s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt) [107.650432] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt [107.654409] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [107.757494] [031/156] (918s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [107.849455] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [107.851367] Starting dynamic subtest: pipe-A-eDP-1 [108.006051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s) [108.016687] Starting dynamic subtest: pipe-B-eDP-1 [108.035066] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.013s) [108.043397] Starting dynamic subtest: pipe-C-eDP-1 [108.062579] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s) [108.070704] Starting dynamic subtest: pipe-D-eDP-1 [108.089466] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [108.091577] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.189s) [110.310009] [032/156] (916s left) vgem_basic (busy-fence) [110.410002] Starting subtest: busy-fence [110.412293] Subtest busy-fence: SUCCESS (0.000s) [110.475049] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true [110.478342] [033/156] (915s left) gem_userptr_blits (dmabuf-sync) [110.547373] Starting subtest: dmabuf-sync [110.551922] Subtest dmabuf-sync: SKIP (0.002s) [110.694612] [034/156] (915s left) kms_psr (pr-sprite-blt) [110.783742] Starting subtest: pr-sprite-blt [110.788030] Subtest pr-sprite-blt: SKIP (0.000s) [110.856543] [035/156] (915s left) kms_plane_alpha_blend (coverage-7efc) [110.945817] Starting subtest: coverage-7efc [111.233349] Starting dynamic subtest: pipe-A-eDP-1 [111.801214] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s) [111.828185] Starting dynamic subtest: pipe-D-eDP-1 [113.141053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.315s) [113.143400] Subtest coverage-7efc: SUCCESS (2.190s) [113.980844] [036/156] (912s left) kms_psr (fbc-psr2-sprite-mmap-gtt) [114.071552] Starting subtest: fbc-psr2-sprite-mmap-gtt [114.073416] Starting dynamic subtest: eDP-1 [114.077542] Dynamic subtest eDP-1: SKIP (0.000s) [114.081468] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s) [114.143957] [037/156] (912s left) prime_busy (before-wait) [114.191001] Starting subtest: before-wait [114.196022] Starting dynamic subtest: rcs0 [114.223984] Dynamic subtest rcs0: SUCCESS (0.030s) [114.233761] Starting dynamic subtest: bcs0 [114.264628] Dynamic subtest bcs0: SUCCESS (0.040s) [114.274108] Starting dynamic subtest: vcs0 [114.304731] Dynamic subtest vcs0: SUCCESS (0.040s) [114.313863] Starting dynamic subtest: vcs1 [114.345914] Dynamic subtest vcs1: SUCCESS (0.041s) [114.354902] Starting dynamic subtest: vecs0 [114.387180] Dynamic subtest vecs0: SUCCESS (0.041s) [114.396365] Starting dynamic subtest: ccs0 [114.427597] Dynamic subtest ccs0: SUCCESS (0.040s) [114.537764] Subtest before-wait: SUCCESS (0.344s) [114.615945] [038/156] (912s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [114.711409] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [115.793380] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.079s) [115.921585] [039/156] (910s left) gem_exec_schedule (independent) [115.999080] Starting subtest: independent [116.001067] Starting dynamic subtest: rcs0 [117.339972] Dynamic subtest rcs0: SUCCESS (1.346s) [117.352260] Starting dynamic subtest: vcs0 [119.393995] Dynamic subtest vcs0: SUCCESS (2.052s) [119.405109] Starting dynamic subtest: vcs1 [121.384921] Dynamic subtest vcs1: SUCCESS (1.988s) [121.396091] Starting dynamic subtest: vecs0 [123.361963] Dynamic subtest vecs0: SUCCESS (1.975s) [123.374121] Starting dynamic subtest: ccs0 [125.338416] Dynamic subtest ccs0: SUCCESS (1.974s) [125.341409] Subtest independent: SUCCESS (9.341s) [125.655934] [040/156] (901s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [125.756649] Starting subtest: psr-2p-primscrn-spr-indfb-move [125.760694] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [125.857252] [041/156] (900s left) kms_psr2_su (frontbuffer-xrgb8888) [125.906854] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [125.966739] [042/156] (900s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [126.062893] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [126.065159] Starting dynamic subtest: pipe-A-eDP-1 [126.087638] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [126.097944] Starting dynamic subtest: pipe-B-eDP-1 [126.119261] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [126.127751] Starting dynamic subtest: pipe-C-eDP-1 [126.148914] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [126.157586] Starting dynamic subtest: pipe-D-eDP-1 [126.179396] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [126.183391] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [128.350157] [043/156] (898s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [128.472106] Starting subtest: basic-flip-before-cursor-legacy [129.389345] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.915s) [130.201256] [044/156] (896s left) kms_psr (psr-sprite-blt) [130.301369] Starting subtest: psr-sprite-blt [130.303784] Starting dynamic subtest: eDP-1 [132.009976] Dynamic subtest eDP-1: SUCCESS (1.709s) [132.012243] Subtest psr-sprite-blt: SUCCESS (1.710s) [132.856893] [045/156] (894s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [132.906572] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [132.971451] [046/156] (894s left) kms_content_protection (uevent-hdcp14) [133.117049] Starting subtest: uevent-hdcp14 [133.121654] Subtest uevent-hdcp14: SKIP (0.000s) [133.242481] [047/156] (893s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [133.344167] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [134.467852] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.125s) [134.591530] [048/156] (892s left) kms_rotation_crc (cursor-rotation-180) [134.696556] Starting subtest: cursor-rotation-180 [136.229747] Subtest cursor-rotation-180: SUCCESS (1.533s) [137.420503] [049/156] (889s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-pwrite) [137.513978] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-pwrite [137.518112] Subtest psrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [137.604369] [050/156] (889s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [137.709414] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [137.714030] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [137.823968] [051/156] (889s left) prime_mmap (test_refcounting) [137.879389] Starting subtest: test_refcounting [137.881747] Starting dynamic subtest: test_refcounting-smem [137.918846] Dynamic subtest test_refcounting-smem: SUCCESS (0.039s) [137.921396] Subtest test_refcounting: SUCCESS (0.040s) [138.015972] [052/156] (889s left) i915_drm_fdinfo (virtual-busy-hang) [138.062070] Starting subtest: virtual-busy-hang [138.066766] Subtest virtual-busy-hang: SKIP (0.000s) [138.130790] [053/156] (889s left) kms_chamelium_hpd (vga-hpd) [138.498216] Subtest vga-hpd: SKIP (0.000s) [139.323672] [054/156] (888s left) kms_big_fb (y-tiled-64bpp-rotate-90) [139.417999] Starting subtest: y-tiled-64bpp-rotate-90 [139.422080] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [139.515224] [055/156] (887s left) perf_pmu (busy-double-start) [139.559683] Starting subtest: busy-double-start [139.561947] Starting dynamic subtest: rcs0 [143.198347] Dynamic subtest rcs0: FAIL (3.579s) [143.211365] Starting dynamic subtest: bcs0 [146.709128] Dynamic subtest bcs0: SUCCESS (3.566s) [146.719144] Starting dynamic subtest: vcs0 [150.894916] Dynamic subtest vcs0: SUCCESS (4.182s) [150.906761] Starting dynamic subtest: vcs1 [154.929956] Dynamic subtest vcs1: SUCCESS (4.031s) [154.941546] Starting dynamic subtest: vecs0 [158.871172] Dynamic subtest vecs0: SUCCESS (3.937s) [158.882419] Starting dynamic subtest: ccs0 [162.507456] Dynamic subtest ccs0: FAIL (3.566s) [162.509723] Subtest busy-double-start: FAIL (22.870s) [162.554555] [056/156] (864s left) kms_vblank (ts-continuation-modeset-rpm) [162.660277] Starting subtest: ts-continuation-modeset-rpm [162.662481] Starting dynamic subtest: pipe-A-eDP-1 [165.147171] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.485s) [165.162395] Starting dynamic subtest: pipe-D-eDP-1 [167.389782] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.240s) [167.392193] Subtest ts-continuation-modeset-rpm: SUCCESS (4.729s) [168.187600] [057/156] (859s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render) [168.301141] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render [168.305090] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [168.396564] [058/156] (859s left) kms_invalid_mode (int-max-clock) [168.498860] Starting subtest: int-max-clock [168.501155] Starting dynamic subtest: pipe-A-eDP-1 [168.786213] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [168.796559] Starting dynamic subtest: pipe-B-eDP-1 [168.798408] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [168.807043] Starting dynamic subtest: pipe-C-eDP-1 [168.808966] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [168.817996] Starting dynamic subtest: pipe-D-eDP-1 [168.820160] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [168.822382] Subtest int-max-clock: SUCCESS (0.295s) [169.615666] [059/156] (857s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [169.680033] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [169.743203] [060/156] (857s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-onoff) [169.848016] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-onoff [169.852520] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [169.937190] [061/156] (857s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [170.042138] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu [170.046535] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [170.152292] [062/156] (857s left) kms_plane (plane-position-covered) [170.244791] Starting subtest: plane-position-covered [170.764053] Starting dynamic subtest: pipe-A-plane-1 [172.003286] Dynamic subtest pipe-A-plane-1: SUCCESS (1.238s) [172.018727] Starting dynamic subtest: pipe-A-plane-2 [173.227158] Dynamic subtest pipe-A-plane-2: SUCCESS (1.225s) [173.238032] Starting dynamic subtest: pipe-A-plane-3 [174.486173] Dynamic subtest pipe-A-plane-3: SUCCESS (1.257s) [174.496775] Starting dynamic subtest: pipe-A-plane-4 [175.745617] Dynamic subtest pipe-A-plane-4: SUCCESS (1.257s) [175.755211] Starting dynamic subtest: pipe-A-plane-5 [175.775952] Dynamic subtest pipe-A-plane-5: SUCCESS (0.029s) [177.003000] Starting dynamic subtest: pipe-B-plane-1 [178.326061] Dynamic subtest pipe-B-plane-1: SUCCESS (1.331s) [178.337248] Starting dynamic subtest: pipe-B-plane-2 [179.646821] Dynamic subtest pipe-B-plane-2: SUCCESS (1.321s) [179.655952] Starting dynamic subtest: pipe-B-plane-3 [180.944813] Dynamic subtest pipe-B-plane-3: SUCCESS (1.296s) [180.957804] Starting dynamic subtest: pipe-B-plane-4 [182.202114] Dynamic subtest pipe-B-plane-4: SUCCESS (1.256s) [182.214637] Starting dynamic subtest: pipe-B-plane-5 [182.227683] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s) [182.229861] Subtest plane-position-covered: SUCCESS (11.980s) [183.003648] [063/156] (844s left) kms_dp_link_training (uhbr-sst) [183.097427] Starting subtest: uhbr-sst [183.105880] Subtest uhbr-sst: SKIP (0.000s) [183.185952] [064/156] (844s left) syncobj_basic (bad-flags-fd-to-handle) [183.244058] Starting subtest: bad-flags-fd-to-handle [183.246406] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s) [183.336707] [065/156] (844s left) perf_pmu (init-busy) [183.384422] Starting subtest: init-busy [183.386736] Starting dynamic subtest: rcs0 [183.389124] Dynamic subtest rcs0: SUCCESS (0.001s) [183.402826] Starting dynamic subtest: bcs0 [183.405183] Dynamic subtest bcs0: SUCCESS (0.001s) [183.414401] Starting dynamic subtest: vcs0 [183.416710] Dynamic subtest vcs0: SUCCESS (0.001s) [183.425714] Starting dynamic subtest: vcs1 [183.427983] Dynamic subtest vcs1: SUCCESS (0.001s) [183.436976] Starting dynamic subtest: vecs0 [183.439192] Dynamic subtest vecs0: SUCCESS (0.001s) [183.448453] Starting dynamic subtest: ccs0 [183.450375] Dynamic subtest ccs0: SUCCESS (0.001s) [183.452288] Subtest init-busy: SUCCESS (0.018s) [183.503384] [066/156] (844s left) gem_exec_params (no-blt) [183.551983] Starting subtest: no-blt [183.554305] Subtest no-blt: SUCCESS (0.002s) [183.656020] [067/156] (844s left) kms_cursor_crc (cursor-onscreen-256x85) [183.914743] Starting subtest: cursor-onscreen-256x85 [183.977354] Subtest cursor-onscreen-256x85: SKIP (0.057s) [184.131863] [068/156] (843s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [184.222853] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [184.224783] Starting dynamic subtest: pipe-A-eDP-1 [184.297872] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [184.307055] Starting dynamic subtest: pipe-B-eDP-1 [185.475142] Dynamic subtest pipe-B-eDP-1: SKIP (1.176s) [185.479282] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.256s) [186.667918] [069/156] (841s left) api_intel_allocator (fork-simple-stress) [186.721242] Starting subtest: fork-simple-stress [192.115713] Subtest fork-simple-stress: SUCCESS (5.397s) [192.235192] [070/156] (835s left) kms_rotation_crc (sprite-rotation-270) [192.341476] Starting subtest: sprite-rotation-270 [192.345913] Subtest sprite-rotation-270: SKIP (0.001s) [192.417503] [071/156] (835s left) syncobj_wait (reset-unsignaled) [192.487939] Starting subtest: reset-unsignaled [192.490537] Subtest reset-unsignaled: SUCCESS (0.000s) [192.604137] [072/156] (835s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [192.713631] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [200.112813] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.405s) [200.236988] [073/156] (827s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-render) [200.340454] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-render [200.344417] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [200.430241] [074/156] (827s left) gem_exec_fence (syncobj-invalid-wait) [200.868249] Starting subtest: syncobj-invalid-wait [200.870766] Subtest syncobj-invalid-wait: SUCCESS (0.000s) [202.478885] [075/156] (825s left) gem_ctx_engines (execute-oneforall) [202.536401] Starting subtest: execute-oneforall [203.242356] Subtest execute-oneforall: SUCCESS (0.705s) [204.477153] [076/156] (823s left) kms_plane (pixel-format-y-tiled-modifier) [204.574208] Starting subtest: pixel-format-y-tiled-modifier [204.578540] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s) [204.650396] [077/156] (823s left) gem_wait (write-wait) [204.727392] Starting subtest: write-wait [204.729492] Starting dynamic subtest: all-engines [205.851520] Dynamic subtest all-engines: SUCCESS (1.126s) [205.870782] Starting dynamic subtest: rcs0 [206.907300] Dynamic subtest rcs0: SUCCESS (1.054s) [206.924368] Starting dynamic subtest: bcs0 [207.964520] Dynamic subtest bcs0: SUCCESS (1.055s) [207.982201] Starting dynamic subtest: vcs0 [209.018921] Dynamic subtest vcs0: SUCCESS (1.052s) [209.035636] Starting dynamic subtest: vcs1 [210.073068] Dynamic subtest vcs1: SUCCESS (1.052s) [210.091559] Starting dynamic subtest: vecs0 [211.127497] Dynamic subtest vecs0: SUCCESS (1.052s) [211.145537] Starting dynamic subtest: ccs0 [212.186172] Dynamic subtest ccs0: SUCCESS (1.056s) [212.188857] Subtest write-wait: SUCCESS (7.462s) [212.387628] [078/156] (815s left) gem_exec_flush (basic-batch-kernel-default-wb) [212.441834] Starting subtest: basic-batch-kernel-default-wb [218.980251] Subtest basic-batch-kernel-default-wb: SUCCESS (6.537s) [219.167355] [079/156] (809s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [219.267064] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [219.271248] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [219.369005] [080/156] (809s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-blt) [219.473400] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-blt [219.477357] Subtest hdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [219.581438] [081/156] (808s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt) [219.675710] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt [219.679958] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [219.766134] [082/156] (808s left) kms_cursor_crc (cursor-rapid-movement-64x64) [219.952091] Starting subtest: cursor-rapid-movement-64x64 [219.958235] Starting dynamic subtest: pipe-A-eDP-1 [220.488074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.532s) [220.519388] Starting dynamic subtest: pipe-D-eDP-1 [221.703284] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.193s) [221.705797] Subtest cursor-rapid-movement-64x64: SUCCESS (1.751s) [222.564759] [083/156] (806s left) kms_big_fb (4-tiled-16bpp-rotate-0) [222.669055] Starting subtest: 4-tiled-16bpp-rotate-0 [224.037728] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.369s) [224.149914] [084/156] (804s left) kms_vblank (invalid) [224.242406] Starting subtest: invalid [224.243961] Starting dynamic subtest: pipe-A-eDP-1 [224.639535] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s) [224.642076] Subtest invalid: SUCCESS (0.398s) [225.483133] [085/156] (803s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [225.581005] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [225.953922] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [228.755394] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.799s) [228.767515] Starting dynamic subtest: pipe-A-eDP-1-4 [230.929307] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s) [230.939699] Starting dynamic subtest: pipe-A-eDP-1-4 [232.940521] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [232.956072] Starting dynamic subtest: pipe-A-eDP-1-x [235.131288] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s) [235.520519] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [238.294090] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.779s) [238.306640] Starting dynamic subtest: pipe-B-eDP-1-4 [240.480083] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s) [240.490925] Starting dynamic subtest: pipe-B-eDP-1-4 [242.490582] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [242.503587] Starting dynamic subtest: pipe-B-eDP-1-x [244.692580] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s) [245.058083] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [247.831586] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.779s) [247.844390] Starting dynamic subtest: pipe-C-eDP-1-4 [250.007162] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [250.016586] Starting dynamic subtest: pipe-C-eDP-1-4 [252.018148] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [252.028669] Starting dynamic subtest: pipe-C-eDP-1-x [254.197558] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [254.561595] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [257.376556] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.821s) [257.387554] Starting dynamic subtest: pipe-D-eDP-1-4 [259.551804] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s) [259.563371] Starting dynamic subtest: pipe-D-eDP-1-4 [261.562466] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [261.574525] Starting dynamic subtest: pipe-D-eDP-1-x [263.753139] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s) [263.756108] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.162s) [264.960760] [086/156] (763s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [265.069377] Starting subtest: psr-rgb565-draw-blt [272.168522] Subtest psr-rgb565-draw-blt: SUCCESS (7.101s) [272.292171] [087/156] (756s left) sw_sync (alloc_timeline) [272.336427] Starting subtest: alloc_timeline [272.338650] Subtest alloc_timeline: SUCCESS (0.000s) [272.421701] [088/156] (756s left) gem_eio (context-create) [272.642292] Starting subtest: context-create [272.974535] Subtest context-create: SUCCESS (0.329s) [273.110324] [089/156] (755s left) syncobj_wait (signal) [273.164592] Starting subtest: signal [273.166581] Subtest signal: SUCCESS (0.000s) [273.263594] [090/156] (755s left) gem_softpin (zero) [273.326376] Starting subtest: zero [273.332851] Subtest zero: SUCCESS (0.004s) [273.448418] [091/156] (755s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [273.510031] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [273.614360] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.102s) [273.693036] [092/156] (755s left) gem_exec_reloc (basic-wc-cpu-active) [273.754637] Subtest basic-wc-cpu-active: SKIP (0.000s) [273.834097] [093/156] (755s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite) [273.933595] Starting subtest: hdr-rgb101010-draw-pwrite [273.937617] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s) [274.044338] [094/156] (754s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu) [274.145300] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu [278.184548] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.043s) [279.411408] [095/156] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [279.521308] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [279.525247] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [279.621705] [096/156] (749s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [279.720408] Starting subtest: pr-overlay-plane-move-continuous-sf [279.724547] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [279.788760] [097/156] (749s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [279.882220] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [279.884597] Starting dynamic subtest: pipe-A-eDP-1 [279.909953] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [279.922429] Starting dynamic subtest: pipe-B-eDP-1 [279.947113] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [279.957920] Starting dynamic subtest: pipe-C-eDP-1 [279.981298] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [279.990839] Starting dynamic subtest: pipe-D-eDP-1 [280.014703] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [280.019094] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [282.155319] [098/156] (747s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [282.272988] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [282.277361] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [282.385599] [099/156] (746s left) gem_ccs (block-multicopy-inplace) [282.449671] Starting subtest: block-multicopy-inplace [282.453923] Subtest block-multicopy-inplace: SKIP (0.000s) [282.565665] [100/156] (746s left) gem_mmap_wc (read-write-distinct) [282.618510] Subtest read-write-distinct: SKIP (0.000s) [282.682884] [101/156] (746s left) kms_flip (dpms-off-confusion) [282.772623] Starting subtest: dpms-off-confusion [282.774801] Starting dynamic subtest: A-eDP1 [291.458857] Dynamic subtest A-eDP1: SUCCESS (8.684s) [291.471510] Starting dynamic subtest: B-eDP1 [300.095166] Dynamic subtest B-eDP1: SUCCESS (8.630s) [300.109771] Starting dynamic subtest: C-eDP1 [308.721263] Dynamic subtest C-eDP1: SUCCESS (8.620s) [308.734133] Starting dynamic subtest: D-eDP1 [317.362230] Dynamic subtest D-eDP1: SUCCESS (8.642s) [317.366879] Subtest dpms-off-confusion: SUCCESS (34.590s) [318.533202] [102/156] (710s left) gem_exec_schedule (u-lateslice) [318.604558] Starting subtest: u-lateslice [318.606524] Starting dynamic subtest: rcs0 [318.615168] Dynamic subtest rcs0: SUCCESS (0.020s) [318.629409] Starting dynamic subtest: bcs0 [318.635647] Dynamic subtest bcs0: SUCCESS (0.019s) [318.645458] Starting dynamic subtest: vcs0 [318.656044] Dynamic subtest vcs0: SUCCESS (0.019s) [318.665747] Starting dynamic subtest: vcs1 [318.677314] Dynamic subtest vcs1: SUCCESS (0.020s) [318.686894] Starting dynamic subtest: vecs0 [318.695126] Dynamic subtest vecs0: SUCCESS (0.017s) [318.704894] Starting dynamic subtest: ccs0 [318.713060] Dynamic subtest ccs0: SUCCESS (0.017s) [318.715201] Subtest u-lateslice: SUCCESS (0.119s) [320.453463] [103/156] (708s left) gem_exec_balancer (bonded-sync) [320.522640] Starting subtest: bonded-sync [320.527138] Subtest bonded-sync: SKIP (0.000s) [320.835165] [104/156] (708s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [320.944696] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [320.949394] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [321.091082] [105/156] (708s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [321.186073] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [321.188440] Starting dynamic subtest: pipe-A [322.232398] Dynamic subtest pipe-A: SUCCESS (1.050s) [322.245900] Starting dynamic subtest: pipe-B [324.332522] Dynamic subtest pipe-B: SUCCESS (2.100s) [324.342139] Starting dynamic subtest: pipe-C [325.531788] Dynamic subtest pipe-C: SUCCESS (1.198s) [325.542503] Starting dynamic subtest: pipe-D [326.757633] Dynamic subtest pipe-D: SUCCESS (1.224s) [326.759807] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.577s) [327.946751] [106/156] (701s left) perf (per-context-mode-unprivileged) [328.075858] Starting subtest: per-context-mode-unprivileged [328.080204] Subtest per-context-mode-unprivileged: SKIP (0.000s) [328.123577] [107/156] (701s left) kms_flip (flip-vs-suspend-interruptible) [328.217645] Starting subtest: flip-vs-suspend-interruptible [328.219943] Starting dynamic subtest: A-eDP1 [442.141987] Dynamic subtest A-eDP1: SUCCESS (11.728s) [442.144390] Subtest flip-vs-suspend-interruptible: SUCCESS (11.731s) [449.291802] [108/156] (587s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [449.422623] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [449.427869] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [449.521977] [109/156] (587s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite) [449.627089] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite [449.632009] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [449.708075] [110/156] (587s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt) [449.810085] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt [449.815123] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [449.900393] [111/156] (586s left) gen9_exec_parse (bb-oversize) [449.960060] Subtest bb-oversize: SKIP (0.000s) [450.033777] [112/156] (586s left) gem_linear_blits (interruptible) [450.537366] Starting subtest: interruptible [455.658413] Subtest interruptible: SUCCESS (4.957s) [455.787294] [113/156] (581s left) gem_exec_whisper (basic-fds-all) [455.891539] Starting subtest: basic-fds-all [467.532488] Subtest basic-fds-all: SUCCESS (11.503s) [467.719187] [114/156] (569s left) kms_flip (flip-vs-blocking-wf-vblank) [467.833742] Starting subtest: flip-vs-blocking-wf-vblank [467.836336] Starting dynamic subtest: A-eDP1 [476.782499] Dynamic subtest A-eDP1: SUCCESS (8.922s) [476.796786] Starting dynamic subtest: B-eDP1 [485.713850] Dynamic subtest B-eDP1: SUCCESS (8.919s) [485.727000] Starting dynamic subtest: C-eDP1 [494.631640] Dynamic subtest C-eDP1: SUCCESS (8.911s) [494.646003] Starting dynamic subtest: D-eDP1 [503.564819] Dynamic subtest D-eDP1: SUCCESS (8.924s) [503.567393] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.691s) [504.800297] [115/156] (532s left) kms_frontbuffer_tracking (fbchdr-indfb-scaledprimary) [504.906186] Starting subtest: fbchdr-indfb-scaledprimary [504.911008] Subtest fbchdr-indfb-scaledprimary: SKIP (0.000s) [504.997038] [116/156] (532s left) gem_ppgtt (shrink-vs-evict-any) [505.052323] Starting subtest: shrink-vs-evict-any [510.564290] Subtest shrink-vs-evict-any: SUCCESS (5.508s) [510.642751] [117/156] (526s left) kms_psr (psr2-primary-mmap-gtt) [510.761944] Starting subtest: psr2-primary-mmap-gtt [510.764453] Starting dynamic subtest: eDP-1 [512.197406] Dynamic subtest eDP-1: SKIP (1.429s) [512.203363] Subtest psr2-primary-mmap-gtt: SKIP (1.432s) [512.342147] [118/156] (524s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [512.463561] Starting subtest: modeset-atomic-cursor-hotspot [512.468615] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [512.659595] [119/156] (524s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-pwrite) [512.762316] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-pwrite [512.767087] Subtest hdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [512.844234] [120/156] (524s left) kms_psr (fbc-psr-primary-mmap-cpu) [512.939339] Starting subtest: fbc-psr-primary-mmap-cpu [512.942159] Starting dynamic subtest: eDP-1 [512.947298] Dynamic subtest eDP-1: SKIP (0.000s) [512.952298] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s) [513.026815] [121/156] (524s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [513.114288] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [513.116983] Starting dynamic subtest: pipe-A-eDP-1 [513.143083] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [513.158825] Starting dynamic subtest: pipe-B-eDP-1 [513.184749] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [513.195325] Starting dynamic subtest: pipe-C-eDP-1 [513.218235] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [513.228025] Starting dynamic subtest: pipe-D-eDP-1 [513.250932] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [513.254989] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s) [515.304407] [122/156] (522s left) kms_color (ctm-negative) [515.397244] Starting subtest: ctm-negative [515.399713] Starting dynamic subtest: pipe-A-eDP-1 [516.114818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s) [516.128164] Starting dynamic subtest: pipe-B-eDP-1 [517.516636] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s) [517.527992] Starting dynamic subtest: pipe-C-eDP-1 [518.888897] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s) [518.900375] Starting dynamic subtest: pipe-D-eDP-1 [520.222200] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s) [520.224954] Subtest ctm-negative: SUCCESS (4.823s) [521.031196] [123/156] (516s left) syncobj_timeline (wait-any-interrupted) [521.105345] Starting subtest: wait-any-interrupted [521.210111] Subtest wait-any-interrupted: SUCCESS (0.103s) [521.291993] [124/156] (516s left) gem_userptr_blits (stress-mm-invalidate-close) [521.366059] Starting subtest: stress-mm-invalidate-close [523.514334] Subtest stress-mm-invalidate-close: SUCCESS (2.148s) [523.639458] [125/156] (513s left) gem_exec_params (dr1-dirt) [523.691181] Starting subtest: DR1-dirt [523.694140] Subtest DR1-dirt: SUCCESS (0.000s) [523.800321] [126/156] (513s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [523.922703] Starting subtest: cursorB-vs-flipB-toggle [523.927917] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [524.066862] [127/156] (513s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [524.165114] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [524.170123] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [524.261110] [128/156] (513s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [524.362011] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [531.374943] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.016s) [531.550522] [129/156] (506s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [531.653521] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [531.658921] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [531.740261] [130/156] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [531.838344] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [538.492073] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.656s) [538.620656] [131/156] (499s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [538.675368] Starting subtest: etime-single-wait-all-available-unsubmitted [538.778689] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.104s) [538.859032] [132/156] (498s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier) [538.957557] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier [538.962994] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s) [539.037125] [133/156] (498s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [539.131226] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [539.133835] Starting dynamic subtest: pipe-A-eDP-1 [539.142989] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [539.154154] Starting dynamic subtest: pipe-B-eDP-1 [539.162842] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [539.173039] Starting dynamic subtest: pipe-C-eDP-1 [539.182053] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [539.191673] Starting dynamic subtest: pipe-D-eDP-1 [539.200538] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [539.204892] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [541.460591] [134/156] (496s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [541.585108] Starting subtest: 2x-cursor-vs-flip-legacy [541.589594] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s) [541.732480] [135/156] (496s left) kms_panel_fitting (legacy) [541.817736] Starting subtest: legacy [541.819913] Starting dynamic subtest: pipe-A-eDP-1 [542.390044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s) [542.417783] Starting dynamic subtest: pipe-B-eDP-1 [543.944884] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.535s) [543.973812] Starting dynamic subtest: pipe-C-eDP-1 [545.547088] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.581s) [545.573928] Starting dynamic subtest: pipe-D-eDP-1 [547.050672] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.484s) [547.053058] Subtest legacy: SUCCESS (5.233s) [548.294730] [136/156] (489s left) api_intel_bb (intel-bb-blit-y) [548.347007] Starting subtest: intel-bb-blit-y [551.870182] Subtest intel-bb-blit-y: SUCCESS (3.525s) [551.995141] [137/156] (486s left) i915_pm_rpm (gem-execbuf-stress) [553.560052] Starting subtest: gem-execbuf-stress [553.563075] Starting dynamic subtest: smem0 [566.474595] Dynamic subtest smem0: SUCCESS (12.920s) [566.489633] Starting dynamic subtest: extra-wait-smem0 [628.249174] Dynamic subtest extra-wait-smem0: SUCCESS (61.760s) [628.252269] Subtest gem-execbuf-stress: SUCCESS (74.687s) [628.621876] [138/156] (409s left) gem_exec_gttfill (multigpu-basic) [628.794926] Starting subtest: multigpu-basic [640.087034] Subtest multigpu-basic: SUCCESS (11.293s) [640.149219] [139/156] (397s left) gem_lmem_swapping (random) [640.242170] Subtest random: SKIP (0.000s) [640.291351] [140/156] (397s left) gem_exec_parallel (fds) [640.351105] Starting subtest: fds [640.353775] Starting dynamic subtest: rcs0 [645.497694] Dynamic subtest rcs0: SUCCESS (5.143s) [645.511374] Starting dynamic subtest: bcs0 [650.003297] Dynamic subtest bcs0: SUCCESS (4.503s) [650.015860] Starting dynamic subtest: vcs0 [655.629579] Dynamic subtest vcs0: SUCCESS (5.622s) [655.643498] Starting dynamic subtest: vcs1 [659.844003] Dynamic subtest vcs1: SUCCESS (4.189s) [659.859193] Starting dynamic subtest: vecs0 [665.599559] Dynamic subtest vecs0: SUCCESS (5.774s) [665.613346] Starting dynamic subtest: ccs0 [670.602650] Dynamic subtest ccs0: SUCCESS (5.000s) [670.605651] Subtest fds: SUCCESS (30.242s) [670.823575] [141/156] (367s left) kms_big_fb (x-tiled-64bpp-rotate-270) [670.940492] Starting subtest: x-tiled-64bpp-rotate-270 [670.961365] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s) [671.092285] [142/156] (367s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [671.200606] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [671.205093] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [671.293656] [143/156] (367s left) gem_fence_thrash (bo-write-verify-x) [671.327372] Starting subtest: bo-write-verify-x [671.351602] Subtest bo-write-verify-x: SKIP (0.021s) [671.412830] [144/156] (366s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-render) [671.503857] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-render [671.508345] Subtest fbchdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [671.609541] [145/156] (366s left) gem_ctx_persistence (engines-cleanup) [671.674610] Starting subtest: engines-cleanup [671.677512] Starting dynamic subtest: rcs0 [671.718761] Dynamic subtest rcs0: SUCCESS (0.044s) [671.731364] Starting dynamic subtest: bcs0 [671.810033] Dynamic subtest bcs0: SUCCESS (0.091s) [671.825245] Starting dynamic subtest: vcs0 [671.836214] Dynamic subtest vcs0: SUCCESS (0.024s) [671.846996] Starting dynamic subtest: vcs1 [671.897910] Dynamic subtest vcs1: SUCCESS (0.061s) [671.911450] Starting dynamic subtest: vecs0 [671.939142] Dynamic subtest vecs0: SUCCESS (0.040s) [671.950172] Starting dynamic subtest: ccs0 [671.958823] Dynamic subtest ccs0: SUCCESS (0.019s) [671.961016] Subtest engines-cleanup: SUCCESS (0.286s) [672.081745] [146/156] (366s left) gem_ctx_persistence (legacy-engines-persistence) [672.141355] Starting subtest: legacy-engines-persistence [672.144113] Starting dynamic subtest: render [672.973340] Dynamic subtest render: SUCCESS (0.830s) [672.987832] Starting dynamic subtest: bsd1 [673.736634] Dynamic subtest bsd1: SUCCESS (0.761s) [673.752334] Starting dynamic subtest: bsd2 [674.503781] Dynamic subtest bsd2: SUCCESS (0.763s) [674.518263] Starting dynamic subtest: blt [675.253353] Dynamic subtest blt: SUCCESS (0.747s) [675.266608] Starting dynamic subtest: vebox [676.021612] Dynamic subtest vebox: SUCCESS (0.766s) [676.024238] Subtest legacy-engines-persistence: SUCCESS (3.880s) [676.147254] [147/156] (362s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [676.260599] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [676.265858] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [676.356726] [148/156] (362s left) kms_busy (basic) [676.456087] Starting subtest: basic [676.459127] Starting dynamic subtest: flip [677.086611] Dynamic subtest flip: SUCCESS (0.631s) [677.098134] Starting dynamic subtest: modeset [680.528303] Dynamic subtest modeset: SUCCESS (3.443s) [680.530941] Subtest basic: SUCCESS (4.076s) [681.339424] [149/156] (357s left) kms_cursor_crc (cursor-sliding-64x21) [681.530341] Starting subtest: cursor-sliding-64x21 [681.579739] Subtest cursor-sliding-64x21: SKIP (0.045s) [681.812285] [150/156] (356s left) kms_hdr (bpc-switch) [681.896104] Starting subtest: bpc-switch [683.002149] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [686.505476] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (3.506s) [687.553586] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [691.053254] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (3.510s) [691.056182] Subtest bpc-switch: SUCCESS (9.160s) [691.167861] [151/156] (347s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu) [691.276198] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu [691.282152] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [691.370317] [152/156] (347s left) kms_pm_dc (dc5-retention-flops) [692.472542] Starting subtest: dc5-retention-flops [692.477981] Subtest dc5-retention-flops: SKIP (0.000s) [692.550184] [153/156] (346s left) gem_exec_capture (pi) [692.611068] Starting subtest: pi [692.613850] Starting dynamic subtest: rcs0 [696.652165] Dynamic subtest rcs0: SUCCESS (4.043s) [696.664716] Starting dynamic subtest: bcs0 [700.610479] Dynamic subtest bcs0: SUCCESS (3.958s) [700.624291] Starting dynamic subtest: vcs0 [704.483236] Dynamic subtest vcs0: SUCCESS (3.871s) [704.497346] Starting dynamic subtest: vcs1 [708.477889] Dynamic subtest vcs1: SUCCESS (3.993s) [708.489311] Starting dynamic subtest: vecs0 [712.366482] Dynamic subtest vecs0: SUCCESS (3.886s) [712.378630] Starting dynamic subtest: ccs0 [716.290342] Dynamic subtest ccs0: SUCCESS (3.923s) [716.292957] Subtest pi: SUCCESS (23.682s) [716.384950] [154/156] (322s left) gem_exec_reloc (basic-cpu) [716.500529] Subtest basic-cpu: SKIP (0.000s) [716.571064] [155/156] (322s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [716.679936] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [723.394130] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.720s) [723.532167] [156/156] (315s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [723.635081] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [730.256697] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.625s) [730.387745] Closing watchdogs results: parsing output: 0/ for test: i915_drm_fdinfo results: parsing output: 1/ for test: gem_render_linear_blits results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: gem_mmap_offset results: parsing output: 5/ for test: prime_mmap results: parsing output: 6/ for test: gem_mmap results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: gem_fence_thrash results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: kms_chamelium_edid results: parsing output: 11/ for test: kms_pm_rpm results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: gem_exec_params results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_lmem_swapping results: parsing output: 16/ for test: gem_render_copy results: parsing output: 17/ for test: syncobj_timeline results: parsing output: 18/ for test: core_sysfs results: parsing output: 19/ for test: kms_flip results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_pipe_crc_basic results: parsing output: 23/ for test: i915_query results: parsing output: 24/ for test: gem_mmap results: parsing output: 25/ for test: kms_flip_scaled_crc results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: gem_pxp results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: vgem_basic results: parsing output: 32/ for test: gem_userptr_blits results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: kms_plane_alpha_blend results: parsing output: 35/ for test: kms_psr results: parsing output: 36/ for test: prime_busy results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: gem_exec_schedule results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_psr2_su results: parsing output: 41/ for test: kms_ccs results: parsing output: 42/ for test: kms_cursor_legacy results: parsing output: 43/ for test: kms_psr results: parsing output: 44/ for test: gem_exec_reloc results: parsing output: 45/ for test: kms_content_protection results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: kms_rotation_crc results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: prime_mmap results: parsing output: 51/ for test: i915_drm_fdinfo results: parsing output: 52/ for test: kms_chamelium_hpd results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: perf_pmu results: parsing output: 55/ for test: kms_vblank results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_invalid_mode results: parsing output: 58/ for test: gem_mmap_wc results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_plane results: parsing output: 62/ for test: kms_dp_link_training results: parsing output: 63/ for test: syncobj_basic results: parsing output: 64/ for test: perf_pmu results: parsing output: 65/ for test: gem_exec_params results: parsing output: 66/ for test: kms_cursor_crc results: parsing output: 67/ for test: kms_psr2_sf results: parsing output: 68/ for test: api_intel_allocator results: parsing output: 69/ for test: kms_rotation_crc results: parsing output: 70/ for test: syncobj_wait results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: gem_exec_fence results: parsing output: 74/ for test: gem_ctx_engines results: parsing output: 75/ for test: kms_plane results: parsing output: 76/ for test: gem_wait results: parsing output: 77/ for test: gem_exec_flush results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_cursor_crc results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: kms_vblank results: parsing output: 84/ for test: kms_async_flips results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: sw_sync results: parsing output: 87/ for test: gem_eio results: parsing output: 88/ for test: syncobj_wait results: parsing output: 89/ for test: gem_softpin results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: gem_exec_reloc results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_psr2_sf results: parsing output: 96/ for test: kms_ccs results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: gem_ccs results: parsing output: 99/ for test: gem_mmap_wc results: parsing output: 100/ for test: kms_flip results: parsing output: 101/ for test: gem_exec_schedule results: parsing output: 102/ for test: gem_exec_balancer results: parsing output: 103/ for test: kms_cursor_legacy results: parsing output: 104/ for test: kms_plane_scaling results: parsing output: 105/ for test: perf results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: gen9_exec_parse results: parsing output: 111/ for test: gem_linear_blits results: parsing output: 112/ for test: gem_exec_whisper results: parsing output: 113/ for test: kms_flip results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: gem_ppgtt results: parsing output: 116/ for test: kms_psr results: parsing output: 117/ for test: kms_cursor_legacy results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_psr results: parsing output: 120/ for test: kms_ccs results: parsing output: 121/ for test: kms_color results: parsing output: 122/ for test: syncobj_timeline results: parsing output: 123/ for test: gem_userptr_blits results: parsing output: 124/ for test: gem_exec_params results: parsing output: 125/ for test: kms_cursor_legacy results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: syncobj_timeline results: parsing output: 131/ for test: kms_plane results: parsing output: 132/ for test: kms_ccs results: parsing output: 133/ for test: kms_cursor_legacy results: parsing output: 134/ for test: kms_panel_fitting results: parsing output: 135/ for test: api_intel_bb results: parsing output: 136/ for test: i915_pm_rpm results: parsing output: 137/ for test: gem_exec_gttfill results: parsing output: 138/ for test: gem_lmem_swapping results: parsing output: 139/ for test: gem_exec_parallel results: parsing output: 140/ for test: kms_big_fb results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: gem_fence_thrash results: parsing output: 143/ for test: kms_frontbuffer_tracking results: parsing output: 144/ for test: gem_ctx_persistence results: parsing output: 145/ for test: gem_ctx_persistence results: parsing output: 146/ for test: kms_big_fb results: parsing output: 147/ for test: kms_busy results: parsing output: 148/ for test: kms_cursor_crc results: parsing output: 149/ for test: kms_hdr results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: kms_pm_dc results: parsing output: 152/ for test: gem_exec_capture results: parsing output: 153/ for test: gem_exec_reloc results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.