[55.884115] Initializing watchdogs
[55.884163]   /dev/watchdog0
[55.898883] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[55.903768] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.906273] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.909786] [001/156] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[56.049934] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[59.735884] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.625s)
[60.967925] [002/156] (955s left) gem_exec_reloc (basic-scanout)
[61.034881] Subtest basic-scanout: SKIP (0.000s)
[61.097187] [003/156] (955s left) kms_feature_discovery (display-1x)
[61.193537] Starting subtest: display-1x
[61.195714] Subtest display-1x: SUCCESS (0.000s)
[61.276683] [004/156] (955s left) api_intel_allocator (reloc-allocator)
[61.335981] Starting subtest: reloc-allocator
[61.338109] Starting dynamic subtest: basic
[61.340216] Dynamic subtest basic: SUCCESS (0.004s)
[61.350776] Starting dynamic subtest: parallel-one
[61.352928] Dynamic subtest parallel-one: SUCCESS (0.006s)
[61.362079] Starting dynamic subtest: print
[61.364352] Dynamic subtest print: SUCCESS (0.000s)
[61.371388] Starting dynamic subtest: reuse
[61.373317] Dynamic subtest reuse: SUCCESS (0.000s)
[61.380083] Starting dynamic subtest: fork-reopen-allocator
[61.381971] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[61.384060] Subtest reloc-allocator: SUCCESS (0.024s)
[61.462782] [005/156] (955s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[61.564738] Starting subtest: fbc-pr-sprite-mmap-cpu
[61.569242] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[61.636516] [006/156] (954s left) prime_busy (before)
[61.691781] Starting subtest: before
[61.696722] Starting dynamic subtest: rcs0
[61.734453] Dynamic subtest rcs0: SUCCESS (0.039s)
[61.743674] Starting dynamic subtest: bcs0
[61.781726] Dynamic subtest bcs0: SUCCESS (0.046s)
[61.790815] Starting dynamic subtest: vcs0
[61.821559] Dynamic subtest vcs0: SUCCESS (0.039s)
[61.828757] Starting dynamic subtest: vcs1
[61.861088] Dynamic subtest vcs1: SUCCESS (0.039s)
[61.867971] Starting dynamic subtest: vecs0
[61.901202] Dynamic subtest vecs0: SUCCESS (0.039s)
[61.908207] Starting dynamic subtest: ccs0
[61.942964] Dynamic subtest ccs0: SUCCESS (0.041s)
[62.051891] Subtest before: SUCCESS (0.354s)
[62.135538] [007/156] (954s left) i915_pm_sseu (full-enable)
[62.199255] Subtest full-enable: SKIP (0.000s)
[62.309867] [008/156] (954s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[62.412808] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[62.417031] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[62.502164] [009/156] (954s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[62.604751] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[62.608744] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[62.699936] [010/156] (954s left) gem_basic (create-fd-close)
[62.755091] Starting subtest: create-fd-close
[62.759278] Subtest create-fd-close: SUCCESS (0.000s)
[62.864604] [011/156] (953s left) kms_pm_dc (dc3co-vpb-simulation)
[63.967315] Starting subtest: dc3co-vpb-simulation
[72.736086] Subtest dc3co-vpb-simulation: SKIP (8.722s)
[73.104453] [012/156] (943s left) gem_mmap_gtt (basic-write-read)
[73.188858] Subtest basic-write-read: SKIP (0.000s)
[73.259202] [013/156] (943s left) prime_self_import (export-vs-gem_close-race)
[73.302424] Starting subtest: export-vs-gem_close-race
[78.496145] Subtest export-vs-gem_close-race: SUCCESS (5.185s)
[78.567975] [014/156] (938s left) kms_legacy_colorkey (basic)
[78.669508] Starting subtest: basic
[78.671463] Starting dynamic subtest: pipe-A
[78.712821] Dynamic subtest pipe-A: SUCCESS (0.045s)
[78.722916] Starting dynamic subtest: pipe-B
[78.725244] Dynamic subtest pipe-B: SUCCESS (0.001s)
[78.732105] Starting dynamic subtest: pipe-C
[78.733993] Dynamic subtest pipe-C: SUCCESS (0.000s)
[78.741199] Starting dynamic subtest: pipe-D
[78.743417] Dynamic subtest pipe-D: SUCCESS (0.000s)
[78.745704] Subtest basic: SUCCESS (0.049s)
[78.793043] [015/156] (938s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[78.883281] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[78.885722] Starting dynamic subtest: pipe-A-eDP-1
[78.911773] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[78.921827] Starting dynamic subtest: pipe-B-eDP-1
[78.945980] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[78.956196] Starting dynamic subtest: pipe-C-eDP-1
[78.979625] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[78.988248] Starting dynamic subtest: pipe-D-eDP-1
[79.013099] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[79.017262] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[81.202136] [016/156] (935s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[81.293852] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[81.298106] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[81.379057] [017/156] (935s left) kms_scaling_modes (scaling-mode-center)
[81.473069] Starting subtest: scaling-mode-center
[81.475384] Starting dynamic subtest: pipe-A-eDP-1
[81.567713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[81.577657] Starting dynamic subtest: pipe-B-eDP-1
[82.710611] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.141s)
[82.719321] Starting dynamic subtest: pipe-C-eDP-1
[83.918520] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s)
[83.928275] Starting dynamic subtest: pipe-D-eDP-1
[85.048376] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[85.050777] Subtest scaling-mode-center: SUCCESS (3.575s)
[86.206675] [018/156] (930s left) i915_pm_rpm (gem-idle)
[88.464523] Starting subtest: gem-idle
[94.685164] Subtest gem-idle: SUCCESS (6.220s)
[95.044727] [019/156] (922s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[96.281628] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[96.286089] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[96.377202] [020/156] (920s left) kms_frontbuffer_tracking (fbchdr-shrfb-scaledprimary)
[96.478595] Starting subtest: fbchdr-shrfb-scaledprimary
[96.482805] Subtest fbchdr-shrfb-scaledprimary: SKIP (0.000s)
[96.557343] [021/156] (920s left) gem_tiled_blits (normal)
[96.613728] Subtest normal: SKIP (0.000s)
[96.676053] [022/156] (920s left) kms_selftest (drm_plane_helper)
[96.714068] Starting subtest: drm_plane_helper
[96.722353] Starting dynamic subtest: drm_test_check_plane_state
[96.815143] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.092s)
[96.824122] Starting dynamic subtest: drm_test_check_invalid_plane_state
[96.919425] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.103s)
[96.921739] Subtest drm_plane_helper: SUCCESS (0.204s)
[97.084245] [023/156] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[97.176644] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[97.181210] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[97.274659] [024/156] (920s left) core_getversion (basic)
[97.310844] Starting subtest: basic
[97.314534] Subtest basic: SUCCESS (0.000s)
[97.368845] [025/156] (919s left) gem_exec_balancer (bonded-true-hang)
[97.631335] Starting subtest: bonded-true-hang
[97.636341] Subtest bonded-true-hang: SKIP (0.000s)
[97.730212] [026/156] (919s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y)
[97.838837] Starting subtest: fbcpsrhdr-tiling-y
[97.843085] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s)
[97.920247] [027/156] (919s left) prime_vgem (basic-fence-read)
[98.022929] Starting subtest: basic-fence-read
[98.031932] Subtest basic-fence-read: SKIP (0.007s)
[98.120270] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[98.123092] [028/156] (919s left) kms_cursor_crc (cursor-onscreen-32x10)
[98.280972] Starting subtest: cursor-onscreen-32x10
[98.326870] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[98.583420] [029/156] (918s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[98.676248] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[98.680080] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[98.756644] [030/156] (918s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[98.849908] Starting subtest: primary-yf-tiled-reflect-x-180
[98.909709] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s)
[99.010361] [031/156] (918s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt)
[99.108831] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt
[99.112395] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[99.227663] [032/156] (918s left) kms_frontbuffer_tracking (psrhdr-1p-rte)
[99.322886] Starting subtest: psrhdr-1p-rte
[99.326506] Subtest psrhdr-1p-rte: SKIP (0.000s)
[99.426863] [033/156] (918s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[99.539304] Starting subtest: cursorA-vs-flipA-toggle
[110.679432] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.134s)
[111.558467] [034/156] (906s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[111.781441] Starting subtest: cursor-rapid-movement-128x128
[111.787172] Starting dynamic subtest: pipe-A-eDP-1
[112.365048] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[112.392997] Starting dynamic subtest: pipe-D-eDP-1
[113.590797] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.203s)
[113.593319] Subtest cursor-rapid-movement-128x128: SUCCESS (1.809s)
[114.437384] [035/156] (903s left) i915_drm_fdinfo (virtual-busy-idle)
[114.477608] Starting subtest: virtual-busy-idle
[114.481785] Subtest virtual-busy-idle: SKIP (0.000s)
[114.545119] [036/156] (903s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[114.634879] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[114.637146] Starting dynamic subtest: A-eDP1
[118.272293] Dynamic subtest A-eDP1: SUCCESS (3.633s)
[118.282419] Starting dynamic subtest: B-eDP1
[121.484766] Dynamic subtest B-eDP1: SUCCESS (3.212s)
[121.494618] Starting dynamic subtest: C-eDP1
[124.698806] Dynamic subtest C-eDP1: SUCCESS (3.212s)
[124.709042] Starting dynamic subtest: D-eDP1
[127.922316] Dynamic subtest D-eDP1: SUCCESS (3.221s)
[127.924317] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.286s)
[128.730100] [037/156] (889s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[128.836304] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[128.840625] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[128.960344] [038/156] (888s left) gem_mmap_offset (open-flood)
[129.017358] Starting subtest: open-flood
[150.506635] Subtest open-flood: SUCCESS (21.490s)
[150.605949] [039/156] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[150.716370] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[150.719952] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[150.811093] [040/156] (867s left) sysfs_preempt_timeout (idempotent)
[150.869988] Starting subtest: idempotent
[150.872132] Starting dynamic subtest: vecs0
[150.874106] Dynamic subtest vecs0: SUCCESS (0.000s)
[150.883534] Starting dynamic subtest: ccs0
[150.885383] Dynamic subtest ccs0: SUCCESS (0.000s)
[150.892806] Starting dynamic subtest: vcs0
[150.894510] Dynamic subtest vcs0: SUCCESS (0.000s)
[150.902254] Starting dynamic subtest: bcs0
[150.904042] Dynamic subtest bcs0: SUCCESS (0.000s)
[150.911377] Starting dynamic subtest: rcs0
[150.913236] Dynamic subtest rcs0: SUCCESS (0.000s)
[150.920285] Starting dynamic subtest: vcs1
[150.922072] Dynamic subtest vcs1: SUCCESS (0.000s)
[150.923844] Subtest idempotent: SUCCESS (0.006s)
[150.958873] [041/156] (867s left) gem_lmem_swapping (parallel-multi)
[151.001461] Subtest parallel-multi: SKIP (0.000s)
[151.046939] [042/156] (866s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[151.139294] Starting subtest: fbc-psr-cursor-mmap-gtt
[151.141262] Starting dynamic subtest: eDP-1
[151.144937] Dynamic subtest eDP-1: SKIP (0.000s)
[151.148749] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[151.211667] [043/156] (866s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[151.260616] Starting subtest: multi-wait-for-submit-available-submitted
[151.262706] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[151.364947] [044/156] (866s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[151.468044] Starting subtest: fbc-dirtyfb-ioctl
[151.470099] Starting dynamic subtest: A-eDP-1
[154.123651] Dynamic subtest A-eDP-1: SUCCESS (2.657s)
[154.125991] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.658s)
[154.998655] [045/156] (863s left) kms_invalid_mode (zero-hdisplay)
[155.090114] Starting subtest: zero-hdisplay
[155.092373] Starting dynamic subtest: pipe-A-eDP-1
[155.380117] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[155.390778] Starting dynamic subtest: pipe-B-eDP-1
[155.392963] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[155.400759] Starting dynamic subtest: pipe-C-eDP-1
[155.402975] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[155.412563] Starting dynamic subtest: pipe-D-eDP-1
[155.414887] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[155.417280] Subtest zero-hdisplay: SUCCESS (0.298s)
[156.224474] [046/156] (861s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[156.334352] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[156.338921] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[156.424256] [047/156] (861s left) gem_vm_create (invalid-destroy)
[156.481454] Starting subtest: invalid-destroy
[156.483743] Subtest invalid-destroy: SUCCESS (0.002s)
[156.577929] [048/156] (861s left) gem_compute (compute-square)
[156.629904] Starting subtest: compute-square
[156.634549] Subtest compute-square: SUCCESS (0.006s)
[156.758152] [049/156] (861s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[156.851089] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[156.855174] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[156.937422] [050/156] (861s left) kms_vblank (wait-forked-busy-hang)
[157.033969] Starting subtest: wait-forked-busy-hang
[157.035843] Starting dynamic subtest: pipe-A-eDP-1
[183.053102] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.017s)
[183.066273] Starting dynamic subtest: pipe-D-eDP-1
[198.091360] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.036s)
[198.093768] Subtest wait-forked-busy-hang: SUCCESS (41.059s)
[198.907652] [051/156] (819s left) kms_flip (absolute-wf_vblank)
[199.010660] Starting subtest: absolute-wf_vblank
[199.012584] Starting dynamic subtest: A-eDP1
[207.756418] Dynamic subtest A-eDP1: SUCCESS (8.747s)
[207.764613] Starting dynamic subtest: B-eDP1
[216.485967] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[216.494158] Starting dynamic subtest: C-eDP1
[225.207552] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[225.217865] Starting dynamic subtest: D-eDP1
[233.932237] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[233.935246] Subtest absolute-wf_vblank: SUCCESS (34.925s)
[235.150242] [052/156] (783s left) perf_pmu (busy-no-semaphores)
[235.189278] Starting subtest: busy-no-semaphores
[235.191618] Starting dynamic subtest: rcs0
[235.741436] Dynamic subtest rcs0: SUCCESS (0.551s)
[235.751079] Starting dynamic subtest: bcs0
[236.290432] Dynamic subtest bcs0: SUCCESS (0.546s)
[236.300673] Starting dynamic subtest: vcs0
[236.839799] Dynamic subtest vcs0: SUCCESS (0.546s)
[236.851604] Starting dynamic subtest: vcs1
[238.797431] Dynamic subtest vcs1: SUCCESS (1.954s)
[238.809037] Starting dynamic subtest: vecs0
[240.843728] Dynamic subtest vecs0: SUCCESS (2.044s)
[240.854870] Starting dynamic subtest: ccs0
[242.826497] Dynamic subtest ccs0: SUCCESS (1.980s)
[242.829508] Subtest busy-no-semaphores: SUCCESS (7.638s)
[242.945382] [053/156] (775s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[243.040885] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[243.043042] Starting dynamic subtest: pipe-A-eDP-1
[243.065043] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[243.075530] Starting dynamic subtest: pipe-B-eDP-1
[243.096703] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[243.104836] Starting dynamic subtest: pipe-C-eDP-1
[243.125618] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[243.133959] Starting dynamic subtest: pipe-D-eDP-1
[243.156095] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[243.160105] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[245.302381] [054/156] (773s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[245.358731] Starting subtest: y-tiled-ccs-to-x-tiled
[245.363187] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[245.553426] [055/156] (772s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render)
[245.655679] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render
[245.659892] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[245.758766] [056/156] (772s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[245.846156] Starting subtest: pixel-format-linear-modifier-source-clamping
[245.872657] Starting dynamic subtest: pipe-A-plane-0
[246.450524] Dynamic subtest pipe-A-plane-0: SUCCESS (0.577s)
[246.459658] Starting dynamic subtest: pipe-A-plane-3
[246.872154] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[247.993910] Starting dynamic subtest: pipe-B-plane-0
[248.564402] Dynamic subtest pipe-B-plane-0: SUCCESS (0.577s)
[248.573083] Starting dynamic subtest: pipe-B-plane-3
[248.999094] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s)
[249.307689] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.460s)
[250.194350] [057/156] (768s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[250.294576] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[250.298882] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[250.402278] [058/156] (768s left) kms_pm_lpsp (kms-lpsp)
[251.510485] Starting subtest: kms-lpsp
[251.512914] Starting dynamic subtest: pipe-A-eDP-1
[251.656791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.148s)
[251.966516] Subtest kms-lpsp: SUCCESS (0.457s)
[252.810949] [059/156] (765s left) kms_chamelium_edid (dp-mode-timings)
[253.204365] Subtest dp-mode-timings: SKIP (0.000s)
[254.019159] [060/156] (764s left) kms_addfb_basic (invalid-set-prop)
[254.076033] Starting subtest: invalid-set-prop
[254.078217] Subtest invalid-set-prop: SUCCESS (0.000s)
[254.241357] [061/156] (764s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[254.351917] Starting subtest: 4-tiled-8bpp-rotate-0
[255.556549] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.205s)
[255.678250] [062/156] (763s left) gem_mmap_wc (bad-object)
[255.732123] Subtest bad-object: SKIP (0.000s)
[255.790110] [063/156] (763s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[255.907094] Starting subtest: verify-pxp-stale-buf-optout-execution
[256.964740] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.058s)
[257.075574] [064/156] (761s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[257.169245] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[257.171509] Starting dynamic subtest: pipe-A-default-mode
[259.863528] Dynamic subtest pipe-A-default-mode: SUCCESS (2.695s)
[259.865978] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.697s)
[260.733261] [065/156] (758s left) gen9_exec_parse (unaligned-access)
[260.797873] Subtest unaligned-access: SKIP (0.000s)
[260.874609] [066/156] (758s left) kms_addfb_basic (no-handle)
[260.920926] Starting subtest: no-handle
[260.923086] Subtest no-handle: SUCCESS (0.000s)
[261.062501] [067/156] (757s left) fbdev (eof)
[261.108032] Starting subtest: eof
[261.110352] Subtest eof: SUCCESS (0.000s)
[261.175729] [068/156] (757s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[261.271748] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[261.275985] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[261.394216] [069/156] (757s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[261.500399] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[261.505380] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[261.609336] [070/156] (757s left) gem_mmap_gtt (big-copy)
[261.670814] Subtest big-copy: SKIP (0.000s)
[261.725312] [071/156] (757s left) gem_basic (create-close)
[261.779528] Starting subtest: create-close
[261.783328] Subtest create-close: SUCCESS (0.000s)
[261.876442] [072/156] (757s left) kms_psr (pr-primary-blt)
[261.964752] Starting subtest: pr-primary-blt
[261.968671] Subtest pr-primary-blt: SKIP (0.000s)
[262.047189] [073/156] (757s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[262.106097] Starting subtest: yf-tiled-to-vebox-yf-tiled
[262.109829] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[262.288303] [074/156] (757s left) gem_mmap_gtt (big-bo-tiledy)
[262.352781] Subtest big-bo-tiledY: SKIP (0.000s)
[262.413180] [075/156] (756s left) kms_chamelium_hpd (hdmi-hpd-fast)
[262.792352] Subtest hdmi-hpd-fast: SKIP (0.000s)
[263.631346] [076/156] (755s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[263.742256] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[263.744656] Starting dynamic subtest: pipe-A-eDP-1
[263.838619] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[263.849176] Starting dynamic subtest: pipe-B-eDP-1
[265.026540] Dynamic subtest pipe-B-eDP-1: SKIP (1.186s)
[265.031051] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.290s)
[266.300500] [077/156] (753s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[266.410753] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[266.415044] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[266.509362] [078/156] (752s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[266.598990] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[266.601162] Starting dynamic subtest: pipe-A-eDP-1
[266.623051] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[266.632595] Starting dynamic subtest: pipe-B-eDP-1
[266.653962] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[266.662291] Starting dynamic subtest: pipe-C-eDP-1
[266.683740] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[266.691679] Starting dynamic subtest: pipe-D-eDP-1
[266.713578] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[266.718168] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[268.857377] [079/156] (750s left) syncobj_wait (wait-any-snapshot)
[268.906968] Starting subtest: wait-any-snapshot
[268.989774] Subtest wait-any-snapshot: SUCCESS (0.083s)
[269.077627] [080/156] (750s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[269.172912] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[269.177376] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[269.258885] [081/156] (750s left) kms_big_fb (linear-8bpp-rotate-270)
[269.357942] Starting subtest: linear-8bpp-rotate-270
[269.381511] Subtest linear-8bpp-rotate-270: SKIP (0.023s)
[269.493508] [082/156] (750s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu)
[269.590027] Starting subtest: hdr-rgb565-draw-mmap-cpu
[269.594411] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[269.684693] [083/156] (750s left) gem_exec_reloc (basic-cpu-gtt-active)
[269.759643] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[269.824853] [084/156] (749s left) syncobj_timeline (invalid-query-one-illegal-handle)
[269.882842] Starting subtest: invalid-query-one-illegal-handle
[269.885080] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s)
[269.989696] [085/156] (749s left) gem_userptr_blits (dmabuf-sync)
[270.053712] Starting subtest: dmabuf-sync
[270.059808] Subtest dmabuf-sync: SKIP (0.002s)
[270.200394] [086/156] (749s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render)
[270.293121] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render
[270.296490] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[270.394729] [087/156] (749s left) kms_cursor_edge_walk (256x256-right-edge)
[270.493440] Starting subtest: 256x256-right-edge
[270.495372] Starting dynamic subtest: pipe-A-eDP-1
[273.915684] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.421s)
[273.927927] Starting dynamic subtest: pipe-D-eDP-1
[277.056064] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.140s)
[277.058441] Subtest 256x256-right-edge: SUCCESS (6.563s)
[277.880458] [088/156] (742s left) gem_lmem_swapping (random-engines)
[277.923324] Subtest random-engines: SKIP (0.000s)
[277.968219] [089/156] (741s left) gem_ctx_isolation (clean)
[278.037974] Starting subtest: clean
[278.040450] Starting dynamic subtest: rcs0
[278.087478] Dynamic subtest rcs0: SUCCESS (0.049s)
[278.098412] Starting dynamic subtest: bcs0
[278.151401] Dynamic subtest bcs0: SUCCESS (0.062s)
[278.162211] Starting dynamic subtest: vcs0
[278.235758] Dynamic subtest vcs0: SUCCESS (0.083s)
[278.249300] Starting dynamic subtest: vcs1
[279.300266] Dynamic subtest vcs1: SUCCESS (1.063s)
[279.309921] Starting dynamic subtest: vecs0
[281.285233] Dynamic subtest vecs0: SUCCESS (1.984s)
[281.295227] Starting dynamic subtest: ccs0
[283.290201] Dynamic subtest ccs0: SUCCESS (2.003s)
[283.292946] Subtest clean: SUCCESS (5.253s)
[283.524917] [090/156] (736s left) gem_exec_whisper (basic-queues)
[283.591177] Starting subtest: basic-queues
[291.239509] Subtest basic-queues: SUCCESS (7.644s)
[291.421484] [091/156] (728s left) api_intel_bb (lot-of-buffers)
[291.476631] Starting subtest: lot-of-buffers
[292.531321] Subtest lot-of-buffers: SUCCESS (1.055s)
[293.416770] [092/156] (726s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[293.521805] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[293.526251] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[293.629472] [093/156] (726s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[293.716265] Starting subtest: plane-primary-toggle-with-vblank-wait
[293.718546] Starting dynamic subtest: pipe-A-eDP-1
[293.890714] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[294.196705] Starting dynamic subtest: pipe-B-eDP-1
[295.066188] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.877s)
[295.365260] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.650s)
[296.224376] [094/156] (723s left) gem_readwrite (beyond-eob)
[296.285754] Subtest beyond-EOB: SKIP (0.000s)
[296.341408] [095/156] (723s left) gem_exec_fence (basic-wait-all)
[296.410367] Starting subtest: basic-wait-all
[296.507025] Subtest basic-wait-all: SUCCESS (0.098s)
[298.400538] [096/156] (721s left) gem_exec_balancer (parallel-keep-in-fence)
[298.662444] Starting subtest: parallel-keep-in-fence
[299.868210] Subtest parallel-keep-in-fence: SUCCESS (1.205s)
[299.990305] [097/156] (720s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[300.089028] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[300.093093] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[300.181212] [098/156] (720s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-fullscreen)
[300.288904] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-fullscreen
[300.293108] Subtest psrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[300.381430] [099/156] (719s left) perf (invalid-oa-metric-set-id)
[300.498675] Starting subtest: invalid-oa-metric-set-id
[300.512368] Subtest invalid-oa-metric-set-id: SUCCESS (0.014s)
[300.556488] [100/156] (719s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[300.641025] Starting subtest: plane-ctm3x4-lut1d
[300.786813] Starting dynamic subtest: pipe-A-plane-0
[300.967690] Dynamic subtest pipe-A-plane-0: SUCCESS (0.179s)
[300.978825] Starting dynamic subtest: pipe-A-plane-1
[301.130707] Dynamic subtest pipe-A-plane-1: SUCCESS (0.164s)
[301.139625] Starting dynamic subtest: pipe-A-plane-2
[301.287883] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[302.550022] Starting dynamic subtest: pipe-B-plane-0
[302.732574] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[302.741943] Starting dynamic subtest: pipe-B-plane-1
[302.887745] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[302.896855] Starting dynamic subtest: pipe-B-plane-2
[303.076539] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[304.342681] Starting dynamic subtest: pipe-C-plane-0
[304.479907] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[304.489188] Starting dynamic subtest: pipe-C-plane-1
[304.635641] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[304.644709] Starting dynamic subtest: pipe-C-plane-2
[304.780068] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[305.979960] Starting dynamic subtest: pipe-D-plane-0
[306.129619] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[306.139547] Starting dynamic subtest: pipe-D-plane-1
[306.295479] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[306.304830] Starting dynamic subtest: pipe-D-plane-2
[306.461692] Dynamic subtest pipe-D-plane-2: SUCCESS (0.164s)
[306.747182] Subtest plane-ctm3x4-lut1d: SUCCESS (6.108s)
[307.641435] [101/156] (712s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[307.736574] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[307.740867] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[307.819929] [102/156] (712s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[307.913267] Starting subtest: y-tiled-8bpp-rotate-180
[307.917391] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[308.024073] [103/156] (712s left) gem_exec_params (invalid-bsd2-flag-on-render)
[308.088591] Starting subtest: invalid-bsd2-flag-on-render
[308.090980] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[308.208327] [104/156] (712s left) perf_pmu (busy-start)
[308.246753] Starting subtest: busy-start
[308.248850] Starting dynamic subtest: rcs0
[310.794904] Dynamic subtest rcs0: SUCCESS (2.550s)
[310.806999] Starting dynamic subtest: bcs0
[313.346966] Dynamic subtest bcs0: SUCCESS (2.549s)
[313.357947] Starting dynamic subtest: vcs0
[317.317073] Dynamic subtest vcs0: SUCCESS (3.967s)
[317.328985] Starting dynamic subtest: vcs1
[321.285706] Dynamic subtest vcs1: SUCCESS (3.966s)
[321.297035] Starting dynamic subtest: vecs0
[325.317892] Dynamic subtest vecs0: SUCCESS (4.029s)
[325.329773] Starting dynamic subtest: ccs0
[327.868064] Dynamic subtest ccs0: SUCCESS (2.549s)
[327.871332] Subtest busy-start: SUCCESS (19.624s)
[327.965574] [105/156] (692s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[328.072878] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc
[328.077359] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[328.161876] [106/156] (692s left) syncobj_basic (bad-handle-to-fd)
[328.222171] Starting subtest: bad-handle-to-fd
[328.224099] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[328.311388] [107/156] (692s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[328.373442] Starting subtest: wait-all-for-submit-delayed-submit
[328.475609] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[328.566871] [108/156] (692s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[328.674523] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[328.678734] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[328.772029] [109/156] (691s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[328.876719] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[328.881108] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[328.980359] [110/156] (691s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[329.038658] Starting subtest: map-fixed-invalidate-overlap-busy
[329.042676] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[329.154962] [111/156] (691s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-pri-indfb-multidraw)
[329.256864] Starting subtest: fbcpsrhdr-2p-pri-indfb-multidraw
[329.261662] Subtest fbcpsrhdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[329.360222] [112/156] (691s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[329.469583] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[336.081701] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.617s)
[336.194218] [113/156] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[336.292186] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[336.296376] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[336.402779] [114/156] (684s left) gem_userptr_blits (unsync-overlap)
[336.468802] Subtest unsync-overlap: SKIP (0.000s)
[336.590086] [115/156] (684s left) gem_ctx_sseu (mmap-args)
[336.652288] Subtest mmap-args: SKIP (0.000s)
[336.708260] [116/156] (684s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[336.810102] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[336.812263] Starting dynamic subtest: pipe-A-eDP-1
[336.869326] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[336.878061] Starting dynamic subtest: pipe-B-eDP-1
[336.936039] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[336.945692] Starting dynamic subtest: pipe-C-eDP-1
[337.002993] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[337.011976] Starting dynamic subtest: pipe-D-eDP-1
[337.059022] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[337.064058] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[339.125910] [117/156] (681s left) gem_mmap_gtt (medium-copy)
[339.196949] Subtest medium-copy: SKIP (0.000s)
[339.259079] [118/156] (681s left) kms_flip (bo-too-big-interruptible)
[339.358734] Starting subtest: bo-too-big-interruptible
[339.360939] Starting dynamic subtest: A-eDP1
[340.675669] Dynamic subtest A-eDP1: SUCCESS (1.317s)
[340.686534] Starting dynamic subtest: B-eDP1
[342.005248] Dynamic subtest B-eDP1: SUCCESS (1.328s)
[342.015683] Starting dynamic subtest: C-eDP1
[343.335083] Dynamic subtest C-eDP1: SUCCESS (1.329s)
[343.346668] Starting dynamic subtest: D-eDP1
[344.666367] Dynamic subtest D-eDP1: SUCCESS (1.330s)
[344.672954] Subtest bo-too-big-interruptible: SUCCESS (5.316s)
[345.873424] [119/156] (675s left) kms_atomic (plane-invalid-params-fence)
[345.966141] Starting subtest: plane-invalid-params-fence
[345.968414] Starting dynamic subtest: pipe-A-eDP-1
[346.330072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.365s)
[346.332452] Subtest plane-invalid-params-fence: SUCCESS (0.367s)
[347.208889] [120/156] (674s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[347.301320] Starting subtest: plane-scaler-unity-scaling-with-rotation
[347.303228] Starting dynamic subtest: pipe-A
[347.527057] Dynamic subtest pipe-A: SUCCESS (0.228s)
[347.536972] Starting dynamic subtest: pipe-B
[348.793131] Dynamic subtest pipe-B: SUCCESS (1.265s)
[348.801932] Starting dynamic subtest: pipe-C
[350.121644] Dynamic subtest pipe-C: SUCCESS (1.327s)
[350.131332] Starting dynamic subtest: pipe-D
[351.477796] Dynamic subtest pipe-D: SUCCESS (1.355s)
[351.480129] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.179s)
[352.652089] [121/156] (668s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[352.705199] Starting subtest: etime-single-wait-available-unsubmitted
[352.810051] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.104s)
[352.900521] [122/156] (668s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[352.998857] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[353.003214] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[353.108909] [123/156] (668s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-pgflip-blt)
[353.214724] Starting subtest: psrhdr-2p-primscrn-shrfb-pgflip-blt
[353.218737] Subtest psrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[353.310098] [124/156] (668s left) kms_atomic_interruptible (universal-setplane-cursor)
[353.409981] Starting subtest: universal-setplane-cursor
[353.412312] Starting dynamic subtest: pipe-A-eDP-1
[360.864963] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.452s)
[360.866965] Subtest universal-setplane-cursor: SUCCESS (7.453s)
[361.706679] [125/156] (659s left) kms_frontbuffer_tracking (hdr-2p-rte)
[361.828514] Starting subtest: hdr-2p-rte
[361.832879] Subtest hdr-2p-rte: SKIP (0.000s)
[361.932688] [126/156] (659s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[362.036987] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[362.851426] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[363.011972] [127/156] (658s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[363.108378] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[363.110253] Starting dynamic subtest: pipe-A-eDP-1
[365.412692] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.306s)
[365.423819] Starting dynamic subtest: pipe-B-eDP-1
[367.812031] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.397s)
[367.820809] Starting dynamic subtest: pipe-C-eDP-1
[370.019285] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.206s)
[370.028819] Starting dynamic subtest: pipe-D-eDP-1
[372.225571] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.205s)
[372.227532] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (9.120s)
[373.442681] [128/156] (648s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[373.547284] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[377.736928] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.195s)
[378.937454] [129/156] (642s left) gem_exec_schedule (preempt-self)
[379.009214] Starting subtest: preempt-self
[379.011109] Starting dynamic subtest: rcs0
[379.026822] Dynamic subtest rcs0: SUCCESS (0.022s)
[379.037612] Starting dynamic subtest: bcs0
[379.047752] Dynamic subtest bcs0: SUCCESS (0.020s)
[379.060397] Starting dynamic subtest: vcs0
[379.069069] Dynamic subtest vcs0: SUCCESS (0.021s)
[379.079017] Starting dynamic subtest: vcs1
[379.088343] Dynamic subtest vcs1: SUCCESS (0.018s)
[379.098185] Starting dynamic subtest: vecs0
[379.105655] Dynamic subtest vecs0: SUCCESS (0.016s)
[379.114851] Starting dynamic subtest: ccs0
[379.128231] Dynamic subtest ccs0: SUCCESS (0.021s)
[379.130409] Subtest preempt-self: SUCCESS (0.125s)
[380.397728] [130/156] (641s left) gem_ctx_shared (detached-shared-gtt)
[380.456886] Starting subtest: detached-shared-gtt
[382.612187] Subtest detached-shared-gtt: SUCCESS (2.153s)
[382.945978] [131/156] (638s left) kms_pm_rpm (system-suspend-idle)
[384.480734] Starting subtest: system-suspend-idle
[403.317528] Subtest system-suspend-idle: SUCCESS (4.429s)
[403.733204] [132/156] (617s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[403.852328] Starting subtest: psr-indfb-scaledprimary
[409.688112] Subtest psr-indfb-scaledprimary: SUCCESS (5.717s)
[409.832459] [133/156] (611s left) kms_flip (bo-too-big)
[409.941865] Starting subtest: bo-too-big
[409.944050] Starting dynamic subtest: A-eDP1
[411.257161] Dynamic subtest A-eDP1: SUCCESS (1.297s)
[411.271802] Starting dynamic subtest: B-eDP1
[412.599523] Dynamic subtest B-eDP1: SUCCESS (1.325s)
[412.612110] Starting dynamic subtest: C-eDP1
[413.952007] Dynamic subtest C-eDP1: SUCCESS (1.340s)
[413.964939] Starting dynamic subtest: D-eDP1
[415.285776] Dynamic subtest D-eDP1: SUCCESS (1.322s)
[415.292639] Subtest bo-too-big: SUCCESS (5.298s)
[416.491545] [134/156] (605s left) gen9_exec_parse (shadow-peek)
[416.549117] Subtest shadow-peek: SKIP (0.000s)
[416.667090] [135/156] (605s left) gem_tiled_fence_blits (basic)
[416.725435] Subtest basic: SKIP (0.000s)
[416.810011] [136/156] (605s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[416.905010] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[416.908863] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[417.017856] [137/156] (604s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[417.119355] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[417.123409] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[417.263675] [138/156] (604s left) gem_exec_fence (parallel)
[417.434819] Starting subtest: parallel
[417.437436] Starting dynamic subtest: rcs0
[419.593305] Dynamic subtest rcs0: SUCCESS (2.149s)
[419.603880] Starting dynamic subtest: bcs0
[421.755110] Dynamic subtest bcs0: SUCCESS (2.153s)
[421.765438] Starting dynamic subtest: vcs0
[423.912084] Dynamic subtest vcs0: SUCCESS (2.150s)
[423.923259] Starting dynamic subtest: vcs1
[426.069062] Dynamic subtest vcs1: SUCCESS (2.151s)
[426.079873] Starting dynamic subtest: vecs0
[428.224383] Dynamic subtest vecs0: SUCCESS (2.148s)
[428.235486] Starting dynamic subtest: ccs0
[430.374447] Dynamic subtest ccs0: SUCCESS (2.148s)
[430.376408] Subtest parallel: SUCCESS (12.904s)
[431.035756] [139/156] (591s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[431.145247] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[431.149378] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[431.224326] [140/156] (590s left) gem_reg_read (timestamp-moving)
[431.281398] Starting subtest: timestamp-moving
[432.283221] Subtest timestamp-moving: SUCCESS (1.000s)
[432.376463] [141/156] (589s left) gem_softpin (allocator-nopin-reserve)
[432.434812] Starting subtest: allocator-nopin-reserve
[432.543260] Subtest allocator-nopin-reserve: SUCCESS (0.108s)
[432.681409] [142/156] (589s left) kms_psr (psr-primary-mmap-cpu)
[432.778877] Starting subtest: psr-primary-mmap-cpu
[432.781160] Starting dynamic subtest: eDP-1
[434.521533] Dynamic subtest eDP-1: SUCCESS (1.740s)
[434.523416] Subtest psr-primary-mmap-cpu: SUCCESS (1.741s)
[435.390934] [143/156] (586s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[435.496824] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[435.501408] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[435.598162] [144/156] (586s left) kms_psr (fbc-psr2-sprite-plane-move)
[435.686791] Starting subtest: fbc-psr2-sprite-plane-move
[435.689039] Starting dynamic subtest: eDP-1
[435.693042] Dynamic subtest eDP-1: SKIP (0.000s)
[435.697084] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[435.789014] [145/156] (586s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[435.893020] Starting subtest: psr-1p-pri-indfb-multidraw
[459.202372] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.303s)
[459.329752] [146/156] (563s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[459.427368] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[459.430623] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[459.537685] [147/156] (562s left) kms_pipe_crc_basic (read-crc)
[459.636227] Starting subtest: read-crc
[459.638104] Starting dynamic subtest: pipe-A-eDP-1
[460.354439] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[460.365339] Starting dynamic subtest: pipe-B-eDP-1
[461.710148] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.355s)
[461.720834] Starting dynamic subtest: pipe-C-eDP-1
[463.108103] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[463.119403] Starting dynamic subtest: pipe-D-eDP-1
[464.441282] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[464.443510] Subtest read-crc: SUCCESS (4.803s)
[465.256508] [148/156] (557s left) kms_content_protection (dp-mst-type-0)
[465.391541] Starting subtest: dp-mst-type-0
[465.396319] Subtest dp-mst-type-0: SKIP (0.000s)
[465.514831] [149/156] (557s left) i915_query (query-topology-unsupported)
[465.566265] Starting subtest: query-topology-unsupported
[465.570420] Subtest query-topology-unsupported: SKIP (0.000s)
[465.680907] [150/156] (556s left) gem_exec_schedule (pi-ringfull)
[465.865517] Starting subtest: pi-ringfull
[465.867550] Starting dynamic subtest: rcs0
[465.891046] Dynamic subtest rcs0: SUCCESS (0.028s)
[465.908443] Starting dynamic subtest: bcs0
[465.923082] Dynamic subtest bcs0: SUCCESS (0.031s)
[465.936959] Starting dynamic subtest: vcs0
[465.952491] Dynamic subtest vcs0: SUCCESS (0.029s)
[465.966962] Starting dynamic subtest: vcs1
[465.980026] Dynamic subtest vcs1: SUCCESS (0.027s)
[465.994156] Starting dynamic subtest: vecs0
[466.009437] Dynamic subtest vecs0: SUCCESS (0.029s)
[466.021662] Starting dynamic subtest: ccs0
[466.039243] Dynamic subtest ccs0: SUCCESS (0.029s)
[466.041513] Subtest pi-ringfull: SUCCESS (0.177s)
[466.263946] [151/156] (556s left) kms_async_flips (alternate-sync-async-flip)
[466.358083] Starting subtest: alternate-sync-async-flip
[466.744040] Starting dynamic subtest: pipe-A-eDP-1
[469.559709] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.814s)
[469.945042] Starting dynamic subtest: pipe-B-eDP-1
[472.700594] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.763s)
[473.095896] Starting dynamic subtest: pipe-C-eDP-1
[475.854945] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[476.223740] Starting dynamic subtest: pipe-D-eDP-1
[478.993854] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.779s)
[478.996119] Subtest alternate-sync-async-flip: SUCCESS (12.633s)
[480.174344] [152/156] (542s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[480.228368] Starting subtest: etime-multi-wait-all-available-unsubmitted
[480.338810] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s)
[480.419075] [153/156] (542s left) kms_hdr (static-swap)
[480.507803] Starting subtest: static-swap
[480.510113] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[480.514472] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[480.525193] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[480.529382] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[480.533755] Subtest static-swap: SKIP (0.003s)
[480.584705] [154/156] (542s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[480.695373] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[480.699395] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[480.784429] [155/156] (542s left) kms_flip (flip-vs-fences)
[480.877127] Starting subtest: flip-vs-fences
[480.881552] Subtest flip-vs-fences: SKIP (0.000s)
[480.976860] [156/156] (541s left) gem_softpin (noreloc-interruptible)
[481.037509] Starting subtest: noreloc-interruptible
[486.433094] Subtest noreloc-interruptible: SUCCESS (5.391s)
[486.552421] 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.