[70.413304] Initializing watchdogs [70.413372] /dev/watchdog0 [70.434070] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [70.445738] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [70.449524] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [70.451963] [001/133] (960s left) kms_big_fb (yf-tiled-addfb) [71.977669] Starting subtest: yf-tiled-addfb [71.979554] Subtest yf-tiled-addfb: SKIP (0.000s) [72.115689] [002/133] (958s left) syncobj_timeline (wait-all-complex) [72.226274] Starting subtest: wait-all-complex [72.445189] Subtest wait-all-complex: SUCCESS (0.217s) [72.550355] [003/133] (958s left) i915_drm_fdinfo (idle) [72.616949] Starting subtest: idle [72.617901] Starting dynamic subtest: rcs0 [73.189585] Dynamic subtest rcs0: SUCCESS (0.572s) [73.199616] Starting dynamic subtest: bcs0 [73.694997] Dynamic subtest bcs0: SUCCESS (0.504s) [73.703215] Starting dynamic subtest: vcs0 [74.201241] Dynamic subtest vcs0: SUCCESS (0.505s) [74.209840] Starting dynamic subtest: vcs1 [74.707505] Dynamic subtest vcs1: SUCCESS (0.505s) [74.715552] Starting dynamic subtest: vecs0 [75.215196] Dynamic subtest vecs0: SUCCESS (0.504s) [75.222669] Starting dynamic subtest: vecs1 [75.719523] Dynamic subtest vecs1: SUCCESS (0.505s) [75.727180] Starting dynamic subtest: ccs0 [76.225304] Dynamic subtest ccs0: SUCCESS (0.504s) [76.226736] Subtest idle: SUCCESS (3.606s) [76.314646] [004/133] (954s left) perf_pmu (interrupts-sync) [76.378932] Starting subtest: interrupts-sync [77.532899] Subtest interrupts-sync: SUCCESS (1.152s) [77.668882] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true [77.670618] [005/133] (953s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [77.748323] Starting subtest: etime-multi-wait-available-unsubmitted [77.855609] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s) [77.979824] [006/133] (953s left) kms_dither (fb-8bpc-vs-panel-6bpc) [79.494327] Starting subtest: fb-8bpc-vs-panel-6bpc [79.496957] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.001s) [79.582199] [007/133] (951s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [81.122503] Starting subtest: yf-tiled-32bpp-rotate-180 [81.124416] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [81.260087] [008/133] (950s left) gem_flink_race (flink_name) [81.336262] Starting subtest: flink_name [86.737694] Subtest flink_name: SUCCESS (5.400s) [86.921081] [009/133] (944s left) prime_mmap (test_refcounting) [87.034561] Starting subtest: test_refcounting [87.035452] Starting dynamic subtest: test_refcounting-smem [87.083335] Dynamic subtest test_refcounting-smem: SUCCESS (0.049s) [87.091441] Starting dynamic subtest: test_refcounting-lmem0 [87.284641] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.201s) [87.285527] Subtest test_refcounting: SUCCESS (0.250s) [87.433059] [010/133] (944s left) i915_drm_fdinfo (virtual-idle) [87.505968] Starting subtest: virtual-idle [91.109070] Subtest virtual-idle: SUCCESS (3.602s) [91.249019] [011/133] (940s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [92.760184] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [92.761100] Starting dynamic subtest: pipe-A-HDMI-A-3 [92.783277] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s) [92.791466] Starting dynamic subtest: pipe-B-HDMI-A-3 [92.812992] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s) [92.821773] Starting dynamic subtest: pipe-C-HDMI-A-3 [92.845044] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s) [92.853496] Starting dynamic subtest: pipe-D-HDMI-A-3 [92.876702] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s) [92.878390] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.011s) [93.040427] [012/133] (938s left) gem_mmap_gtt (hang-busy) [93.121040] Subtest hang-busy: SKIP (0.000s) [93.201778] [013/133] (938s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [94.723588] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [94.725223] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [94.864783] [014/133] (936s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic) [96.406983] Starting subtest: async-flip-with-page-flip-events-linear-atomic [96.669381] Starting dynamic subtest: pipe-A-HDMI-A-3 [98.935556] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.266s) [99.099895] Starting dynamic subtest: pipe-B-HDMI-A-3 [101.161425] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.068s) [101.304727] Starting dynamic subtest: pipe-C-HDMI-A-3 [103.367203] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.069s) [103.522957] Starting dynamic subtest: pipe-D-HDMI-A-3 [105.588139] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.072s) [105.589433] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (9.180s) [105.926498] [015/133] (925s left) kms_big_fb (4-tiled-32bpp-rotate-180) [107.454196] Starting subtest: 4-tiled-32bpp-rotate-180 [109.335577] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.881s) [109.552639] [016/133] (922s left) syncobj_basic (create-signaled) [109.633160] Starting subtest: create-signaled [109.634148] Subtest create-signaled: SUCCESS (0.000s) [109.759554] [017/133] (922s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [109.838957] Starting subtest: multi-wait-for-submit-available-signaled [109.839927] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s) [109.994078] [018/133] (922s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [111.510972] Starting subtest: plane-downscale-factor-0-75-with-modifiers [111.511909] Starting dynamic subtest: pipe-A [112.117633] Dynamic subtest pipe-A: SUCCESS (0.607s) [112.136133] Starting dynamic subtest: pipe-B [112.693761] Dynamic subtest pipe-B: SUCCESS (0.576s) [112.705161] Starting dynamic subtest: pipe-C [113.254062] Dynamic subtest pipe-C: SUCCESS (0.560s) [113.267540] Starting dynamic subtest: pipe-D [113.831481] Dynamic subtest pipe-D: SUCCESS (0.577s) [113.832521] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (2.321s) [114.060094] [019/133] (918s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [114.140959] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [114.218580] [020/133] (918s left) kms_plane_alpha_blend (alpha-opaque-fb) [115.731091] Starting subtest: alpha-opaque-fb [115.984041] Starting dynamic subtest: pipe-A-HDMI-A-3 [116.447585] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.463s) [116.456983] Starting dynamic subtest: pipe-D-HDMI-A-3 [116.971919] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.523s) [116.972834] Subtest alpha-opaque-fb: SUCCESS (1.241s) [117.137932] [021/133] (915s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [117.223542] Starting subtest: mixed-tiled-to-yf-tiled-ccs [117.225465] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [117.489529] [022/133] (914s left) gen7_exec_parse (basic-rejected) [117.572853] Subtest basic-rejected: SKIP (0.000s) [117.649273] [023/133] (914s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [119.163428] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [119.165125] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [119.255755] [024/133] (913s left) gem_exec_schedule (implicit-read-write) [119.364769] Starting subtest: implicit-read-write [119.365664] Starting dynamic subtest: rcs0 [119.666836] Dynamic subtest rcs0: SUCCESS (0.293s) [119.675823] Starting dynamic subtest: bcs0 [119.873703] Dynamic subtest bcs0: SUCCESS (0.209s) [119.882423] Starting dynamic subtest: vcs0 [120.098313] Dynamic subtest vcs0: SUCCESS (0.221s) [120.107154] Starting dynamic subtest: vcs1 [120.319537] Dynamic subtest vcs1: SUCCESS (0.223s) [120.328821] Starting dynamic subtest: vecs0 [120.529414] Dynamic subtest vecs0: SUCCESS (0.217s) [120.537968] Starting dynamic subtest: vecs1 [120.751219] Dynamic subtest vecs1: SUCCESS (0.221s) [120.760109] Starting dynamic subtest: ccs0 [121.023092] Dynamic subtest ccs0: SUCCESS (0.272s) [121.024062] Subtest implicit-read-write: SUCCESS (1.658s) [121.428424] [025/133] (911s left) kms_chamelium_hpd (dp-hpd) [123.000712] Subtest dp-hpd: SKIP (0.000s) [123.105269] [026/133] (909s left) kms_pm_dc (dc6-psr) [125.639406] Starting subtest: dc6-psr [125.641152] Subtest dc6-psr: SKIP (0.000s) [125.749697] [027/133] (906s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [127.285985] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [127.287632] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s) [127.395744] [028/133] (905s left) i915_pm_rps (thresholds-park) [127.502765] Starting subtest: thresholds-park [127.504740] Subtest thresholds-park: SKIP (0.000s) [127.700105] [029/133] (905s left) kms_rotation_crc (exhaust-fences) [129.214175] Starting subtest: exhaust-fences [129.215979] Subtest exhaust-fences: SKIP (0.000s) [129.305740] [030/133] (903s left) syncobj_wait (invalid-signal-zero-handles) [129.395998] Starting subtest: invalid-signal-zero-handles [129.397126] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [129.524910] [031/133] (903s left) gem_mmap_gtt (basic-small-bo-tiledx) [129.605128] Subtest basic-small-bo-tiledX: SKIP (0.000s) [129.682010] [032/133] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [131.201535] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [131.203198] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [131.350124] [033/133] (901s left) gem_ctx_sseu (engines) [131.466053] Subtest engines: SKIP (0.000s) [131.529982] [034/133] (901s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [133.057463] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [133.059273] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [133.198245] [035/133] (899s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [134.755153] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [136.056630] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.301s) [136.287889] [036/133] (896s left) sysfs_timeslice_duration (duration) [136.371416] Starting subtest: duration [136.372316] Starting dynamic subtest: vecs0 [149.534362] Dynamic subtest vecs0: SUCCESS (13.161s) [149.544165] Starting dynamic subtest: ccs0 [162.676200] Dynamic subtest ccs0: SUCCESS (13.139s) [162.687219] Starting dynamic subtest: vcs0 [175.822786] Dynamic subtest vcs0: SUCCESS (13.144s) [175.833551] Starting dynamic subtest: bcs0 [188.968558] Dynamic subtest bcs0: SUCCESS (13.144s) [188.978370] Starting dynamic subtest: vecs1 [202.127050] Dynamic subtest vecs1: SUCCESS (13.156s) [202.138613] Starting dynamic subtest: rcs0 [215.261604] Dynamic subtest rcs0: SUCCESS (13.133s) [215.271574] Starting dynamic subtest: vcs1 [228.410726] Dynamic subtest vcs1: SUCCESS (13.148s) [228.411858] Subtest duration: SUCCESS (92.034s) [228.529363] [037/133] (804s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [230.041019] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [230.041989] Starting dynamic subtest: pipe-A-HDMI-A-3 [230.050341] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [230.059442] Starting dynamic subtest: pipe-B-HDMI-A-3 [230.067923] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [230.076666] Starting dynamic subtest: pipe-C-HDMI-A-3 [230.084940] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [230.093321] Starting dynamic subtest: pipe-D-HDMI-A-3 [230.104090] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [230.106136] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s) [230.321772] [038/133] (803s left) gem_workarounds (reset-context) [230.416257] Starting subtest: reset-context [230.610499] Subtest reset-context: SUCCESS (0.194s) [230.814652] [039/133] (802s left) prime_vgem (basic-write) [230.918593] Starting subtest: basic-write [230.933126] Subtest basic-write: SKIP (0.013s) [231.044557] [040/133] (802s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [232.563291] Starting subtest: fbcpsr-rgb565-draw-blt [232.564968] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s) [232.705718] [041/133] (800s left) gem_exec_suspend (basic-s4-devices) [232.820663] Starting subtest: basic-S4-devices [232.821562] Starting dynamic subtest: smem [243.107900] Dynamic subtest smem: SUCCESS (10.287s) [243.119220] Starting dynamic subtest: lmem0 [253.241664] Dynamic subtest lmem0: SUCCESS (10.133s) [253.242772] Subtest basic-S4-devices: SUCCESS (20.420s) [260.486162] [042/133] (780s left) gem_ringfill (legacy-basic) [260.900297] Starting subtest: legacy-basic [260.902202] Starting dynamic subtest: default [260.987383] Dynamic subtest default: SUCCESS (0.089s) [261.002950] Starting dynamic subtest: render [261.027566] Dynamic subtest render: SUCCESS (0.039s) [261.054194] Starting dynamic subtest: bsd [261.073374] Dynamic subtest bsd: SUCCESS (0.045s) [261.094984] Starting dynamic subtest: bsd1 [261.119065] Dynamic subtest bsd1: SUCCESS (0.044s) [261.143993] Starting dynamic subtest: bsd2 [261.163863] Dynamic subtest bsd2: SUCCESS (0.044s) [261.185620] Starting dynamic subtest: blt [261.209895] Dynamic subtest blt: SUCCESS (0.045s) [261.240138] Starting dynamic subtest: vebox [261.256973] Dynamic subtest vebox: SUCCESS (0.046s) [261.258289] Subtest legacy-basic: SUCCESS (0.360s) [261.456076] [043/133] (779s left) gem_mmap_wc (write-wc-read-gtt) [261.535971] Subtest write-wc-read-gtt: SKIP (0.000s) [261.597255] [044/133] (779s left) gem_eio (in-flight-internal-1us) [261.888431] Starting subtest: in-flight-internal-1us [262.919913] Subtest in-flight-internal-1us: SUCCESS (1.032s) [264.465045] [045/133] (776s left) gem_exec_params (cliprects-invalid) [264.563116] Starting subtest: cliprects-invalid [264.564067] Subtest cliprects-invalid: SUCCESS (0.000s) [264.767145] [046/133] (776s left) gem_vm_create (execbuf) [264.859238] Starting subtest: execbuf [264.867013] Subtest execbuf: SUCCESS (0.008s) [265.071406] [047/133] (776s left) gem_ctx_persistence (many-contexts) [265.157314] Starting subtest: many-contexts [302.831308] Subtest many-contexts: SUCCESS (37.673s) [303.039152] [048/133] (738s left) i915_pm_rps (engine-order) [303.124791] Starting subtest: engine-order [316.022593] Subtest engine-order: SUCCESS (12.896s) [316.203083] [049/133] (724s left) gem_set_tiling_vs_blt (tiled-to-tiled) [316.292146] Subtest tiled-to-tiled: SKIP (0.000s) [316.365864] [050/133] (724s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [316.444253] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [316.445167] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [316.592513] [051/133] (724s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [318.110517] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [318.112213] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [318.249193] [052/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [319.796593] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [319.798252] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [319.997366] [053/133] (721s left) gem_mmap_wc (invalid-flags) [320.086965] Subtest invalid-flags: SKIP (0.000s) [320.151755] [054/133] (721s left) kms_big_fb (linear-64bpp-rotate-0) [321.674016] Starting subtest: linear-64bpp-rotate-0 [324.055752] Subtest linear-64bpp-rotate-0: SUCCESS (2.382s) [324.246740] [055/133] (717s left) gem_lmem_swapping (heavy-verify-random-ccs) [328.826191] Starting subtest: heavy-verify-random-ccs [328.827116] Starting dynamic subtest: lmem0 [339.054497] Dynamic subtest lmem0: SUCCESS (10.228s) [339.055452] Subtest heavy-verify-random-ccs: SUCCESS (10.229s) [340.723947] [FACT gem_lmem_swapping (heavy-verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [340.724962] [FACT gem_lmem_swapping (heavy-verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true [340.726763] [056/133] (700s left) gem_exec_schedule (semaphore-user) [344.344558] Starting subtest: semaphore-user [344.437299] Subtest semaphore-user: SUCCESS (0.093s) [344.877275] [FACT gem_exec_schedule (semaphore-user)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [344.879881] [FACT gem_exec_schedule (semaphore-user)] new: kernel.kmod_is_loaded.i915: true [344.882430] [057/133] (696s left) kms_chamelium_edid (dp-mode-timings) [346.443402] Subtest dp-mode-timings: SKIP (0.000s) [346.552641] [058/133] (695s left) kms_selftest (drm_dp_mst_helper) [346.610906] Starting subtest: drm_dp_mst_helper [346.615858] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [346.681041] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.065s) [346.699532] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [346.787426] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.105s) [346.815393] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [346.907559] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.118s) [346.908910] Subtest drm_dp_mst_helper: SUCCESS (0.296s) [347.114589] [059/133] (694s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [347.197599] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [347.279605] [060/133] (694s left) gem_spin_batch (spin-each) [347.369804] Starting subtest: spin-each [350.804926] Subtest spin-each: SUCCESS (3.434s) [351.118737] [061/133] (690s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [352.640507] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [352.667413] Starting dynamic subtest: pipe-A-plane-0 [353.817573] Dynamic subtest pipe-A-plane-0: SUCCESS (1.150s) [353.850743] Starting dynamic subtest: pipe-A-plane-3 [354.467569] Dynamic subtest pipe-A-plane-3: SUCCESS (0.649s) [354.620358] Starting dynamic subtest: pipe-B-plane-0 [355.659775] Dynamic subtest pipe-B-plane-0: SUCCESS (1.050s) [355.671347] Starting dynamic subtest: pipe-B-plane-3 [356.276703] Dynamic subtest pipe-B-plane-3: SUCCESS (0.616s) [356.367367] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.728s) [356.613126] [062/133] (685s left) gem_exec_balancer (full-pulse) [356.705529] Starting subtest: full-pulse [358.861381] Subtest full-pulse: SUCCESS (2.156s) [359.260802] [063/133] (682s left) fbdev (eof) [359.325347] Starting subtest: eof [359.326268] Subtest eof: SUCCESS (0.000s) [359.486304] [064/133] (682s left) api_intel_bb (delta-check) [359.566145] Starting subtest: delta-check [359.594940] Subtest delta-check: SUCCESS (0.030s) [359.795688] [065/133] (682s left) kms_plane_scaling (planes-downscale-factor-0-5) [361.309224] Starting subtest: planes-downscale-factor-0-5 [361.310163] Starting dynamic subtest: pipe-A [361.408039] Dynamic subtest pipe-A: SUCCESS (0.099s) [361.424564] Starting dynamic subtest: pipe-B [361.572879] Dynamic subtest pipe-B: SUCCESS (0.164s) [361.593042] Starting dynamic subtest: pipe-C [361.731577] Dynamic subtest pipe-C: SUCCESS (0.158s) [361.743311] Starting dynamic subtest: pipe-D [361.857545] Dynamic subtest pipe-D: SUCCESS (0.125s) [361.858501] Subtest planes-downscale-factor-0-5: SUCCESS (0.549s) [362.065880] [066/133] (680s left) kms_feature_discovery (chamelium) [363.583195] Starting subtest: chamelium [363.584998] Subtest chamelium: SKIP (0.000s) [363.752663] [067/133] (678s left) gem_exec_params (readonly) [363.871645] Starting subtest: readonly [363.873607] Subtest readonly: SUCCESS (0.002s) [364.077792] [068/133] (678s left) gem_exec_fence (parallel) [364.289403] Starting subtest: parallel [364.290528] Starting dynamic subtest: rcs0 [366.438267] Dynamic subtest rcs0: SUCCESS (2.149s) [366.449298] Starting dynamic subtest: bcs0 [368.594581] Dynamic subtest bcs0: SUCCESS (2.156s) [368.605611] Starting dynamic subtest: vcs0 [370.743128] Dynamic subtest vcs0: SUCCESS (2.148s) [370.754325] Starting dynamic subtest: vcs1 [372.898136] Dynamic subtest vcs1: SUCCESS (2.154s) [372.909514] Starting dynamic subtest: vecs0 [375.049166] Dynamic subtest vecs0: SUCCESS (2.150s) [375.060578] Starting dynamic subtest: vecs1 [377.200264] Dynamic subtest vecs1: SUCCESS (2.150s) [377.211409] Starting dynamic subtest: ccs0 [379.354939] Dynamic subtest ccs0: SUCCESS (2.154s) [379.355915] Subtest parallel: SUCCESS (15.066s) [380.042805] [069/133] (662s left) kms_vrr (flipline) [381.559557] Starting subtest: flipline [381.562096] Subtest flipline: SKIP (0.000s) [381.654877] [070/133] (661s left) gem_mmap_gtt (medium-copy-xy) [381.742974] Subtest medium-copy-XY: SKIP (0.000s) [381.809762] [071/133] (660s left) gem_request_retire (retire-vma-not-inactive) [381.895233] Starting subtest: retire-vma-not-inactive [381.978469] Subtest retire-vma-not-inactive: SUCCESS (0.083s) [382.169408] [072/133] (660s left) kms_psr2_su (page_flip-xrgb8888) [382.251358] Subtest page_flip-XRGB8888: SKIP (0.000s) [382.329134] [073/133] (660s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [382.407480] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [382.511543] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [382.652031] [074/133] (660s left) kms_psr (fbc-psr-sprite-plane-move) [384.167451] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s) [384.228702] [075/133] (658s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [385.750294] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [385.752047] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [385.896773] [076/133] (657s left) gem_ctx_persistence (engines-cleanup) [386.011561] Starting subtest: engines-cleanup [386.012466] Starting dynamic subtest: rcs0 [386.100337] Dynamic subtest rcs0: SUCCESS (0.088s) [386.114157] Starting dynamic subtest: bcs0 [386.138507] Dynamic subtest bcs0: SUCCESS (0.037s) [386.162075] Starting dynamic subtest: vcs0 [386.165130] Dynamic subtest vcs0: SUCCESS (0.025s) [386.188265] Starting dynamic subtest: vcs1 [386.228253] Dynamic subtest vcs1: SUCCESS (0.062s) [386.272181] Starting dynamic subtest: vecs0 [386.273686] Dynamic subtest vecs0: SUCCESS (0.031s) [386.289534] Starting dynamic subtest: vecs1 [386.321111] Dynamic subtest vecs1: SUCCESS (0.058s) [386.333018] Starting dynamic subtest: ccs0 [386.365527] Dynamic subtest ccs0: SUCCESS (0.044s) [386.366719] Subtest engines-cleanup: SUCCESS (0.354s) [386.549016] [077/133] (656s left) perf_pmu (busy) [386.621009] Starting subtest: busy [386.621978] Starting dynamic subtest: rcs0 [387.245760] Dynamic subtest rcs0: SUCCESS (0.623s) [387.260585] Starting dynamic subtest: bcs0 [387.815875] Dynamic subtest bcs0: SUCCESS (0.567s) [387.830753] Starting dynamic subtest: vcs0 [388.382739] Dynamic subtest vcs0: SUCCESS (0.564s) [388.397771] Starting dynamic subtest: vcs1 [388.948878] Dynamic subtest vcs1: SUCCESS (0.563s) [388.964058] Starting dynamic subtest: vecs0 [389.517825] Dynamic subtest vecs0: SUCCESS (0.566s) [389.532801] Starting dynamic subtest: vecs1 [390.080815] Dynamic subtest vecs1: SUCCESS (0.560s) [390.095376] Starting dynamic subtest: ccs0 [390.641635] Dynamic subtest ccs0: SUCCESS (0.558s) [390.643536] Subtest busy: SUCCESS (4.022s) [390.798843] [078/133] (652s left) gem_exec_flush (basic-uc-set-default) [390.887135] Subtest basic-uc-set-default: SKIP (0.000s) [390.961210] [079/133] (652s left) kms_flip (2x-flip-vs-panning-vs-hang) [392.479392] Starting subtest: 2x-flip-vs-panning-vs-hang [392.491552] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.013s) [392.692378] [080/133] (650s left) prime_self_import (basic-with_one_bo) [392.749662] Starting subtest: basic-with_one_bo [392.801318] Subtest basic-with_one_bo: SUCCESS (0.053s) [392.952906] [081/133] (650s left) syncobj_timeline (invalid-query-zero-handles) [393.033131] Starting subtest: invalid-query-zero-handles [393.034055] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [393.200274] [082/133] (650s left) gem_exec_fence (basic-wait) [393.408578] Starting subtest: basic-wait [393.409601] Starting dynamic subtest: rcs0 [393.518410] Dynamic subtest rcs0: SUCCESS (0.111s) [393.540775] Starting dynamic subtest: bcs0 [393.572180] Dynamic subtest bcs0: SUCCESS (0.052s) [393.590336] Starting dynamic subtest: vcs0 [393.629485] Dynamic subtest vcs0: SUCCESS (0.055s) [393.649471] Starting dynamic subtest: vcs1 [393.681609] Dynamic subtest vcs1: SUCCESS (0.051s) [393.715264] Starting dynamic subtest: vecs0 [393.737397] Dynamic subtest vecs0: SUCCESS (0.054s) [393.758963] Starting dynamic subtest: vecs1 [393.789531] Dynamic subtest vecs1: SUCCESS (0.051s) [393.813015] Starting dynamic subtest: ccs0 [393.850069] Dynamic subtest ccs0: SUCCESS (0.059s) [393.851284] Subtest basic-wait: SUCCESS (0.444s) [394.568734] [083/133] (649s left) kms_async_flips (test-cursor) [396.084972] Starting subtest: test-cursor [396.325600] Starting dynamic subtest: pipe-A-HDMI-A-3 [396.592996] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.268s) [396.786340] Starting dynamic subtest: pipe-B-HDMI-A-3 [396.859736] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.084s) [397.043643] Starting dynamic subtest: pipe-C-HDMI-A-3 [397.124050] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.091s) [397.303522] Starting dynamic subtest: pipe-D-HDMI-A-3 [397.392891] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.100s) [397.393788] Subtest test-cursor: SUCCESS (1.309s) [397.756297] [084/133] (645s left) api_intel_allocator (two-level-inception) [397.837165] Starting subtest: two-level-inception [403.252585] Subtest two-level-inception: SUCCESS (5.415s) [403.439687] [085/133] (640s left) kms_psr (pr-no-drrs) [404.960063] Subtest pr-no-drrs: SKIP (0.000s) [405.027106] [086/133] (638s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [406.554505] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [406.556560] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [406.711227] [087/133] (637s left) gem_exec_suspend (basic-s0) [406.838360] Starting subtest: basic-S0 [406.839356] Starting dynamic subtest: smem