[58.722435] Initializing watchdogs
[58.722564]   /dev/watchdog0
[58.737928] [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]
[58.742794] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.745190] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.749106] [001/156] (960s left) kms_scaling_modes (scaling-mode-full-aspect)
[58.864135] Starting subtest: scaling-mode-full-aspect
[58.866579] Starting dynamic subtest: pipe-A-eDP-1
[58.984661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.121s)
[58.994616] Starting dynamic subtest: pipe-B-eDP-1
[60.216906] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.226s)
[60.226114] Starting dynamic subtest: pipe-C-eDP-1
[61.428873] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s)
[61.436671] Starting dynamic subtest: pipe-D-eDP-1
[62.579837] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[62.582228] Subtest scaling-mode-full-aspect: SUCCESS (3.704s)
[63.743949] [002/156] (955s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[63.854402] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[63.858797] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[63.945271] [003/156] (955s left) gem_pread (self)
[64.013724] Subtest self: SKIP (0.000s)
[64.071505] [004/156] (955s left) kms_color (invalid-gamma-lut-sizes)
[64.165848] Starting subtest: invalid-gamma-lut-sizes
[64.168265] Starting dynamic subtest: pipe-A
[64.453224] Dynamic subtest pipe-A: SUCCESS (0.288s)
[64.462205] Starting dynamic subtest: pipe-B
[64.464592] Dynamic subtest pipe-B: SUCCESS (0.000s)
[64.472554] Starting dynamic subtest: pipe-C
[64.474972] Dynamic subtest pipe-C: SUCCESS (0.000s)
[64.482794] Starting dynamic subtest: pipe-D
[64.485184] Dynamic subtest pipe-D: SUCCESS (0.000s)
[64.487396] Subtest invalid-gamma-lut-sizes: SUCCESS (0.290s)
[65.288711] [005/156] (954s left) dmabuf_sync_file (export-multiwait)
[65.358218] Starting subtest: export-multiwait
[65.360226] Subtest export-multiwait: SUCCESS (0.001s)
[65.413066] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[65.416451] [006/156] (954s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-pwrite)
[65.510834] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-pwrite
[65.515230] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[65.607792] [007/156] (953s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[65.691799] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[65.694412] Starting dynamic subtest: pipe-A-eDP-1
[65.717595] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[65.727225] Starting dynamic subtest: pipe-B-eDP-1
[65.748212] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[65.755432] Starting dynamic subtest: pipe-C-eDP-1
[65.777165] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[65.784450] Starting dynamic subtest: pipe-D-eDP-1
[65.807248] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[65.811334] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.002s)
[67.943892] [008/156] (951s left) kms_invalid_mode (clock-too-high)
[68.034163] Starting subtest: clock-too-high
[68.036463] Starting dynamic subtest: pipe-A-eDP-1
[68.320749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[68.328773] Starting dynamic subtest: pipe-B-eDP-1
[68.338220] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[68.345683] Starting dynamic subtest: pipe-C-eDP-1
[68.350202] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[68.357321] Starting dynamic subtest: pipe-D-eDP-1
[68.362047] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[68.364394] Subtest clock-too-high: SUCCESS (0.293s)
[69.172186] [009/156] (950s left) api_intel_bb (bb-with-allocator)
[69.224803] Starting subtest: bb-with-allocator
[69.231074] Subtest bb-with-allocator: SUCCESS (0.007s)
[69.350224] [010/156] (950s left) gem_exec_reloc (basic-write-cpu-noreloc)
[69.416904] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[69.491015] [011/156] (950s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[69.597788] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[69.602110] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[69.694531] [012/156] (949s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[69.787493] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[69.791735] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[69.871407] [013/156] (949s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[69.965787] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[69.970174] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[70.069245] [014/156] (949s left) perf (unprivileged-single-ctx-counters)
[70.193074] Starting subtest: unprivileged-single-ctx-counters
[70.196461] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[70.234500] [015/156] (949s left) kms_async_flips (crc)
[70.320084] Starting subtest: crc
[70.697068] Starting dynamic subtest: pipe-A-eDP-1
[73.585385] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.886s)
[73.960487] Starting dynamic subtest: pipe-B-eDP-1
[76.925980] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.971s)
[77.299166] Starting dynamic subtest: pipe-C-eDP-1
[80.234972] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.944s)
[80.616669] Starting dynamic subtest: pipe-D-eDP-1
[83.466844] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.859s)
[83.469306] Subtest crc: SUCCESS (13.142s)
[84.637956] [016/156] (935s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[84.732088] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[84.734366] Starting dynamic subtest: pipe-A-eDP-1
[84.759248] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[84.767397] Starting dynamic subtest: pipe-B-eDP-1
[84.791408] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[84.799207] Starting dynamic subtest: pipe-C-eDP-1
[84.823124] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[84.831116] Starting dynamic subtest: pipe-D-eDP-1
[84.855354] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[84.859434] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[87.004709] [017/156] (932s left) kms_psr (fbc-pr-primary-mmap-gtt)
[87.100067] Starting subtest: fbc-pr-primary-mmap-gtt
[87.104144] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[87.173831] [018/156] (932s left) gem_exec_reloc (basic-gtt-read-noreloc)
[87.226768] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[87.292646] [019/156] (932s left) kms_getfb (getfb2-handle-zero)
[87.383200] Starting subtest: getfb2-handle-zero
[87.385448] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[87.471372] [020/156] (932s left) gem_exec_whisper (basic-fds-forked-all)
[87.527357] Starting subtest: basic-fds-forked-all
[107.807864] Subtest basic-fds-forked-all: SUCCESS (20.274s)
[107.993047] [021/156] (912s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[108.112342] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[108.116608] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[108.184594] [022/156] (911s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[108.312083] Starting subtest: basic-flip-after-cursor-atomic
[109.265451] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.953s)
[110.145560] [023/156] (909s left) perf_pmu (busy-hang)
[110.187836] Starting subtest: busy-hang
[110.190401] Starting dynamic subtest: rcs0
[111.467479] Dynamic subtest rcs0: SUCCESS (1.278s)
[111.478780] Starting dynamic subtest: bcs0
[112.712074] Dynamic subtest bcs0: SUCCESS (1.245s)
[112.723540] Starting dynamic subtest: vcs0
[114.822099] Dynamic subtest vcs0: SUCCESS (2.109s)
[114.833376] Starting dynamic subtest: vcs1
[116.801147] Dynamic subtest vcs1: SUCCESS (1.977s)
[116.810613] Starting dynamic subtest: vecs0
[118.788455] Dynamic subtest vecs0: SUCCESS (1.986s)
[118.799865] Starting dynamic subtest: ccs0
[120.037121] Dynamic subtest ccs0: SUCCESS (1.247s)
[120.039795] Subtest busy-hang: SUCCESS (9.851s)
[120.156632] [024/156] (900s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[120.264659] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[120.268758] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[120.390528] [025/156] (899s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[120.484285] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[120.488545] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[120.593909] [026/156] (899s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-wc)
[120.693561] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-wc
[120.697768] Subtest fbcpsrhdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[120.793924] [027/156] (899s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[120.898802] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[120.903216] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[120.991742] [028/156] (899s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[121.083908] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[121.087507] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[121.159981] [029/156] (899s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[121.250538] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[121.253840] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[121.320361] [030/156] (899s left) gem_exec_reloc (basic-wc-active)
[121.378474] Subtest basic-wc-active: SKIP (0.000s)
[121.452026] [031/156] (898s left) i915_pm_rps (thresholds-idle-park)
[121.506481] Starting subtest: thresholds-idle-park
[121.510182] Subtest thresholds-idle-park: SKIP (0.000s)
[121.634749] [032/156] (898s left) gem_exec_schedule (implicit-boths)
[121.702733] Starting subtest: implicit-boths
[121.704502] Starting dynamic subtest: rcs0
[121.815209] Dynamic subtest rcs0: SUCCESS (0.116s)
[121.827067] Starting dynamic subtest: vcs0
[121.902277] Dynamic subtest vcs0: SUCCESS (0.086s)
[121.913043] Starting dynamic subtest: vcs1
[121.980026] Dynamic subtest vcs1: SUCCESS (0.077s)
[121.991835] Starting dynamic subtest: vecs0
[122.053377] Dynamic subtest vecs0: SUCCESS (0.074s)
[122.064416] Starting dynamic subtest: ccs0
[122.152693] Dynamic subtest ccs0: SUCCESS (0.098s)
[122.155064] Subtest implicit-boths: SUCCESS (0.453s)
[123.341783] [033/156] (897s left) kms_dsc (dsc-with-bpc-formats)
[123.430126] Starting subtest: dsc-with-bpc-formats
[123.539584] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[123.578802] [034/156] (896s left) syncobj_timeline (multi-wait-all-available-submitted)
[123.633601] Starting subtest: multi-wait-all-available-submitted
[123.636098] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[123.733426] [035/156] (896s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[123.816902] Starting subtest: nonblocking-crc-frame-sequence
[123.819083] Starting dynamic subtest: pipe-A-eDP-1
[124.575941] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.759s)
[124.586399] Starting dynamic subtest: pipe-B-eDP-1
[125.983082] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s)
[125.993465] Starting dynamic subtest: pipe-C-eDP-1
[127.360661] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[127.373169] Starting dynamic subtest: pipe-D-eDP-1
[128.789674] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.428s)
[128.792230] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.975s)
[129.690516] [036/156] (890s left) kms_flip (flip-vs-panning-interruptible)
[129.784151] Starting subtest: flip-vs-panning-interruptible
[129.786364] Starting dynamic subtest: A-eDP1
[138.496775] Dynamic subtest A-eDP1: SUCCESS (8.712s)
[138.508305] Starting dynamic subtest: B-eDP1
[147.232032] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[147.241290] Starting dynamic subtest: C-eDP1
[155.951706] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[155.963310] Starting dynamic subtest: D-eDP1
[164.686772] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[164.688786] Subtest flip-vs-panning-interruptible: SUCCESS (34.905s)
[165.869316] [037/156] (854s left) gem_eio (create)
[166.104980] Starting subtest: create
[166.432910] Subtest create: SUCCESS (0.329s)
[166.574428] [038/156] (854s left) gem_lmem_swapping (parallel-random-verify-ccs)
[166.617747] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[166.659631] [039/156] (854s left) gen7_exec_parse (basic-allocation)
[166.722412] Subtest basic-allocation: SKIP (0.000s)
[166.801394] [040/156] (853s left) perf_pmu (invalid-init)
[166.840186] Starting subtest: invalid-init
[166.842188] Subtest invalid-init: SUCCESS (0.000s)
[166.951294] [041/156] (853s left) gem_exec_fence (parallel)
[167.128751] Starting subtest: parallel
[167.131315] Starting dynamic subtest: rcs0
[169.285094] Dynamic subtest rcs0: SUCCESS (2.156s)
[169.297476] Starting dynamic subtest: bcs0
[171.433993] Dynamic subtest bcs0: SUCCESS (2.148s)
[171.442783] Starting dynamic subtest: vcs0
[173.587595] Dynamic subtest vcs0: SUCCESS (2.152s)
[173.598278] Starting dynamic subtest: vcs1
[175.739841] Dynamic subtest vcs1: SUCCESS (2.152s)
[175.751212] Starting dynamic subtest: vecs0
[177.895034] Dynamic subtest vecs0: SUCCESS (2.155s)
[177.906904] Starting dynamic subtest: ccs0
[180.050490] Dynamic subtest ccs0: SUCCESS (2.155s)
[180.052643] Subtest parallel: SUCCESS (12.923s)
[182.335678] [042/156] (838s left) gem_exec_flush (basic-wb-ro-default)
[182.393655] Starting subtest: basic-wb-ro-default
[187.860460] Subtest basic-wb-ro-default: SUCCESS (5.466s)
[188.049832] [043/156] (832s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[188.100429] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[188.104665] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[188.283803] [044/156] (832s left) kms_cursor_crc (cursor-random-512x512)
[188.566901] Starting subtest: cursor-random-512x512
[188.571380] Subtest cursor-random-512x512: SKIP (0.001s)
[188.726119] [045/156] (832s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[188.775481] Starting subtest: framebuffer-vs-set-tiling
[188.780021] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[188.922800] [046/156] (832s left) sysfs_heartbeat_interval (nopreempt)
[188.981250] Starting subtest: nopreempt
[188.983484] Starting dynamic subtest: vecs0
[198.272672] Dynamic subtest vecs0: SUCCESS (9.287s)
[198.285574] Starting dynamic subtest: ccs0
[202.280922] Dynamic subtest ccs0: SUCCESS (4.009s)
[202.293221] Starting dynamic subtest: vcs0
[212.284787] Dynamic subtest vcs0: SUCCESS (9.998s)
[212.294769] Starting dynamic subtest: bcs0
[216.187788] Dynamic subtest bcs0: SUCCESS (3.904s)
[216.197520] Starting dynamic subtest: rcs0
[220.193534] Dynamic subtest rcs0: SUCCESS (4.005s)
[220.204091] Starting dynamic subtest: vcs1
[229.310249] Dynamic subtest vcs1: SUCCESS (9.113s)
[229.312906] Subtest nopreempt: SUCCESS (40.326s)
[229.385334] [047/156] (791s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[229.492625] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc
[229.496889] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[229.593712] [048/156] (791s left) kms_universal_plane (cursor-fb-leak)
[229.681555] Starting subtest: cursor-fb-leak
[229.683899] Starting dynamic subtest: pipe-A-eDP-1
[230.026069] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.346s)
[230.041177] Starting dynamic subtest: pipe-B-eDP-1
[231.379542] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.351s)
[231.389891] Starting dynamic subtest: pipe-C-eDP-1
[232.709902] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.328s)
[232.722609] Starting dynamic subtest: pipe-D-eDP-1
[234.030294] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[234.032790] Subtest cursor-fb-leak: SUCCESS (4.352s)
[235.190133] [049/156] (785s left) kms_pm_rpm (system-suspend-modeset)
[237.522656] Starting subtest: system-suspend-modeset
[257.201437] Subtest system-suspend-modeset: SUCCESS (4.359s)
[257.589621] [050/156] (763s left) gem_exec_big (single)
[257.661204] Starting subtest: single
[261.103540] Subtest single: FAIL (3.354s)
[261.148468] [051/156] (760s left) kms_cursor_crc (cursor-sliding-max-size)
[261.510911] Starting subtest: cursor-sliding-max-size
[261.517080] Subtest cursor-sliding-max-size: SKIP (0.000s)
[261.627608] [052/156] (759s left) gem_exec_reloc (basic-write-wc-noreloc)
[261.686396] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[261.774700] [053/156] (759s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[261.877842] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[268.850620] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.952s)
[268.982380] [054/156] (752s left) syncobj_timeline (signal-point-0)
[269.049792] Starting subtest: signal-point-0
[269.052174] Subtest signal-point-0: SUCCESS (0.000s)
[269.169927] [055/156] (752s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[269.267971] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[269.294688] Starting dynamic subtest: pipe-A-plane-0
[269.583743] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[269.594018] Starting dynamic subtest: pipe-A-plane-3
[269.819440] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[270.976408] Starting dynamic subtest: pipe-B-plane-0
[271.278281] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[271.289488] Starting dynamic subtest: pipe-B-plane-3
[271.512008] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[271.828006] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.555s)
[272.651704] [056/156] (748s left) kms_atomic (plane-overlay-legacy)
[272.743734] Starting subtest: plane-overlay-legacy
[272.746104] Starting dynamic subtest: pipe-A-eDP-1
[273.160618] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.417s)
[273.163090] Subtest plane-overlay-legacy: SUCCESS (0.418s)
[273.998329] [057/156] (747s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render)
[274.108013] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render
[274.112244] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[274.208245] [058/156] (747s left) i915_drm_fdinfo (memory-info-shared)
[274.253879] Starting subtest: memory-info-shared
[274.256117] Starting dynamic subtest: smem0
[274.313855] Dynamic subtest smem0: SUCCESS (0.061s)
[274.316299] Subtest memory-info-shared: SUCCESS (0.062s)
[274.400094] [059/156] (747s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[274.496810] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[274.501226] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[274.586334] [060/156] (747s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[274.680026] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[274.684294] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[274.807711] [061/156] (746s left) prime_vgem (basic-fence-mmap)
[274.880049] Starting subtest: basic-fence-mmap
[274.884738] Subtest basic-fence-mmap: SKIP (0.000s)
[274.992857] [062/156] (746s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[275.048816] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[275.111119] [063/156] (746s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[275.224902] Starting subtest: cursorA-vs-flipA-atomic-transitions
[286.426700] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.188s)
[287.230903] [064/156] (734s left) gem_exec_schedule (preempt-other)
[287.309995] Starting subtest: preempt-other
[287.311999] Starting dynamic subtest: rcs0
[287.382522] Dynamic subtest rcs0: SUCCESS (0.075s)
[287.400055] Starting dynamic subtest: bcs0
[287.453215] Dynamic subtest bcs0: SUCCESS (0.069s)
[287.469063] Starting dynamic subtest: vcs0
[287.521586] Dynamic subtest vcs0: SUCCESS (0.068s)
[287.538744] Starting dynamic subtest: vcs1
[287.589395] Dynamic subtest vcs1: SUCCESS (0.067s)
[287.606889] Starting dynamic subtest: vecs0
[287.654517] Dynamic subtest vecs0: SUCCESS (0.064s)
[287.670759] Starting dynamic subtest: ccs0
[287.719717] Dynamic subtest ccs0: SUCCESS (0.064s)
[287.722707] Subtest preempt-other: SUCCESS (0.413s)
[288.670986] [065/156] (733s left) perf_pmu (all-busy-idle-check-all)
[288.709320] Starting subtest: all-busy-idle-check-all
[290.569715] Subtest all-busy-idle-check-all: SUCCESS (1.857s)
[290.667723] [066/156] (731s left) kms_cursor_crc (cursor-offscreen-64x21)
[290.857328] Starting subtest: cursor-offscreen-64x21
[290.908214] Subtest cursor-offscreen-64x21: SKIP (0.045s)
[291.133218] [067/156] (730s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[291.236627] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite
[291.240827] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[291.330221] [068/156] (730s left) kms_pm_lpsp (screens-disabled)
[292.436840] Starting subtest: screens-disabled
[292.440800] Subtest screens-disabled: SKIP (0.000s)
[292.523408] [069/156] (729s left) gem_ctx_engines (execute-one)
[292.583385] Starting subtest: execute-one
[294.842249] Subtest execute-one: SUCCESS (2.258s)
[295.032205] [070/156] (727s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[295.092049] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[295.196518] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[295.291817] [071/156] (726s left) kms_frontbuffer_tracking (hdr-suspend)
[295.399444] Starting subtest: hdr-suspend
[295.403897] Subtest hdr-suspend: SKIP (0.000s)
[295.494239] [072/156] (726s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[295.600313] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[295.604306] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[295.730183] [073/156] (726s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[295.829880] Starting subtest: psr-rgb565-draw-mmap-gtt
[295.833787] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[295.931539] [074/156] (726s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[296.031817] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[296.034150] Starting dynamic subtest: pipe-A-eDP-1
[296.921394] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.881s)
[296.932079] Starting dynamic subtest: pipe-B-eDP-1
[298.535953] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.611s)
[298.548289] Starting dynamic subtest: pipe-C-eDP-1
[300.091580] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.553s)
[300.103426] Starting dynamic subtest: pipe-D-eDP-1
[301.604274] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.511s)
[301.606203] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.563s)
[302.786501] [075/156] (719s left) kms_chamelium_color (gamma)
[302.880035] Subtest gamma: SKIP (0.000s)
[302.925233] [076/156] (719s left) gem_mmap_gtt (big-copy-odd)
[302.988377] Subtest big-copy-odd: SKIP (0.000s)
[303.045111] [077/156] (719s left) kms_frontbuffer_tracking (psr-slowdraw)
[303.151213] Starting subtest: psr-slowdraw
[328.434676] Subtest psr-slowdraw: SUCCESS (25.277s)
[328.595918] [078/156] (693s left) gem_exec_schedule (preempt-self)
[328.670473] Starting subtest: preempt-self
[328.672570] Starting dynamic subtest: rcs0
[328.680172] Dynamic subtest rcs0: SUCCESS (0.019s)
[328.691350] Starting dynamic subtest: bcs0
[328.698226] Dynamic subtest bcs0: SUCCESS (0.017s)
[328.709074] Starting dynamic subtest: vcs0
[328.715111] Dynamic subtest vcs0: SUCCESS (0.016s)
[328.725710] Starting dynamic subtest: vcs1
[328.737830] Dynamic subtest vcs1: SUCCESS (0.022s)
[328.748124] Starting dynamic subtest: vecs0
[328.759088] Dynamic subtest vecs0: SUCCESS (0.021s)
[328.769633] Starting dynamic subtest: ccs0
[328.776071] Dynamic subtest ccs0: SUCCESS (0.016s)
[328.778357] Subtest preempt-self: SUCCESS (0.115s)
[330.742047] [079/156] (691s left) perf_pmu (idle-no-semaphores)
[330.783006] Starting subtest: idle-no-semaphores
[330.785337] Starting dynamic subtest: rcs0
[331.325342] Dynamic subtest rcs0: SUCCESS (0.541s)
[331.336933] Starting dynamic subtest: bcs0
[331.846310] Dynamic subtest bcs0: SUCCESS (0.518s)
[331.857715] Starting dynamic subtest: vcs0
[332.364358] Dynamic subtest vcs0: SUCCESS (0.514s)
[332.378108] Starting dynamic subtest: vcs1
[332.888006] Dynamic subtest vcs1: SUCCESS (0.519s)
[332.901520] Starting dynamic subtest: vecs0
[333.404555] Dynamic subtest vecs0: SUCCESS (0.513s)
[333.417311] Starting dynamic subtest: ccs0
[333.919155] Dynamic subtest ccs0: SUCCESS (0.511s)
[333.922105] Subtest idle-no-semaphores: SUCCESS (3.136s)
[334.033035] [080/156] (688s left) gem_readwrite (new-obj)
[334.090354] Subtest new-obj: SKIP (0.000s)
[334.150159] [081/156] (688s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[334.258357] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[334.262429] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[334.343542] [082/156] (688s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[334.442435] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[334.446774] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[334.543605] [083/156] (688s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[334.644605] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[341.705745] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.065s)
[341.849515] [084/156] (680s left) gem_render_copy (y-tiled)
[341.910742] Starting subtest: y-tiled
[341.915330] Subtest y-tiled: SKIP (0.000s)
[342.100833] [085/156] (680s left) kms_big_fb (linear-8bpp-rotate-270)
[342.206715] Starting subtest: linear-8bpp-rotate-270
[342.227954] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[342.360495] [086/156] (680s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[342.468386] Starting subtest: 4-tiled-8bpp-rotate-270
[342.488853] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[342.620228] [087/156] (680s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[342.726242] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[342.730801] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[342.839690] [088/156] (680s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[342.929805] Starting subtest: bad-aux-stride-yf-tiled-ccs
[342.932114] Starting dynamic subtest: pipe-A-eDP-1
[342.955290] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[342.967756] Starting dynamic subtest: pipe-B-eDP-1
[342.989478] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[343.002640] Starting dynamic subtest: pipe-C-eDP-1
[343.024249] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[343.035193] Starting dynamic subtest: pipe-D-eDP-1
[343.053964] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[343.058124] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[345.217880] [089/156] (677s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[345.318867] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[345.321201] Starting dynamic subtest: pipe-A-default-mode
[348.029043] Dynamic subtest pipe-A-default-mode: SUCCESS (2.710s)
[348.031382] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.712s)
[348.911746] [090/156] (674s left) gem_mmap_offset (isolation)
[348.959401] Starting subtest: isolation
[348.976595] Subtest isolation: SUCCESS (0.006s)
[349.076693] [091/156] (673s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render)
[349.171648] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render
[349.176089] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[349.298135] [092/156] (673s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[349.387461] Starting subtest: fbc-psr-sprite-mmap-cpu
[349.389713] Starting dynamic subtest: eDP-1
[349.393709] Dynamic subtest eDP-1: SKIP (0.000s)
[349.397616] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[349.462517] [093/156] (673s left) vgem_basic (dmabuf-export)
[349.502805] Starting subtest: dmabuf-export
[349.550330] Subtest dmabuf-export: SUCCESS (0.049s)
[349.655890] [094/156] (673s left) gem_exec_params (invalid-bsd2-flag-on-render)
[349.711540] Starting subtest: invalid-bsd2-flag-on-render
[349.713993] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[349.815175] [095/156] (673s left) kms_rotation_crc (primary-rotation-90)
[349.897238] Starting subtest: primary-rotation-90
[349.901020] Subtest primary-rotation-90: SKIP (0.001s)
[349.971815] [096/156] (673s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[350.066986] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[350.070375] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[350.192974] [097/156] (673s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[350.303831] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[350.307725] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[350.398617] [098/156] (672s left) gem_exec_reloc (basic-wc-gtt)
[350.456502] Subtest basic-wc-gtt: SKIP (0.000s)
[350.531965] [099/156] (672s left) kms_flip (2x-flip-vs-expired-vblank)
[350.623354] Starting subtest: 2x-flip-vs-expired-vblank
[350.634570] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[350.722036] [100/156] (672s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[350.808618] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[350.819458] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s)
[350.895835] [101/156] (672s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[350.993983] Starting subtest: x-tiled-8bpp-rotate-180
[352.217936] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.226s)
[352.353434] [102/156] (671s left) kms_vblank (wait-forked-busy)
[352.440966] Starting subtest: wait-forked-busy
[352.442723] Starting dynamic subtest: pipe-A-eDP-1
[354.333552] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.893s)
[354.352389] Starting dynamic subtest: pipe-D-eDP-1
[356.877429] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s)
[356.879850] Subtest wait-forked-busy: SUCCESS (4.442s)
[357.690670] [103/156] (665s left) gem_tiled_pread_basic (basic)
[357.738528] Subtest basic: SKIP (0.000s)
[357.803078] [104/156] (665s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[357.891627] Starting subtest: fbc-psr2-cursor-mmap-cpu
[357.893849] Starting dynamic subtest: eDP-1
[357.897846] Dynamic subtest eDP-1: SKIP (0.000s)
[357.901863] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[357.967614] [105/156] (665s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[358.067010] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[358.069254] Starting dynamic subtest: pipe-A
[358.087139] Dynamic subtest pipe-A: SKIP (0.018s)
[358.098405] Starting dynamic subtest: pipe-B
[358.122274] Dynamic subtest pipe-B: SKIP (0.032s)
[358.133436] Starting dynamic subtest: pipe-C
[358.152399] Dynamic subtest pipe-C: SKIP (0.032s)
[358.163007] Starting dynamic subtest: pipe-D
[358.186080] Dynamic subtest pipe-D: SKIP (0.031s)
[358.190064] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.117s)
[358.296727] [106/156] (665s left) gem_exec_params (no-blt)
[358.355710] Starting subtest: no-blt
[358.357998] Subtest no-blt: SUCCESS (0.002s)
[358.484411] [107/156] (665s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-render)
[358.583621] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-render
[358.587800] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[358.687607] [108/156] (665s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[358.792361] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[358.795819] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[358.899272] [109/156] (664s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[358.946753] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[359.052951] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[359.130825] [110/156] (664s left) gem_exec_balancer (hog)
[359.193795] Starting subtest: hog
[359.198431] Subtest hog: SKIP (0.000s)
[359.494108] [111/156] (664s left) gem_ctx_persistence (heartbeat-hang)
[359.557063] Starting subtest: heartbeat-hang
[359.561708] Subtest heartbeat-hang: SKIP (0.000s)
[359.668710] [112/156] (664s left) kms_lease (lease-invalid-crtc)
[359.763934] Starting subtest: lease-invalid-crtc
[359.766229] Starting dynamic subtest: pipe-A-eDP-1
[359.768503] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[359.779346] Starting dynamic subtest: pipe-B-eDP-1
[359.781441] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[359.791630] Starting dynamic subtest: pipe-C-eDP-1
[359.793524] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[359.803837] Starting dynamic subtest: pipe-D-eDP-1
[359.806056] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[359.808288] Subtest lease-invalid-crtc: SUCCESS (0.008s)
[359.849612] [113/156] (664s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[359.944433] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[359.948608] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[360.042764] [114/156] (663s left) kms_psr (psr2-sprite-blt)
[360.132717] Starting subtest: psr2-sprite-blt
[360.134939] Starting dynamic subtest: eDP-1
[361.864300] Dynamic subtest eDP-1: SUCCESS (1.734s)
[361.866786] Subtest psr2-sprite-blt: SUCCESS (1.735s)
[362.742052] [115/156] (661s left) kms_addfb_basic (addfb25-modifier-no-flag)
[362.849476] Starting subtest: addfb25-modifier-no-flag
[362.851969] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[362.956359] [116/156] (661s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[363.058819] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[363.060996] Starting dynamic subtest: pipe-A-eDP-1
[363.083353] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[363.095730] Starting dynamic subtest: pipe-B-eDP-1
[363.117452] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[363.127739] Starting dynamic subtest: pipe-C-eDP-1
[363.149031] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[363.159294] Starting dynamic subtest: pipe-D-eDP-1
[363.181551] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[363.185718] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[365.325418] [117/156] (658s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[365.432277] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[365.436746] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[365.514480] [118/156] (658s left) i915_fb_tiling (basic-x-tiling)
[365.574514] Subtest basic-x-tiling: SKIP (0.000s)
[365.636457] [119/156] (658s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[365.731735] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[365.736236] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[365.805418] [120/156] (658s left) kms_content_protection (atomic-dpms-hdcp14)
[365.949600] Starting subtest: atomic-dpms-hdcp14
[365.954197] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[366.073891] [121/156] (658s left) i915_pm_rps (engine-order)
[366.137432] Starting subtest: engine-order
[371.455391] Subtest engine-order: SUCCESS (5.321s)
[371.596174] [122/156] (652s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[371.696092] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[371.700378] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[371.799829] [123/156] (652s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt)
[371.898448] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt
[371.902899] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[371.993055] [124/156] (652s left) kms_flip (nonexisting-fb)
[372.085181] Starting subtest: nonexisting-fb
[372.087521] Starting dynamic subtest: A-eDP1
[373.315279] Dynamic subtest A-eDP1: SUCCESS (1.233s)
[373.327520] Starting dynamic subtest: B-eDP1
[374.434729] Dynamic subtest B-eDP1: SUCCESS (1.119s)
[374.451666] Starting dynamic subtest: C-eDP1
[375.572235] Dynamic subtest C-eDP1: SUCCESS (1.135s)
[375.584743] Starting dynamic subtest: D-eDP1
[376.695015] Dynamic subtest D-eDP1: SUCCESS (1.122s)
[376.697400] Subtest nonexisting-fb: SUCCESS (4.618s)
[377.858681] [125/156] (646s left) kms_flip (2x-flip-vs-suspend-interruptible)
[377.951701] Starting subtest: 2x-flip-vs-suspend-interruptible
[377.956327] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s)
[378.061344] [126/156] (646s left) kms_dp_linktrain_fallback (dp-fallback)
[378.152947] Starting subtest: dp-fallback
[378.159518] Subtest dp-fallback: SKIP (0.000s)
[378.238673] [127/156] (646s left) kms_flip (plain-flip-interruptible)
[378.333286] Starting subtest: plain-flip-interruptible
[378.335591] Starting dynamic subtest: A-eDP1
[379.980519] Dynamic subtest A-eDP1: SUCCESS (1.647s)
[379.994123] Starting dynamic subtest: B-eDP1
[381.607856] Dynamic subtest B-eDP1: SUCCESS (1.626s)
[381.620999] Starting dynamic subtest: C-eDP1
[383.223735] Dynamic subtest C-eDP1: SUCCESS (1.614s)
[383.235077] Starting dynamic subtest: D-eDP1
[384.855049] Dynamic subtest D-eDP1: SUCCESS (1.630s)
[384.860791] Subtest plain-flip-interruptible: SUCCESS (6.528s)
[386.031246] [128/156] (638s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[386.131531] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[386.135707] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[386.227922] [129/156] (638s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[386.284536] Subtest untiled-to-tiled: SKIP (0.000s)
[386.359181] [130/156] (638s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[386.455950] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[386.460215] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[386.555019] [131/156] (638s left) gem_exec_flush (basic-batch-kernel-default-wb)
[386.607903] Starting subtest: basic-batch-kernel-default-wb
[393.696239] Subtest basic-batch-kernel-default-wb: SUCCESS (7.089s)
[393.898340] [132/156] (630s left) gem_ctx_persistence (engines-cleanup)
[393.948223] Starting subtest: engines-cleanup
[393.950406] Starting dynamic subtest: rcs0
[394.017022] Dynamic subtest rcs0: SUCCESS (0.069s)
[394.032973] Starting dynamic subtest: bcs0
[394.064414] Dynamic subtest bcs0: SUCCESS (0.046s)
[394.075543] Starting dynamic subtest: vcs0
[394.101128] Dynamic subtest vcs0: SUCCESS (0.035s)
[394.111933] Starting dynamic subtest: vcs1
[394.143358] Dynamic subtest vcs1: SUCCESS (0.040s)
[394.154547] Starting dynamic subtest: vecs0
[394.189166] Dynamic subtest vecs0: SUCCESS (0.044s)
[394.201715] Starting dynamic subtest: ccs0
[394.247282] Dynamic subtest ccs0: SUCCESS (0.056s)
[394.249882] Subtest engines-cleanup: SUCCESS (0.301s)
[394.329558] [133/156] (630s left) gem_ppgtt (blt-vs-render-ctxn)
[394.397151] Starting subtest: blt-vs-render-ctxN
[427.194795] Subtest blt-vs-render-ctxN: SUCCESS (32.793s)
[427.343307] [134/156] (597s left) kms_chamelium_hpd (dp-hpd-fast)
[427.791704] Subtest dp-hpd-fast: SKIP (0.000s)
[428.654457] [135/156] (596s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[428.753299] Starting subtest: y-tiled-32bpp-rotate-0
[428.757950] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[428.844497] [136/156] (596s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[428.942030] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[428.944260] Starting dynamic subtest: pipe-A-eDP-1
[429.667610] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[429.679717] Starting dynamic subtest: pipe-B-eDP-1
[431.483554] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.821s)
[431.496316] Starting dynamic subtest: pipe-C-eDP-1
[433.328069] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.843s)
[433.340562] Starting dynamic subtest: pipe-D-eDP-1
[435.154331] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.825s)
[435.156286] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.205s)
[436.330038] [137/156] (588s left) sw_sync (sync_merge_same)
[436.375131] Starting subtest: sync_merge_same
[436.377644] Subtest sync_merge_same: SUCCESS (0.000s)
[436.431819] [138/156] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[436.532408] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[436.536366] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[436.633560] [139/156] (588s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[436.734993] Starting subtest: fbcpsr-stridechange
[442.949859] Subtest fbcpsr-stridechange: SUCCESS (6.220s)
[443.089771] [140/156] (582s left) gem_busy (semaphore)
[443.266154] Subtest semaphore: SKIP (0.000s)
[443.474506] [141/156] (581s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[443.565487] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[443.570058] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[443.657567] [142/156] (581s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[443.769318] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[443.773534] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[443.909604] [143/156] (581s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[444.008645] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[445.076318] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.067s)
[445.191573] [144/156] (580s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-pwrite)
[445.286459] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-pwrite
[445.290043] Subtest hdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[445.389469] [145/156] (579s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[445.476100] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[445.478115] Starting dynamic subtest: pipe-A
[445.497634] Dynamic subtest pipe-A: SKIP (0.018s)
[445.508890] Starting dynamic subtest: pipe-B
[445.528686] Dynamic subtest pipe-B: SKIP (0.032s)
[445.539547] Starting dynamic subtest: pipe-C
[445.561699] Dynamic subtest pipe-C: SKIP (0.032s)
[445.572272] Starting dynamic subtest: pipe-D
[445.594562] Dynamic subtest pipe-D: SKIP (0.032s)
[445.598176] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.117s)
[445.701851] [146/156] (579s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-blt)
[445.801335] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-blt
[445.804561] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[445.897470] [147/156] (579s left) kms_psr (pr-sprite-render)
[445.987132] Starting subtest: pr-sprite-render
[445.990807] Subtest pr-sprite-render: SKIP (0.000s)
[446.075720] [148/156] (579s left) api_intel_bb (object-reloc-purge-cache)
[446.127330] Starting subtest: object-reloc-purge-cache
[446.131106] Subtest object-reloc-purge-cache: SKIP (0.003s)
[446.243928] [149/156] (579s left) gem_lmem_swapping (massive)
[446.285611] Subtest massive: SKIP (0.000s)
[446.328335] [150/156] (579s left) syncobj_timeline (wait-any-snapshot)
[446.381186] Starting subtest: wait-any-snapshot
[446.464713] Subtest wait-any-snapshot: SUCCESS (0.083s)
[446.543474] [151/156] (579s left) gen7_exec_parse (oacontrol-tracking)
[446.589163] Subtest oacontrol-tracking: SKIP (0.000s)
[446.663355] [152/156] (578s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[446.752798] Starting subtest: fbc-modesetfrombusy
[450.637199] Subtest fbc-modesetfrombusy: SUCCESS (3.888s)
[451.849242] [153/156] (573s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[451.920288] Starting subtest: yf-tiled-ccs-to-y-tiled
[451.924984] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[452.107430] [154/156] (573s left) gem_exec_flush (basic-uc-prw-default)
[452.170083] Starting subtest: basic-uc-prw-default
[457.627050] Subtest basic-uc-prw-default: SUCCESS (5.456s)
[457.831726] [155/156] (567s left) prime_busy (before)
[457.887219] Starting subtest: before
[457.889690] Starting dynamic subtest: rcs0
[457.925740] Dynamic subtest rcs0: SUCCESS (0.037s)
[457.939682] Starting dynamic subtest: bcs0
[457.985554] Dynamic subtest bcs0: SUCCESS (0.059s)
[457.997310] Starting dynamic subtest: vcs0
[458.029011] Dynamic subtest vcs0: SUCCESS (0.041s)
[458.039502] Starting dynamic subtest: vcs1
[458.071989] Dynamic subtest vcs1: SUCCESS (0.042s)
[458.083072] Starting dynamic subtest: vecs0
[458.114031] Dynamic subtest vecs0: SUCCESS (0.041s)
[458.124915] Starting dynamic subtest: ccs0
[458.157131] Dynamic subtest ccs0: SUCCESS (0.042s)
[458.266350] Subtest before: SUCCESS (0.379s)
[458.343059] [156/156] (567s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[458.457645] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[458.462157] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[458.571099] Closing watchdogs
results: parsing output: 0/ for test: kms_scaling_modes
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_pread
results: parsing output: 3/ for test: kms_color
results: parsing output: 4/ for test: dmabuf_sync_file
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_invalid_mode
results: parsing output: 8/ for test: api_intel_bb
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: kms_async_flips
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: kms_getfb
results: parsing output: 19/ for test: gem_exec_whisper
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: i915_pm_rps
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: kms_dsc
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_pipe_crc_basic
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: gem_eio
results: parsing output: 37/ for test: gem_lmem_swapping
results: parsing output: 38/ for test: gen7_exec_parse
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: gem_exec_fence
results: parsing output: 41/ for test: gem_exec_flush
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: sysfs_heartbeat_interval
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_universal_plane
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: gem_exec_big
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: kms_atomic
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: i915_drm_fdinfo
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: prime_vgem
results: parsing output: 61/ for test: gem_mmap_wc
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_pm_lpsp
results: parsing output: 68/ for test: gem_ctx_engines
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_chamelium_color
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: gem_readwrite
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_flip_scaled_crc
results: parsing output: 89/ for test: gem_mmap_offset
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: vgem_basic
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: kms_rotation_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: gem_tiled_pread_basic
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: kms_lease
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: i915_fb_tiling
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: kms_content_protection
results: parsing output: 120/ for test: i915_pm_rps
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_flip
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_dp_linktrain_fallback
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_set_tiling_vs_blt
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_flush
results: parsing output: 131/ for test: gem_ctx_persistence
results: parsing output: 132/ for test: gem_ppgtt
results: parsing output: 133/ for test: kms_chamelium_hpd
results: parsing output: 134/ for test: kms_big_fb
results: parsing output: 135/ for test: kms_ccs
results: parsing output: 136/ for test: sw_sync
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_busy
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_big_fb
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_plane_scaling
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_psr
results: parsing output: 147/ for test: api_intel_bb
results: parsing output: 148/ for test: gem_lmem_swapping
results: parsing output: 149/ for test: syncobj_timeline
results: parsing output: 150/ for test: gen7_exec_parse
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_render_copy
results: parsing output: 153/ for test: gem_exec_flush
results: parsing output: 154/ for test: prime_busy
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.