[61.016956] Initializing watchdogs [61.017135] /dev/watchdog0 [61.030284] [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] [61.033909] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.035958] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.039226] [001/131] (960s left) kms_psr (fbc-psr-cursor-mmap-gtt) [61.200381] Starting subtest: fbc-psr-cursor-mmap-gtt [61.202604] Starting dynamic subtest: eDP-1 [61.206656] Dynamic subtest eDP-1: SKIP (0.000s) [61.210777] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s) [61.265221] [002/131] (960s left) gem_ctx_param (invalid-ctx-set) [61.323776] Starting subtest: invalid-ctx-set [61.326062] Subtest invalid-ctx-set: SUCCESS (0.002s) [61.428731] [003/131] (960s left) gem_lmem_swapping (verify) [61.472352] Subtest verify: SKIP (0.000s) [61.501094] [004/131] (960s left) kms_cursor_legacy (cursor-vs-flip-atomic) [61.630030] Starting subtest: cursor-vs-flip-atomic [90.748223] Subtest cursor-vs-flip-atomic: SUCCESS (29.101s) [91.562925] [005/131] (930s left) i915_query (test-query-geometry-subslices) [91.628082] Starting subtest: test-query-geometry-subslices [91.630487] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [91.715591] [006/131] (929s left) kms_scaling_modes (scaling-mode-full) [91.808511] Starting subtest: scaling-mode-full [91.810971] Starting dynamic subtest: pipe-A-eDP-1 [91.916756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s) [91.924174] Starting dynamic subtest: pipe-B-eDP-1 [93.098447] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.181s) [93.106892] Starting dynamic subtest: pipe-C-eDP-1 [94.209106] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s) [94.217890] Starting dynamic subtest: pipe-D-eDP-1 [95.335051] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s) [95.337658] Subtest scaling-mode-full: SUCCESS (3.527s) [96.479823] [007/131] (925s left) gem_exec_nop (basic-parallel) [96.555349] Starting subtest: basic-parallel [113.927580] Subtest basic-parallel: SUCCESS (17.380s) [114.153220] [008/131] (907s left) gem_exec_balancer (bonded-semaphore) [114.219655] Starting subtest: bonded-semaphore [114.223876] Subtest bonded-semaphore: SKIP (0.000s) [114.519271] [009/131] (907s left) gem_pread (bench) [114.590283] Subtest bench: SKIP (0.000s) [114.651835] [010/131] (907s left) gem_exec_reloc (basic-concurrent16) [114.719620] Subtest basic-concurrent16: SKIP (0.000s) [114.783025] [011/131] (907s left) kms_vblank (wait-busy-hang) [114.892040] Starting subtest: wait-busy-hang [114.894364] Starting dynamic subtest: pipe-A-eDP-1 [141.662924] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.768s) [141.676754] Starting dynamic subtest: pipe-D-eDP-1 [156.722814] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.055s) [156.725120] Subtest wait-busy-hang: SUCCESS (41.826s) [157.535948] [012/131] (864s left) kms_getfb (getfb2-handle-zero) [157.598303] Starting subtest: getfb2-handle-zero [157.600785] Subtest getfb2-handle-zero: SUCCESS (0.000s) [157.716487] [013/131] (864s left) gem_exec_fence (syncobj-timeline-repeat) [158.270649] Starting subtest: syncobj-timeline-repeat [158.481497] Subtest syncobj-timeline-repeat: SUCCESS (0.210s) [160.010751] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true [160.013861] [014/131] (861s left) kms_prop_blob (invalid-get-prop-any) [160.076958] Starting subtest: invalid-get-prop-any [160.079280] Subtest invalid-get-prop-any: SUCCESS (0.000s) [160.182410] [015/131] (861s left) gem_spin_batch (resubmit) [160.247585] Starting subtest: resubmit [160.250319] Starting dynamic subtest: rcs0 [160.256662] Dynamic subtest rcs0: SUCCESS (0.009s) [160.266666] Starting dynamic subtest: bcs0 [160.269057] Dynamic subtest bcs0: SUCCESS (0.004s) [160.276097] Starting dynamic subtest: vcs0 [160.278425] Dynamic subtest vcs0: SUCCESS (0.003s) [160.284643] Starting dynamic subtest: vcs1 [160.286905] Dynamic subtest vcs1: SUCCESS (0.004s) [160.293083] Starting dynamic subtest: vecs0 [160.295379] Dynamic subtest vecs0: SUCCESS (0.005s) [160.302102] Starting dynamic subtest: ccs0 [160.304371] Dynamic subtest ccs0: SUCCESS (0.003s) [160.306647] Subtest resubmit: SUCCESS (0.028s) [160.504280] [016/131] (861s left) kms_flip (2x-nonexisting-fb) [160.604064] Starting subtest: 2x-nonexisting-fb [160.614419] Subtest 2x-nonexisting-fb: SKIP (0.010s) [160.705739] [017/131] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [160.813679] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [160.817682] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [160.915679] [018/131] (861s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [161.013361] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [164.453665] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (3.443s) [164.576919] [019/131] (857s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt) [164.675795] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt [164.679217] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [164.767144] [020/131] (857s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [164.865597] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [164.870122] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [165.985354] [021/131] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [166.096728] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [166.101048] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [166.198047] [022/131] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [166.299459] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [166.303851] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [166.394188] [023/131] (855s left) kms_psr (fbc-psr-sprite-mmap-cpu) [166.492082] Starting subtest: fbc-psr-sprite-mmap-cpu [166.494274] Starting dynamic subtest: eDP-1 [166.498160] Dynamic subtest eDP-1: SKIP (0.000s) [166.502067] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s) [166.555829] [024/131] (855s left) gem_ctx_persistence (userptr) [166.609277] Starting subtest: userptr [166.831751] Subtest userptr: SUCCESS (0.222s) [166.901559] [025/131] (855s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [166.995752] Starting subtest: plane-all-modeset-transition-fencing [166.999495] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s) [167.060175] [026/131] (855s left) gem_mmap_wc (read) [167.114596] Subtest read: SKIP (0.000s) [167.175546] [027/131] (855s left) gem_mmap_wc (bad-size) [167.228357] Subtest bad-size: SKIP (0.000s) [167.275287] [028/131] (855s left) i915_hangman (gt-engine-hang) [167.349632] Starting subtest: gt-engine-hang [167.351583] Starting dynamic subtest: rcs0 [168.904490] Dynamic subtest rcs0: SUCCESS (1.553s) [168.914972] Starting dynamic subtest: bcs0 [170.887818] Dynamic subtest bcs0: SUCCESS (1.982s) [170.895923] Starting dynamic subtest: vcs0 [172.872579] Dynamic subtest vcs0: SUCCESS (1.985s) [172.881640] Starting dynamic subtest: vcs1 [174.920069] Dynamic subtest vcs1: SUCCESS (2.047s) [174.929538] Starting dynamic subtest: vecs0 [176.903895] Dynamic subtest vecs0: SUCCESS (1.983s) [176.913745] Starting dynamic subtest: ccs0 [178.889438] Dynamic subtest ccs0: SUCCESS (1.985s) [178.892471] Subtest gt-engine-hang: SUCCESS (11.538s) [178.962361] [029/131] (843s left) kms_cursor_crc (cursor-rapid-movement-128x42) [179.156308] Starting subtest: cursor-rapid-movement-128x42 [179.195943] Subtest cursor-rapid-movement-128x42: SKIP (0.035s) [179.389906] [030/131] (843s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [179.485973] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [179.488319] Starting dynamic subtest: pipe-A-eDP-1 [179.546061] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [179.554036] Starting dynamic subtest: pipe-B-eDP-1 [179.612719] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [179.621281] Starting dynamic subtest: pipe-C-eDP-1 [179.679491] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [179.687460] Starting dynamic subtest: pipe-D-eDP-1 [179.750149] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [179.754626] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s) [181.630147] [031/131] (840s left) kms_flip (blocking-wf_vblank) [181.730038] Starting subtest: blocking-wf_vblank [181.732429] Starting dynamic subtest: A-eDP1 [190.678969] Dynamic subtest A-eDP1: SUCCESS (8.948s) [190.686414] Starting dynamic subtest: B-eDP1 [199.606383] Dynamic subtest B-eDP1: SUCCESS (8.926s) [199.618212] Starting dynamic subtest: C-eDP1 [208.515495] Dynamic subtest C-eDP1: SUCCESS (8.908s) [208.522268] Starting dynamic subtest: D-eDP1 [217.442622] Dynamic subtest D-eDP1: SUCCESS (8.926s) [217.447158] Subtest blocking-wf_vblank: SUCCESS (35.716s) [218.647888] [032/131] (803s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [218.709940] Starting subtest: y-tiled-to-vebox-y-tiled [218.714693] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [218.896891] [033/131] (803s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [218.958266] Starting subtest: mixed-tiled-to-y-tiled-ccs [218.962076] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [219.134474] [034/131] (803s left) gem_eio (wait-wedge-1us) [219.339276] Starting subtest: wait-wedge-1us [220.962868] Subtest wait-wedge-1us: SUCCESS (1.624s) [221.114263] [035/131] (801s left) gem_userptr_blits (stress-mm-invalidate-close) [221.175483] Starting subtest: stress-mm-invalidate-close [223.322625] Subtest stress-mm-invalidate-close: SUCCESS (2.148s) [223.455598] [036/131] (799s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [223.563420] Starting subtest: psr-rgb101010-draw-mmap-cpu [228.395595] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (4.836s) [228.502517] [037/131] (794s left) syncobj_wait (single-wait-all-signaled) [228.558614] Starting subtest: single-wait-all-signaled [228.560714] Subtest single-wait-all-signaled: SUCCESS (0.000s) [228.662872] [038/131] (794s left) gem_sync (basic-each) [228.737195] Starting subtest: basic-each [231.063202] Subtest basic-each: SUCCESS (2.336s) [231.243488] [039/131] (791s left) gen3_mixed_blits [231.342973] [040/131] (791s left) drm_fdinfo (virtual-busy) [231.381553] Starting subtest: virtual-busy [231.386658] Subtest virtual-busy: SKIP (0.000s) [231.448780] [041/131] (791s left) kms_cursor_legacy (torture-move) [231.564851] Starting subtest: torture-move [231.567048] Starting dynamic subtest: pipe-A [237.243735] Dynamic subtest pipe-A: SUCCESS (5.674s) [237.253102] Starting dynamic subtest: pipe-B [243.704254] Dynamic subtest pipe-B: SUCCESS (6.461s) [243.719620] Starting dynamic subtest: pipe-C [251.056508] Dynamic subtest pipe-C: SUCCESS (7.352s) [251.067322] Starting dynamic subtest: pipe-D [257.926986] Dynamic subtest pipe-D: SUCCESS (6.870s) [257.936565] Starting dynamic subtest: all-pipes [264.802354] Dynamic subtest all-pipes: SUCCESS (6.874s) [264.804965] Subtest torture-move: SUCCESS (33.234s) [264.940760] [042/131] (757s left) kms_psr (fbc-pr-no-drrs) [265.031900] Starting subtest: fbc-pr-no-drrs [265.036502] Subtest fbc-pr-no-drrs: SKIP (0.000s) [265.099353] [043/131] (757s left) kms_vblank (query-forked-busy-hang) [265.198702] Starting subtest: query-forked-busy-hang [265.200984] Starting dynamic subtest: pipe-A-eDP-1 [291.680902] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.477s) [291.693423] Starting dynamic subtest: pipe-D-eDP-1 [317.672443] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.988s) [317.674272] Subtest query-forked-busy-hang: SUCCESS (52.470s) [318.545253] [044/131] (704s left) kms_psr (psr2-suspend) [318.639099] Starting subtest: psr2-suspend [318.641476] Starting dynamic subtest: eDP-1 [336.251842] Dynamic subtest eDP-1: SUCCESS (2.809s) [336.254225] Subtest psr2-suspend: SUCCESS (2.809s) [337.038069] [045/131] (700s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [337.141655] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [337.144039] Starting dynamic subtest: pipe-A-default-mode [337.430089] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [337.435010] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.283s) [338.276065] [046/131] (699s left) perf_pmu (busy-idle-check-all) [338.313127] Starting subtest: busy-idle-check-all [338.316140] Starting dynamic subtest: rcs0 [338.988856] Dynamic subtest rcs0: SUCCESS (0.670s) [339.000132] Starting dynamic subtest: bcs0 [339.714215] Dynamic subtest bcs0: FAIL (0.628s) [339.723472] Starting dynamic subtest: vcs0 [340.729769] Dynamic subtest vcs0: SUCCESS (1.097s) [340.740034] Starting dynamic subtest: vcs1 [342.714325] Dynamic subtest vcs1: SUCCESS (1.972s) [342.725647] Starting dynamic subtest: vecs0 [344.762654] Dynamic subtest vecs0: SUCCESS (2.038s) [344.772239] Starting dynamic subtest: ccs0 [345.492750] Dynamic subtest ccs0: FAIL (0.626s) [345.495012] Subtest busy-idle-check-all: FAIL (7.035s) [345.540581] [047/131] (692s left) prime_vgem (fence-read-hang) [345.623501] Subtest fence-read-hang: SKIP (0.000s) [345.718041] [048/131] (692s left) gem_media_vme [345.876675] [049/131] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [345.982067] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [351.129104] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.135s) [351.279685] [050/131] (686s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [351.353865] Starting subtest: stress-mm-invalidate-close-overlap [353.506238] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s) [353.629554] [051/131] (684s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [353.724455] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [353.726854] Starting dynamic subtest: pipe-A [355.404006] Dynamic subtest pipe-A: SUCCESS (1.677s) [355.412621] Starting dynamic subtest: pipe-B [358.152059] Dynamic subtest pipe-B: SUCCESS (2.744s) [358.160854] Starting dynamic subtest: pipe-C [359.336539] Dynamic subtest pipe-C: SUCCESS (1.181s) [359.347580] Starting dynamic subtest: pipe-D [360.553151] Dynamic subtest pipe-D: SUCCESS (1.214s) [360.557961] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.818s) [361.715685] [052/131] (676s left) gem_exec_capture (capture-recoverable) [361.775861] Starting subtest: capture-recoverable [361.782538] Subtest capture-recoverable: SUCCESS (0.003s) [361.898716] [053/131] (676s left) kms_cursor_crc (cursor-random-128x128) [362.082130] Starting subtest: cursor-random-128x128 [362.084784] Starting dynamic subtest: pipe-A-eDP-1 [365.844703] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.755s) [365.866098] Starting dynamic subtest: pipe-D-eDP-1 [370.184192] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.320s) [370.186655] Subtest cursor-random-128x128: SUCCESS (8.095s) [370.968227] [054/131] (667s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [375.929357] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [375.932086] Starting dynamic subtest: pipe-A-eDP-1 [376.737330] Dynamic subtest pipe-A-eDP-1: SKIP (0.803s) [376.746328] Starting dynamic subtest: pipe-B-eDP-1 [377.961959] Dynamic subtest pipe-B-eDP-1: SKIP (1.222s) [377.967278] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (2.029s) [379.140026] [055/131] (659s left) kms_content_protection (uevent) [379.318195] Starting subtest: uevent [382.668972] Subtest uevent: SKIP (3.347s) [383.843839] [056/131] (654s left) sysfs_heartbeat_interval (nopreempt) [383.904361] Starting subtest: nopreempt [383.907113] Starting dynamic subtest: vecs0 [393.746935] Dynamic subtest vecs0: SUCCESS (9.836s) [393.758210] Starting dynamic subtest: ccs0 [397.740326] Dynamic subtest ccs0: SUCCESS (3.992s) [397.750364] Starting dynamic subtest: vcs0 [407.756242] Dynamic subtest vcs0: SUCCESS (10.008s) [407.765024] Starting dynamic subtest: bcs0 [411.716418] Dynamic subtest bcs0: SUCCESS (3.959s) [411.726745] Starting dynamic subtest: rcs0 [415.767380] Dynamic subtest rcs0: SUCCESS (4.047s) [415.778249] Starting dynamic subtest: vcs1 [425.738565] Dynamic subtest vcs1: SUCCESS (9.964s) [425.741635] Subtest nopreempt: SUCCESS (41.814s) [425.811901] [057/131] (612s left) gem_mmap_gtt (basic-read) [425.876822] Subtest basic-read: SKIP (0.000s) [425.930339] [058/131] (612s left) i915_pm_rps (thresholds-idle) [425.995722] Starting subtest: thresholds-idle [426.000892] Subtest thresholds-idle: SKIP (0.001s) [426.072900] [059/131] (612s left) dmabuf_sync_file (export-before-signal) [426.124221] Starting subtest: export-before-signal [426.127151] Subtest export-before-signal: SUCCESS (0.001s) [426.177903] [060/131] (612s left) gem_mmap_wc (set-cache-level) [426.239927] Subtest set-cache-level: SKIP (0.000s) [426.299231] [061/131] (612s left) kms_big_fb (x-tiled-8bpp-rotate-270) [426.415709] Starting subtest: x-tiled-8bpp-rotate-270 [426.438076] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s) [426.569921] [062/131] (612s left) kms_pm_rpm (dpms-lpsp) [428.914641] Starting subtest: dpms-lpsp [429.213639] Subtest dpms-lpsp: SUCCESS (0.297s) [429.294748] [063/131] (609s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [429.414009] Starting subtest: cursorA-vs-flipB-atomic [429.419446] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [429.563733] [064/131] (609s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [429.667455] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [429.672158] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [429.760583] [065/131] (608s left) kms_addfb_basic (legacy-format) [429.813149] Starting subtest: legacy-format [429.833957] Subtest legacy-format: SUCCESS (0.019s) [429.963289] [066/131] (608s left) gem_bad_reloc (negative-reloc) [430.035494] Subtest negative-reloc: SKIP (0.000s) [430.097578] [067/131] (608s left) kms_dither (fb-8bpc-vs-panel-8bpc) [430.183194] Starting subtest: fb-8bpc-vs-panel-8bpc [430.185951] Starting dynamic subtest: pipe-A-eDP-1 [431.550579] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.366s) [431.553183] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.367s) [432.416721] [068/131] (606s left) kms_big_fb (linear-16bpp-rotate-0) [432.523201] Starting subtest: linear-16bpp-rotate-0 [434.045636] Subtest linear-16bpp-rotate-0: SUCCESS (1.522s) [434.204559] [069/131] (604s left) sw_sync (alloc_timeline) [434.238122] Starting subtest: alloc_timeline [434.240857] Subtest alloc_timeline: SUCCESS (0.000s) [434.297152] [070/131] (604s left) api_intel_allocator (simple-allocator) [434.360181] Starting subtest: simple-allocator [434.362537] Starting dynamic subtest: basic [434.364797] Dynamic subtest basic: SUCCESS (0.006s) [434.377090] Starting dynamic subtest: parallel-one [434.537918] Dynamic subtest parallel-one: SUCCESS (0.172s) [434.547019] Starting dynamic subtest: print [434.549570] Dynamic subtest print: SUCCESS (0.000s) [434.558066] Starting dynamic subtest: reuse [434.561155] Dynamic subtest reuse: SUCCESS (0.000s) [434.569867] Starting dynamic subtest: reserve [434.572221] Dynamic subtest reserve: SUCCESS (0.000s) [434.580894] Starting dynamic subtest: fork-reopen-allocator [434.583410] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s) [434.586053] Subtest simple-allocator: SUCCESS (0.198s) [434.674816] [071/131] (604s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [434.782049] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [434.787290] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [434.880448] [072/131] (604s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [434.978937] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [439.347914] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.376s) [439.466367] [073/131] (599s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [439.532717] Starting subtest: invalid-multi-wait-all-unsubmitted [439.535375] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [439.625341] [074/131] (599s left) kms_plane_scaling (invalid-num-scalers) [439.716762] Starting subtest: invalid-num-scalers [439.719213] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [439.733032] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.014s) [439.741694] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [439.757575] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.024s) [439.765820] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [439.784241] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.026s) [439.792954] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [439.811056] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.025s) [439.813822] Subtest invalid-num-scalers: SUCCESS (0.094s) [439.911548] [075/131] (599s left) kms_big_fb (4-tiled-64bpp-rotate-0) [440.020218] Starting subtest: 4-tiled-64bpp-rotate-0 [442.253621] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (2.234s) [442.762033] [076/131] (596s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc) [442.861209] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc [447.400593] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.544s) [447.530590] [077/131] (591s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [447.662102] Starting subtest: 2x-long-flip-vs-cursor-atomic [447.667772] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s) [447.790622] [078/131] (591s left) kms_addfb_basic (bad-pitch-1024) [447.854453] Starting subtest: bad-pitch-1024 [447.857042] Subtest bad-pitch-1024: SUCCESS (0.000s) [447.987806] [079/131] (591s left) gem_exec_flush (basic-batch-kernel-default-uc) [448.054491] Starting subtest: basic-batch-kernel-default-uc [454.379964] Subtest basic-batch-kernel-default-uc: SUCCESS (6.329s) [454.563029] [080/131] (584s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu) [454.674200] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu [457.640201] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (2.971s) [457.751155] [081/131] (581s left) gem_exec_schedule (pi-ringfull) [457.928143] Starting subtest: pi-ringfull [457.931038] Starting dynamic subtest: rcs0 [458.011209] Dynamic subtest rcs0: SUCCESS (0.085s) [458.027135] Starting dynamic subtest: bcs0 [458.094180] Dynamic subtest bcs0: SUCCESS (0.082s) [458.103552] Starting dynamic subtest: vcs0 [458.179997] Dynamic subtest vcs0: SUCCESS (0.084s) [458.194187] Starting dynamic subtest: vcs1 [458.258390] Dynamic subtest vcs1: SUCCESS (0.077s) [458.274859] Starting dynamic subtest: vecs0 [458.335356] Dynamic subtest vecs0: SUCCESS (0.076s) [458.352507] Starting dynamic subtest: ccs0 [458.411796] Dynamic subtest ccs0: SUCCESS (0.075s) [458.414523] Subtest pi-ringfull: SUCCESS (0.487s) [458.662544] [082/131] (580s left) kms_pm_backlight (fade-with-suspend) [458.768011] Starting subtest: fade-with-suspend [474.846785] Starting dynamic subtest: eDP-1 [477.509478] Dynamic subtest eDP-1: SUCCESS (2.647s) [477.511782] Subtest fade-with-suspend: SUCCESS (3.889s) [478.344508] [083/131] (575s left) kms_flip (absolute-wf_vblank-interruptible) [478.450362] Starting subtest: absolute-wf_vblank-interruptible [478.452862] Starting dynamic subtest: A-eDP1 [487.246747] Dynamic subtest A-eDP1: SUCCESS (8.751s) [487.256392] Starting dynamic subtest: B-eDP1 [495.991881] Dynamic subtest B-eDP1: SUCCESS (8.727s) [496.001737] Starting dynamic subtest: C-eDP1 [504.713076] Dynamic subtest C-eDP1: SUCCESS (8.712s) [504.725522] Starting dynamic subtest: D-eDP1 [513.443257] Dynamic subtest D-eDP1: SUCCESS (8.727s) [513.445936] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.925s) [514.652518] [084/131] (539s left) syncobj_timeline (wait-all-for-submit-snapshot) [514.708486] Starting subtest: wait-all-for-submit-snapshot [514.789013] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [514.859743] [085/131] (539s left) gem_exec_balancer (indices) [514.921156] Starting subtest: indices [517.511072] Subtest indices: SUCCESS (2.588s) [517.805881] [086/131] (536s left) gem_set_tiling_vs_blt (tiled-to-untiled) [517.873459] Subtest tiled-to-untiled: SKIP (0.000s) [517.936136] [087/131] (536s left) gem_ctx_isolation (nonpriv-switch) [517.995084] Starting subtest: nonpriv-switch [517.998000] Starting dynamic subtest: rcs0 [518.695983] Dynamic subtest rcs0: SUCCESS (0.701s) [518.704583] Starting dynamic subtest: bcs0 [519.466965] Dynamic subtest bcs0: SUCCESS (0.770s) [519.476396] Starting dynamic subtest: vcs0 [520.165939] Dynamic subtest vcs0: SUCCESS (0.699s) [520.174624] Starting dynamic subtest: vcs1 [522.278632] Dynamic subtest vcs1: SUCCESS (2.111s) [522.290473] Starting dynamic subtest: vecs0 [524.245559] Dynamic subtest vecs0: SUCCESS (1.965s) [524.257094] Starting dynamic subtest: ccs0 [526.209891] Dynamic subtest ccs0: SUCCESS (1.964s) [526.212909] Subtest nonpriv-switch: SUCCESS (8.214s) [526.468108] [088/131] (527s left) gem_userptr_blits (dmabuf-sync) [526.545863] Starting subtest: dmabuf-sync [526.551161] Subtest dmabuf-sync: SKIP (0.002s) [526.680923] [089/131] (527s left) kms_flip (2x-flip-vs-panning) [526.795435] Starting subtest: 2x-flip-vs-panning [526.807438] Subtest 2x-flip-vs-panning: SKIP (0.011s) [526.927533] [090/131] (527s left) gem_mmap_gtt (basic-copy) [526.995408] Subtest basic-copy: SKIP (0.000s) [527.059308] [091/131] (527s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [527.121642] Starting subtest: single-wait-all-for-submit-available-submitted [527.124550] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [527.205283] [092/131] (527s left) gem_exec_flush (basic-uc-prw-default) [527.263561] Starting subtest: basic-uc-prw-default [532.746920] Subtest basic-uc-prw-default: SUCCESS (5.484s) [532.932272] [093/131] (521s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [532.980469] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [533.087921] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s) [533.161218] [094/131] (521s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [533.258446] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [533.261125] Starting dynamic subtest: pipe-A-eDP-1 [533.289340] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [533.303826] Starting dynamic subtest: pipe-B-eDP-1 [533.332214] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [533.341493] Starting dynamic subtest: pipe-C-eDP-1 [533.372394] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [533.382523] Starting dynamic subtest: pipe-D-eDP-1 [533.411164] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [533.416489] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [535.393113] [095/131] (519s left) kms_color (ctm-signed) [535.492407] Starting subtest: ctm-signed [535.494821] Starting dynamic subtest: pipe-A-eDP-1 [537.567376] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.071s) [537.577586] Starting dynamic subtest: pipe-B-eDP-1 [540.299923] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.733s) [540.309147] Starting dynamic subtest: pipe-C-eDP-1 [542.918508] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.619s) [542.928332] Starting dynamic subtest: pipe-D-eDP-1 [545.569055] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.648s) [545.571749] Subtest ctm-signed: SUCCESS (10.074s) [546.407528] [096/131] (508s left) kms_plane_alpha_blend (alpha-basic) [546.507491] Starting subtest: alpha-basic [546.925183] Starting dynamic subtest: pipe-A-eDP-1 [548.823032] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.894s) [548.842872] Starting dynamic subtest: pipe-D-eDP-1 [551.468345] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.630s) [551.471001] Subtest alpha-basic: SUCCESS (4.957s) [552.269005] [097/131] (502s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [552.359408] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [552.361909] Starting dynamic subtest: pipe-A-default-mode [552.658686] Dynamic subtest pipe-A-default-mode: SKIP (0.294s) [552.664279] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.295s) [553.498174] [098/131] (501s left) gem_exec_schedule (timeslicing) [553.577477] Starting subtest: timeslicing [553.580135] Starting dynamic subtest: rcs0 [553.586539] Dynamic subtest rcs0: SUCCESS (0.021s) [553.595971] Starting dynamic subtest: bcs0 [553.605374] Dynamic subtest bcs0: SUCCESS (0.020s) [553.614788] Starting dynamic subtest: vcs0 [553.626318] Dynamic subtest vcs0: SUCCESS (0.020s) [553.635417] Starting dynamic subtest: vcs1 [553.647254] Dynamic subtest vcs1: SUCCESS (0.020s) [553.659479] Starting dynamic subtest: vecs0 [553.667746] Dynamic subtest vecs0: SUCCESS (0.020s) [553.677312] Starting dynamic subtest: ccs0 [553.689712] Dynamic subtest ccs0: SUCCESS (0.020s) [553.692551] Subtest timeslicing: SUCCESS (0.127s) [555.598723] [099/131] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt) [555.701502] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt [555.706430] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [555.796651] [100/131] (499s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [555.900764] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [555.905660] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [556.004071] [101/131] (498s left) gem_exec_whisper (basic-fds) [556.061450] Starting subtest: basic-fds [561.619754] Subtest basic-fds: SUCCESS (5.552s) [561.799060] [102/131] (493s left) gem_ctx_param (invalid-param-set) [561.865694] Starting subtest: invalid-param-set [561.868603] Subtest invalid-param-set: SUCCESS (0.000s) [561.932345] [103/131] (493s left) gen7_exec_parse (oacontrol-tracking) [562.006719] Subtest oacontrol-tracking: SKIP (0.000s) [562.091509] [104/131] (492s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [562.481375] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [563.306798] [105/131] (491s left) syncobj_wait (signal) [563.365357] Starting subtest: signal [563.367760] Subtest signal: SUCCESS (0.000s) [563.465619] [106/131] (491s left) syncobj_timeline (multi-wait-all-available-signaled) [563.517843] Starting subtest: multi-wait-all-available-signaled [563.520609] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s) [563.611583] [107/131] (491s left) perf (missing-sample-flags) [563.716461] Starting subtest: missing-sample-flags [563.718959] Subtest missing-sample-flags: SUCCESS (0.001s) [563.756150] [108/131] (491s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [563.858960] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [563.864512] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [563.962487] [109/131] (491s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [564.021514] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [564.024160] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [564.113708] [110/131] (491s left) kms_busy (basic) [564.204152] Starting subtest: basic [564.206570] Starting dynamic subtest: flip [564.804227] Dynamic subtest flip: SUCCESS (0.596s) [564.814479] Starting dynamic subtest: modeset [568.229034] Dynamic subtest modeset: SUCCESS (3.422s) [568.231821] Subtest basic: SUCCESS (4.020s) [569.026215] [111/131] (486s left) gem_ctx_persistence (engines-cleanup) [569.080907] Starting subtest: engines-cleanup [569.083530] Starting dynamic subtest: rcs0 [569.181725] Dynamic subtest rcs0: SUCCESS (0.100s) [569.194208] Starting dynamic subtest: bcs0 [569.250602] Dynamic subtest bcs0: SUCCESS (0.067s) [569.262579] Starting dynamic subtest: vcs0 [569.268723] Dynamic subtest vcs0: SUCCESS (0.016s) [569.279866] Starting dynamic subtest: vcs1 [569.346018] Dynamic subtest vcs1: SUCCESS (0.076s) [569.358312] Starting dynamic subtest: vecs0 [569.387762] Dynamic subtest vecs0: SUCCESS (0.040s) [569.398335] Starting dynamic subtest: ccs0 [569.425691] Dynamic subtest ccs0: SUCCESS (0.036s) [569.428506] Subtest engines-cleanup: SUCCESS (0.345s) [569.522540] [112/131] (485s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-out-visible-area) [569.979352] Subtest fbc-dirty-rectangle-out-visible-area: SKIP (0.000s) [570.029230] [FACT kms_fbc_dirty_rect (fbc-dirty-rectangle-out-visible-area)] new: kernel.kmod_is_loaded.xe: true [570.033013] [113/131] (485s left) perf_pmu (most-busy-idle-check-all) [570.072709] Starting subtest: most-busy-idle-check-all [570.075421] Starting dynamic subtest: rcs0 [571.559583] Dynamic subtest rcs0: SUCCESS (1.489s) [571.569531] Starting dynamic subtest: bcs0 [573.546325] Dynamic subtest bcs0: SUCCESS (1.983s) [573.558764] Starting dynamic subtest: vcs0 [575.593150] Dynamic subtest vcs0: SUCCESS (2.046s) [575.604753] Starting dynamic subtest: vcs1 [577.514096] Dynamic subtest vcs1: SUCCESS (1.919s) [577.526446] Starting dynamic subtest: vecs0 [579.562307] Dynamic subtest vecs0: SUCCESS (2.047s) [579.574456] Starting dynamic subtest: ccs0 [581.546163] Dynamic subtest ccs0: SUCCESS (1.982s) [581.549359] Subtest most-busy-idle-check-all: SUCCESS (11.478s) [581.657470] [114/131] (473s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu) [581.759714] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu [584.762171] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (3.009s) [584.882466] [115/131] (470s left) api_intel_bb (reset-bb) [584.941656] Starting subtest: reset-bb [584.944545] Subtest reset-bb: SUCCESS (0.004s) [585.046491] [116/131] (470s left) gem_exec_reloc (basic-wc-gtt-active) [585.109483] Subtest basic-wc-gtt-active: SKIP (0.000s) [585.173559] [117/131] (470s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [585.277588] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [586.465758] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.189s) [586.632033] [118/131] (468s left) kms_psr (pr-sprite-blt) [586.738597] Starting subtest: pr-sprite-blt [586.743153] Subtest pr-sprite-blt: SKIP (0.000s) [586.803950] [119/131] (468s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [586.918081] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [586.922273] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [587.016516] [120/131] (468s left) kms_lease (lease-invalid-connector) [587.113690] Starting subtest: lease-invalid-connector [587.116238] Starting dynamic subtest: pipe-A-eDP-1 [587.118357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [587.127500] Starting dynamic subtest: pipe-B-eDP-1 [587.129775] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [587.138489] Starting dynamic subtest: pipe-C-eDP-1 [587.140453] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [587.149261] Starting dynamic subtest: pipe-D-eDP-1 [587.151361] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [587.153441] Subtest lease-invalid-connector: SUCCESS (0.004s) [587.185310] [121/131] (468s left) kms_chamelium_color (ctm-negative) [587.280032] Subtest ctm-negative: SKIP (0.000s) [587.319485] [122/131] (468s left) i915_hangman (engine-engine-error) [587.401594] Starting subtest: engine-engine-error [587.404134] Starting dynamic subtest: rcs0 [588.552109] Dynamic subtest rcs0: SUCCESS (1.149s) [588.562656] Starting dynamic subtest: bcs0 [590.535963] Dynamic subtest bcs0: SUCCESS (1.981s) [590.547864] Starting dynamic subtest: vcs0 [592.520022] Dynamic subtest vcs0: SUCCESS (1.982s) [592.533139] Starting dynamic subtest: vcs1 [594.504227] Dynamic subtest vcs1: SUCCESS (1.982s) [594.516257] Starting dynamic subtest: vecs0 [596.551866] Dynamic subtest vecs0: SUCCESS (2.045s) [596.564893] Starting dynamic subtest: ccs0 [598.535008] Dynamic subtest ccs0: SUCCESS (1.981s) [598.538084] Subtest engine-engine-error: SUCCESS (11.134s) [598.612113] [123/131] (457s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [598.718472] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs [598.723612] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [599.868105] [124/131] (455s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [599.970417] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [599.973278] Starting dynamic subtest: pipe-A-eDP-1 [600.000496] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [600.010912] Starting dynamic subtest: pipe-B-eDP-1 [600.036765] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [600.045514] Starting dynamic subtest: pipe-C-eDP-1 [600.071475] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [600.080217] Starting dynamic subtest: pipe-D-eDP-1 [600.106351] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [600.111232] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s) [602.222081] [125/131] (453s left) sw_sync (sync_merge_invalid) [602.265593] Starting subtest: sync_merge_invalid [602.289174] Subtest sync_merge_invalid: SUCCESS (0.025s) [602.371126] [126/131] (453s left) prime_vgem (fence-wait) [602.438513] Starting subtest: fence-wait [602.441113] Starting dynamic subtest: rcs0 [603.479537] Dynamic subtest rcs0: SUCCESS (1.041s) [603.491753] Starting dynamic subtest: bcs0 [604.534751] Dynamic subtest bcs0: SUCCESS (1.054s) [604.546705] Starting dynamic subtest: vcs0 [605.581360] Dynamic subtest vcs0: SUCCESS (1.045s) [605.592575] Starting dynamic subtest: vcs1 [606.625115] Dynamic subtest vcs1: SUCCESS (1.041s) [606.637374] Starting dynamic subtest: vecs0 [607.670903] Dynamic subtest vecs0: SUCCESS (1.043s) [607.683568] Starting dynamic subtest: ccs0 [608.714743] Dynamic subtest ccs0: SUCCESS (1.041s) [608.717741] Subtest fence-wait: SUCCESS (6.277s) [608.853003] [127/131] (447s left) kms_joiner (basic-max-non-joiner) [608.964413] Starting subtest: basic-max-non-joiner [608.969399] Subtest basic-max-non-joiner: SKIP (0.000s) [609.024106] [128/131] (446s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [609.125294] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [613.702215] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.581s) [613.822972] [129/131] (442s left) gem_exec_params (invalid-bsd2-flag-on-blt) [613.879948] Starting subtest: invalid-bsd2-flag-on-blt [613.882728] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [613.975249] [130/131] (441s left) prime_self_import (basic-with_one_bo) [614.008051] Starting subtest: basic-with_one_bo [614.032531] Subtest basic-with_one_bo: SUCCESS (0.023s) [614.133589] [131/131] (441s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [619.186067] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [619.188295] Starting dynamic subtest: pipe-A-eDP-1 [630.927598] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.738s) [630.939124] Starting dynamic subtest: pipe-B-eDP-1 [642.653516] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.723s) [642.656444] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.465s) [643.503564] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: gem_ctx_param results: parsing output: 2/ for test: gem_lmem_swapping results: parsing output: 3/ for test: kms_cursor_legacy results: parsing output: 4/ for test: i915_query results: parsing output: 5/ for test: kms_scaling_modes results: parsing output: 6/ for test: gem_exec_nop results: parsing output: 7/ for test: gem_exec_balancer results: parsing output: 8/ for test: gem_pread results: parsing output: 9/ for test: gem_exec_reloc results: parsing output: 10/ for test: kms_vblank results: parsing output: 11/ for test: kms_getfb results: parsing output: 12/ for test: gem_exec_fence results: parsing output: 13/ for test: kms_prop_blob results: parsing output: 14/ for test: gem_spin_batch results: parsing output: 15/ for test: kms_flip results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_psr results: parsing output: 23/ for test: gem_ctx_persistence results: parsing output: 24/ for test: kms_atomic_transition results: parsing output: 25/ for test: gem_mmap_wc results: parsing output: 26/ for test: gem_mmap_wc results: parsing output: 27/ for test: i915_hangman results: parsing output: 28/ for test: kms_cursor_crc results: parsing output: 29/ for test: kms_ccs results: parsing output: 30/ for test: kms_flip results: parsing output: 31/ for test: gem_render_copy results: parsing output: 32/ for test: gem_render_copy results: parsing output: 33/ for test: gem_eio results: parsing output: 34/ for test: gem_userptr_blits results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: syncobj_wait results: parsing output: 37/ for test: gem_sync results: parsing output: 38/ for test: gen3_mixed_blits results: parsing output: 39/ for test: drm_fdinfo results: parsing output: 40/ for test: kms_cursor_legacy results: parsing output: 41/ for test: kms_psr results: parsing output: 42/ for test: kms_vblank results: parsing output: 43/ for test: kms_psr results: parsing output: 44/ for test: kms_flip_scaled_crc results: parsing output: 45/ for test: perf_pmu results: parsing output: 46/ for test: prime_vgem results: parsing output: 47/ for test: gem_media_vme results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_userptr_blits results: parsing output: 50/ for test: kms_plane_scaling results: parsing output: 51/ for test: gem_exec_capture results: parsing output: 52/ for test: kms_cursor_crc results: parsing output: 53/ for test: kms_psr2_sf results: parsing output: 54/ for test: kms_content_protection results: parsing output: 55/ for test: sysfs_heartbeat_interval results: parsing output: 56/ for test: gem_mmap_gtt results: parsing output: 57/ for test: i915_pm_rps results: parsing output: 58/ for test: dmabuf_sync_file results: parsing output: 59/ for test: gem_mmap_wc results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_pm_rpm results: parsing output: 62/ for test: kms_cursor_legacy results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: gem_bad_reloc results: parsing output: 66/ for test: kms_dither results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: sw_sync results: parsing output: 69/ for test: api_intel_allocator results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: kms_plane_scaling results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_cursor_legacy results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: gem_exec_flush results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_exec_schedule results: parsing output: 81/ for test: kms_pm_backlight results: parsing output: 82/ for test: kms_flip results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: gem_exec_balancer results: parsing output: 85/ for test: gem_set_tiling_vs_blt results: parsing output: 86/ for test: gem_ctx_isolation results: parsing output: 87/ for test: gem_userptr_blits results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gem_mmap_gtt results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: gem_exec_flush results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: kms_color results: parsing output: 95/ for test: kms_plane_alpha_blend results: parsing output: 96/ for test: kms_flip_scaled_crc results: parsing output: 97/ for test: gem_exec_schedule results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: gem_exec_whisper results: parsing output: 101/ for test: gem_ctx_param results: parsing output: 102/ for test: gen7_exec_parse results: parsing output: 103/ for test: kms_chamelium_hpd results: parsing output: 104/ for test: syncobj_wait results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: perf results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: syncobj_wait results: parsing output: 109/ for test: kms_busy results: parsing output: 110/ for test: gem_ctx_persistence results: parsing output: 111/ for test: kms_fbc_dirty_rect results: parsing output: 112/ for test: perf_pmu results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: api_intel_bb results: parsing output: 115/ for test: gem_exec_reloc results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: kms_psr results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_lease results: parsing output: 120/ for test: kms_chamelium_color results: parsing output: 121/ for test: i915_hangman results: parsing output: 122/ for test: kms_ccs results: parsing output: 123/ for test: kms_ccs results: parsing output: 124/ for test: sw_sync results: parsing output: 125/ for test: prime_vgem results: parsing output: 126/ for test: kms_joiner results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_exec_params results: parsing output: 129/ for test: prime_self_import results: parsing output: 130/ for test: kms_psr2_sf Done.