[58.640880] Initializing watchdogs [58.640926] /dev/watchdog0 [58.656129] [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.660911] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.663543] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.665362] [001/133] (960s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [58.759359] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [58.760213] Starting dynamic subtest: pipe-A-default-mode [59.953854] Dynamic subtest pipe-A-default-mode: SKIP (1.197s) [59.955696] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.198s) [60.145189] [002/133] (959s left) i915_pm_rpm (gem-idle) [62.094688] Starting subtest: gem-idle [68.298699] Subtest gem-idle: SUCCESS (6.214s) [68.635216] [003/133] (950s left) vgem_basic (bad-handle) [68.707503] Starting subtest: bad-handle [68.708666] Subtest bad-handle: SUCCESS (0.000s) [68.761722] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true [68.763335] [004/133] (950s left) kms_addfb_basic (bad-pitch-0) [69.887242] Starting subtest: bad-pitch-0 [69.888283] Subtest bad-pitch-0: SUCCESS (0.000s) [70.016082] [005/133] (949s left) kms_atomic_transition (modeset-transition) [70.114929] Starting subtest: modeset-transition [70.115798] Starting dynamic subtest: 1x-outputs [80.987495] Dynamic subtest 1x-outputs: SUCCESS (10.876s) [80.990058] Subtest modeset-transition: SUCCESS (10.878s) [81.844563] [006/133] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [81.938062] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [81.939723] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [82.044173] [007/133] (937s left) gem_exec_fence (invalid-fence-array) [82.462450] Starting subtest: invalid-fence-array [82.466531] Subtest invalid-fence-array: SUCCESS (0.002s) [84.015376] [008/133] (935s left) gem_busy (extended) [84.185536] Starting subtest: extended [84.186696] Starting dynamic subtest: rcs0 [84.271410] Dynamic subtest rcs0: SUCCESS (0.086s) [84.283172] Starting dynamic subtest: bcs0 [84.313482] Dynamic subtest bcs0: SUCCESS (0.041s) [84.321779] Starting dynamic subtest: vcs0 [85.917829] Dynamic subtest vcs0: SUCCESS (1.594s) [85.926587] Starting dynamic subtest: vcs1 [87.901913] Dynamic subtest vcs1: SUCCESS (1.983s) [87.910560] Starting dynamic subtest: vecs0 [89.885369] Dynamic subtest vecs0: SUCCESS (1.982s) [89.895069] Starting dynamic subtest: ccs0 [89.923785] Dynamic subtest ccs0: SUCCESS (0.047s) [89.924986] Subtest extended: SUCCESS (5.738s) [90.157797] [009/133] (929s left) gem_softpin (noreloc-s3) [90.214463] Starting subtest: noreloc-S3 [110.308877] Subtest noreloc-S3: SUCCESS (5.397s) [116.427146] [010/133] (909s left) kms_chamelium_hpd (hdmi-hpd) [116.816823] Subtest hdmi-hpd: SKIP (0.000s) [117.574889] [011/133] (907s left) kms_big_fb (y-tiled-8bpp-rotate-90) [117.671366] Starting subtest: y-tiled-8bpp-rotate-90 [117.673266] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [117.775781] [012/133] (907s left) perf (invalid-create-userspace-config) [117.897712] Starting subtest: invalid-create-userspace-config [117.898642] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [117.931108] [013/133] (907s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [118.018004] Starting subtest: primary-yf-tiled-reflect-x-180 [118.088132] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.071s) [118.182921] [014/133] (907s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [118.274200] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [125.537086] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.330s) [125.645523] [015/133] (899s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [125.740283] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [125.741974] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [125.826145] [016/133] (899s left) prime_self_import (basic-with_one_bo_two_files) [125.853915] Starting subtest: basic-with_one_bo_two_files [125.878032] Subtest basic-with_one_bo_two_files: SUCCESS (0.024s) [125.971257] [017/133] (899s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [126.061635] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf [126.063376] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [126.128270] [018/133] (899s left) gem_wait (await) [126.185296] Starting subtest: await [126.186351] Starting dynamic subtest: all-engines [127.299519] Dynamic subtest all-engines: SUCCESS (1.120s) [127.308768] Starting dynamic subtest: rcs0 [128.369186] Dynamic subtest rcs0: SUCCESS (1.074s) [128.386006] Starting dynamic subtest: bcs0 [129.430012] Dynamic subtest bcs0: SUCCESS (1.065s) [129.447855] Starting dynamic subtest: vcs0 [130.496017] Dynamic subtest vcs0: SUCCESS (1.069s) [130.511033] Starting dynamic subtest: vcs1 [131.551187] Dynamic subtest vcs1: SUCCESS (1.057s) [131.568366] Starting dynamic subtest: vecs0 [132.605119] Dynamic subtest vecs0: SUCCESS (1.056s) [132.620478] Starting dynamic subtest: ccs0 [133.662707] Dynamic subtest ccs0: SUCCESS (1.060s) [133.663841] Subtest await: SUCCESS (7.507s) [133.855858] [019/133] (891s left) kms_flip (2x-plain-flip-fb-recreate) [133.952892] Starting subtest: 2x-plain-flip-fb-recreate [133.963928] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s) [134.036388] [020/133] (891s left) syncobj_timeline (single-wait-all-available-signaled) [134.083200] Starting subtest: single-wait-all-available-signaled [134.084231] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [134.191094] [021/133] (891s left) kms_flip (wf_vblank-ts-check) [134.282029] Starting subtest: wf_vblank-ts-check [134.282888] Starting dynamic subtest: A-eDP1 [143.235589] Dynamic subtest A-eDP1: SUCCESS (8.940s) [143.243022] Starting dynamic subtest: B-eDP1 [152.157928] Dynamic subtest B-eDP1: SUCCESS (8.921s) [152.167426] Starting dynamic subtest: C-eDP1 [161.092843] Dynamic subtest C-eDP1: SUCCESS (8.926s) [161.100341] Starting dynamic subtest: D-eDP1 [170.027516] Dynamic subtest D-eDP1: SUCCESS (8.937s) [170.028695] Subtest wf_vblank-ts-check: SUCCESS (35.733s) [171.214554] [022/133] (854s left) kms_vblank (ts-continuation-dpms-suspend) [171.302156] Starting subtest: ts-continuation-dpms-suspend [171.303000] Starting dynamic subtest: pipe-A-eDP-1 [189.274957] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.269s) [189.288574] Starting dynamic subtest: pipe-D-eDP-1 [207.290354] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.875s) [207.291409] Subtest ts-continuation-dpms-suspend: SUCCESS (5.147s) [214.094508] [023/133] (817s left) kms_cursor_crc (cursor-rapid-movement-512x170) [214.399185] Starting subtest: cursor-rapid-movement-512x170 [214.401375] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [214.536313] [024/133] (817s left) i915_hangman (engine-engine-hang) [214.600558] Starting subtest: engine-engine-hang [214.601518] Starting dynamic subtest: rcs0 [216.406135] Dynamic subtest rcs0: SUCCESS (1.833s) [216.416635] Starting dynamic subtest: bcs0 [218.390454] Dynamic subtest bcs0: SUCCESS (2.009s) [218.400054] Starting dynamic subtest: vcs0 [220.437155] Dynamic subtest vcs0: SUCCESS (2.068s) [220.448615] Starting dynamic subtest: vcs1 [222.358381] Dynamic subtest vcs1: SUCCESS (1.935s) [222.368316] Starting dynamic subtest: vecs0 [224.404775] Dynamic subtest vecs0: SUCCESS (2.059s) [224.415051] Starting dynamic subtest: ccs0 [226.390625] Dynamic subtest ccs0: SUCCESS (1.994s) [226.392238] Subtest engine-engine-hang: SUCCESS (11.907s) [226.471416] [025/133] (805s left) gem_exec_schedule (preempt-queue-contexts-chain) [226.528754] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [226.823873] [026/133] (805s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [226.932266] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [226.933212] Starting dynamic subtest: pipe-A-eDP-1 [227.368894] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s) [227.378784] Starting dynamic subtest: pipe-B-eDP-1 [227.387018] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s) [227.394276] Starting dynamic subtest: pipe-C-eDP-1 [227.401563] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s) [227.408296] Starting dynamic subtest: pipe-D-eDP-1 [227.415523] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [227.416267] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.452s) [229.643711] [027/133] (802s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [229.737874] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [235.220087] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.495s) [236.407450] [028/133] (795s left) i915_selftest (live) [238.181329] Starting subtest: live [238.182798] Starting dynamic subtest: sanitycheck [242.503818] Dynamic subtest sanitycheck: SUCCESS (4.327s) [242.512051] Starting dynamic subtest: uncore [246.947376] Dynamic subtest uncore: SUCCESS (4.446s) [246.955069] Starting dynamic subtest: workarounds [263.335680] Dynamic subtest workarounds: FAIL (16.188s) [263.341927] Starting dynamic subtest: gt_engines [267.740912] Dynamic subtest gt_engines: SUCCESS (4.593s) [267.749707] Starting dynamic subtest: gt_timelines [283.672020] Dynamic subtest gt_timelines: SUCCESS (15.929s) [283.680282] Starting dynamic subtest: gt_contexts [286.448897] Dynamic subtest gt_contexts: SUCCESS (2.777s) [286.457264] Starting dynamic subtest: gt_lrc [290.798796] Dynamic subtest gt_lrc: SUCCESS (4.348s) [290.807594] Starting dynamic subtest: gt_mocs [295.170624] Dynamic subtest gt_mocs: SUCCESS (4.371s) [295.179051] Starting dynamic subtest: gt_pm [301.953230] Dynamic subtest gt_pm: SUCCESS (6.782s) [301.961785] Starting dynamic subtest: gt_heartbeat [306.345811] Dynamic subtest gt_heartbeat: SUCCESS (4.392s) [306.351312] Starting dynamic subtest: gt_tlb [315.663251] Dynamic subtest gt_tlb: SUCCESS (9.319s) [315.671963] Starting dynamic subtest: requests [329.341556] Dynamic subtest requests: SUCCESS (13.688s) [329.349911] Starting dynamic subtest: migrate [337.178687] Dynamic subtest migrate: SUCCESS (7.829s) [337.187268] Starting dynamic subtest: active [341.525197] Dynamic subtest active: SUCCESS (4.346s) [341.533666] Starting dynamic subtest: objects [346.330211] Dynamic subtest objects: SUCCESS (4.805s) [346.338831] Starting dynamic subtest: mman [351.274501] Dynamic subtest mman: SUCCESS (4.944s) [351.282457] Starting dynamic subtest: dmabuf [355.632131] Dynamic subtest dmabuf: SUCCESS (4.357s) [355.640400] Starting dynamic subtest: vma [359.934060] Dynamic subtest vma: SUCCESS (4.304s) [359.940844] Starting dynamic subtest: coherency [364.905218] Dynamic subtest coherency: SUCCESS (4.970s) [364.914071] Starting dynamic subtest: gtt [376.592037] Dynamic subtest gtt: SUCCESS (11.689s) [376.600732] Starting dynamic subtest: gem [384.110686] Dynamic subtest gem: SUCCESS (7.519s) [384.122131] Starting dynamic subtest: evict [388.258511] Dynamic subtest evict: SUCCESS (4.148s) [388.267124] Starting dynamic subtest: hugepages [399.053633] Dynamic subtest hugepages: SUCCESS (10.795s) [399.062405] Starting dynamic subtest: gem_contexts [428.027865] Dynamic subtest gem_contexts: SUCCESS (28.964s) [428.036565] Starting dynamic subtest: client [432.371730] Dynamic subtest client: SUCCESS (4.341s) [432.380434] Starting dynamic subtest: gem_migrate [436.714244] Dynamic subtest gem_migrate: SUCCESS (4.342s) [436.722904] Starting dynamic subtest: reset [439.504410] Dynamic subtest reset: SUCCESS (2.788s) [439.513178] Starting dynamic subtest: memory_region [443.823965] Dynamic subtest memory_region: SUCCESS (4.317s) [443.832940] Starting dynamic subtest: hangcheck [458.816110] Dynamic subtest hangcheck: SUCCESS (14.988s) [458.824429] Starting dynamic subtest: execlists [463.119171] Dynamic subtest execlists: SUCCESS (4.303s) [463.128176] Starting dynamic subtest: ring_submission [467.455612] Dynamic subtest ring_submission: SUCCESS (4.334s) [467.464591] Starting dynamic subtest: perf [470.266065] Dynamic subtest perf: SUCCESS (2.809s) [470.273530] Starting dynamic subtest: slpc [482.368636] Dynamic subtest slpc: SUCCESS (12.100s) [482.375570] Starting dynamic subtest: guc [486.313505] Dynamic subtest guc: SUCCESS (3.942s) [486.322232] Starting dynamic subtest: guc_multi_lrc [490.668895] Dynamic subtest guc_multi_lrc: SUCCESS (4.354s) [490.677504] Starting dynamic subtest: guc_hang [495.512220] Dynamic subtest guc_hang: SUCCESS (4.843s) [495.520751] Starting dynamic subtest: late_gt_pm [499.826119] Dynamic subtest late_gt_pm: SUCCESS (4.312s) [499.827514] Subtest live: FAIL (261.655s) [499.848024] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [499.848748] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [499.850785] [029/133] (532s left) kms_plane (pixel-format-yf-tiled-ccs-modifier) [501.425759] Starting subtest: pixel-format-yf-tiled-ccs-modifier [501.427317] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s) [501.521823] [FACT kms_plane (pixel-format-yf-tiled-ccs-modifier)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [501.523077] [FACT kms_plane (pixel-format-yf-tiled-ccs-modifier)] new: kernel.kmod_is_loaded.i915: true [501.525319] [030/133] (530s left) kms_dither (fb-8bpc-vs-panel-8bpc) [501.606411] Starting subtest: fb-8bpc-vs-panel-8bpc [501.607205] Starting dynamic subtest: pipe-A-eDP-1 [503.023444] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.415s) [503.024298] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.417s) [503.834410] [031/133] (528s left) gem_exec_flush (basic-wb-set-default) [503.906254] Starting subtest: basic-wb-set-default [509.363753] Subtest basic-wb-set-default: SUCCESS (5.453s) [509.543222] [032/133] (522s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [509.636282] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [516.210178] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.575s) [516.316929] [033/133] (515s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [516.429838] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs [516.431653] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [517.568527] [034/133] (514s left) kms_cursor_crc (cursor-onscreen-32x10) [517.744480] Starting subtest: cursor-onscreen-32x10 [517.795508] Subtest cursor-onscreen-32x10: SKIP (0.048s) [518.038764] [035/133] (514s left) gem_exec_balancer (bonded-false-hang) [518.315824] Starting subtest: bonded-false-hang [518.317540] Subtest bonded-false-hang: SKIP (0.000s) [518.429584] [036/133] (513s left) prime_mmap (test_reprime) [518.473255] Starting subtest: test_reprime [518.474560] Starting dynamic subtest: test_reprime-smem [518.523518] Dynamic subtest test_reprime-smem: SUCCESS (0.051s) [518.524602] Subtest test_reprime: SUCCESS (0.052s) [518.616713] [037/133] (513s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [518.706077] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [518.707875] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [518.770486] [038/133] (513s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [519.145761] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [519.959778] [039/133] (512s left) gen9_exec_parse (unaligned-jump) [520.011859] Subtest unaligned-jump: SKIP (0.000s) [520.087390] [040/133] (512s left) gem_ctx_persistence (legacy-engines-mixed-process) [520.142817] Starting subtest: legacy-engines-mixed-process [520.143675] Starting dynamic subtest: render [521.476918] Dynamic subtest render: SUCCESS (1.333s) [521.487422] Starting dynamic subtest: bsd1 [523.461898] Dynamic subtest bsd1: SUCCESS (1.983s) [523.472413] Starting dynamic subtest: bsd2 [525.438197] Dynamic subtest bsd2: SUCCESS (1.974s) [525.449042] Starting dynamic subtest: blt [527.427698] Dynamic subtest blt: SUCCESS (1.987s) [527.438025] Starting dynamic subtest: vebox [529.473134] Dynamic subtest vebox: SUCCESS (2.043s) [529.474369] Subtest legacy-engines-mixed-process: SUCCESS (9.332s) [529.561889] [041/133] (502s left) prime_vgem (basic-blt) [529.638864] Starting subtest: basic-blt [529.665489] Subtest basic-blt: SUCCESS (0.026s) [529.795248] [042/133] (502s left) gen9_exec_parse (bb-oversize) [529.847597] Subtest bb-oversize: SKIP (0.000s) [529.921724] [043/133] (502s left) perf (mi-rpc) [530.039595] Starting subtest: mi-rpc [530.041279] Subtest mi-rpc: SKIP (0.000s) [530.079312] [044/133] (502s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [530.169443] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [530.170439] Starting dynamic subtest: pipe-A-eDP-1 [530.179168] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [530.186762] Starting dynamic subtest: pipe-B-eDP-1 [530.195427] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [530.202832] Starting dynamic subtest: pipe-C-eDP-1 [530.210871] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [530.217787] Starting dynamic subtest: pipe-D-eDP-1 [530.225988] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [530.227667] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s) [532.441107] [045/133] (500s left) gem_set_tiling_vs_blt (untiled-to-tiled) [532.508802] Subtest untiled-to-tiled: SKIP (0.000s) [532.568812] [046/133] (500s left) gem_mmap_wc (bad-object) [532.621100] Subtest bad-object: SKIP (0.000s) [532.678777] [047/133] (500s left) syncobj_timeline (multi-wait-all-signaled) [532.728728] Starting subtest: multi-wait-all-signaled [532.729575] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [532.814640] [048/133] (499s left) kms_psr (fbc-psr2-cursor-plane-onoff) [532.910833] Starting subtest: fbc-psr2-cursor-plane-onoff [532.911684] Starting dynamic subtest: eDP-1 [532.913368] Dynamic subtest eDP-1: SKIP (0.000s) [532.915167] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [532.982786] [049/133] (499s left) kms_big_fb (linear-64bpp-rotate-0) [533.083077] Starting subtest: linear-64bpp-rotate-0 [534.794648] Subtest linear-64bpp-rotate-0: SUCCESS (1.712s) [534.943603] [050/133] (497s left) gem_exec_alignment (pi) [534.995178] Starting subtest: pi [593.611705] Subtest pi: SUCCESS (58.623s) [594.819915] [051/133] (438s left) kms_joiner (basic-big-joiner) [594.968435] Starting subtest: basic-big-joiner [594.970157] Subtest basic-big-joiner: SKIP (0.000s) [595.033493] [052/133] (437s left) api_intel_bb (intel-bb-blit-none) [595.089540] Starting subtest: intel-bb-blit-none [599.078057] Subtest intel-bb-blit-none: SUCCESS (3.981s) [599.201197] [053/133] (433s left) kms_big_fb (4-tiled-8bpp-rotate-270) [599.300291] Starting subtest: 4-tiled-8bpp-rotate-270 [599.322156] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s) [599.444134] [054/133] (433s left) syncobj_basic (bad-fd-to-handle) [599.491813] Starting subtest: bad-fd-to-handle [599.492736] Subtest bad-fd-to-handle: SUCCESS (0.000s) [599.585519] [055/133] (433s left) gem_ctx_param (invalid-size-get) [599.640304] Starting subtest: invalid-size-get [599.641370] Subtest invalid-size-get: SUCCESS (0.001s) [599.751196] [056/133] (433s left) gem_exec_fence (syncobj-wait) [600.239051] Starting subtest: syncobj-wait [601.500230] Subtest syncobj-wait: SUCCESS (1.252s) [603.491457] [057/133] (429s left) gem_exec_schedule (preempt-queue-chain) [603.564311] Subtest preempt-queue-chain: SKIP (0.000s) [603.855137] [058/133] (429s left) kms_selftest (drm_dp_mst_helper) [603.896039] Starting subtest: drm_dp_mst_helper [603.901878] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [603.986209] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.083s) [603.994741] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [604.077123] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.091s) [604.084910] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [604.193154] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.116s) [604.194001] Subtest drm_dp_mst_helper: SUCCESS (0.298s) [604.345398] [059/133] (428s left) gem_mmap_gtt (isolation) [604.399070] Subtest isolation: SKIP (0.000s) [604.461796] [060/133] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [604.546099] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [604.547790] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [604.654774] [061/133] (428s left) kms_psr (pr-dpms) [604.744994] Starting subtest: pr-dpms [604.746769] Subtest pr-dpms: SKIP (0.000s) [604.833786] [062/133] (428s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [604.915213] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [604.916936] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [605.013541] [063/133] (428s left) gem_exec_fence (basic-busy-all) [605.066188] Starting subtest: basic-busy-all [605.158274] Subtest basic-busy-all: SUCCESS (0.092s) [607.471246] [064/133] (425s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [607.514516] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [607.515376] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [607.651685] [065/133] (425s left) kms_cdclk (mode-transition) [607.746432] Starting subtest: mode-transition [607.747238] Starting dynamic subtest: pipe-A-eDP-1 [608.034478] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s) [608.045122] Starting dynamic subtest: pipe-B-eDP-1 [608.046830] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s) [608.057056] Starting dynamic subtest: pipe-C-eDP-1 [608.058789] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s) [608.066841] Starting dynamic subtest: pipe-D-eDP-1 [608.068898] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s) [608.070737] Subtest mode-transition: SKIP (0.299s) [608.859044] [066/133] (424s left) kms_flip (bo-too-big-interruptible) [608.946802] Starting subtest: bo-too-big-interruptible [608.948786] Starting dynamic subtest: A-eDP1 [610.306317] Dynamic subtest A-eDP1: SUCCESS (1.356s) [610.316453] Starting dynamic subtest: B-eDP1 [611.534755] Dynamic subtest B-eDP1: SUCCESS (1.227s) [611.546444] Starting dynamic subtest: C-eDP1 [612.869586] Dynamic subtest C-eDP1: SUCCESS (1.333s) [612.881895] Starting dynamic subtest: D-eDP1 [614.201179] Dynamic subtest D-eDP1: SUCCESS (1.328s) [614.204264] Subtest bo-too-big-interruptible: SUCCESS (5.257s) [615.388425] [067/133] (418s left) gem_ctx_isolation (dirty-create) [615.446578] Starting subtest: dirty-create [615.447410] Starting dynamic subtest: rcs0 [615.651055] Dynamic subtest rcs0: SUCCESS (0.204s) [615.662033] Starting dynamic subtest: bcs0 [615.857928] Dynamic subtest bcs0: SUCCESS (0.206s) [615.872855] Starting dynamic subtest: vcs0 [616.070810] Dynamic subtest vcs0: SUCCESS (0.211s) [616.079128] Starting dynamic subtest: vcs1 [617.631130] Dynamic subtest vcs1: SUCCESS (1.560s) [617.641147] Starting dynamic subtest: vecs0 [619.642325] Dynamic subtest vecs0: SUCCESS (2.011s) [619.652944] Starting dynamic subtest: ccs0 [621.636745] Dynamic subtest ccs0: SUCCESS (1.994s) [621.637798] Subtest dirty-create: SUCCESS (6.192s) [621.861655] [068/133] (411s left) kms_pipe_stress (stress-xrgb8888-untiled) [621.960607] Starting subtest: stress-xrgb8888-untiled [627.772903] Subtest stress-xrgb8888-untiled: SUCCESS (5.813s) [627.825312] [069/133] (405s left) gem_close_race (basic-process) [627.880698] Starting subtest: basic-process [627.927397] Subtest basic-process: SUCCESS (0.046s) [628.118724] [070/133] (405s left) kms_feature_discovery (psr1) [628.212329] Starting subtest: psr1 [628.213388] Subtest psr1: SUCCESS (0.000s) [628.282576] [071/133] (405s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [628.381882] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [629.515124] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.134s) [629.637894] [072/133] (403s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping) [629.731432] Starting subtest: pixel-format-y-tiled-modifier-source-clamping [629.733785] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s) [629.803109] [073/133] (403s left) gem_exec_balancer (sliced) [629.880841] Starting subtest: sliced [629.882608] Subtest sliced: SKIP (0.000s) [630.180555] [074/133] (403s left) perf_pmu (busy-double-start) [630.223409] Starting subtest: busy-double-start [630.224481] Starting dynamic subtest: rcs0 [633.832238] Dynamic subtest rcs0: FAIL (3.588s) [633.841310] Starting dynamic subtest: bcs0 [637.382941] Dynamic subtest bcs0: SUCCESS (3.570s) [637.393261] Starting dynamic subtest: vcs0 [641.970868] Dynamic subtest vcs0: SUCCESS (4.587s) [641.983170] Starting dynamic subtest: vcs1 [645.938180] Dynamic subtest vcs1: SUCCESS (3.964s) [645.947705] Starting dynamic subtest: vecs0 [649.968002] Dynamic subtest vecs0: SUCCESS (4.029s) [649.978707] Starting dynamic subtest: ccs0 [653.575482] Dynamic subtest ccs0: FAIL (3.567s) [653.576296] Subtest busy-double-start: FAIL (23.316s) [653.640291] [075/133] (380s left) kms_flip (flip-vs-expired-vblank) [653.729409] Starting subtest: flip-vs-expired-vblank [653.731683] Starting dynamic subtest: A-eDP1 [662.413854] Dynamic subtest A-eDP1: SUCCESS (8.657s) [662.424860] Starting dynamic subtest: B-eDP1 [671.143320] Dynamic subtest B-eDP1: SUCCESS (8.730s) [671.151369] Starting dynamic subtest: C-eDP1 [679.871891] Dynamic subtest C-eDP1: SUCCESS (8.714s) [679.882621] Starting dynamic subtest: D-eDP1 [688.498592] Dynamic subtest D-eDP1: SUCCESS (8.629s) [688.499488] Subtest flip-vs-expired-vblank: SUCCESS (34.743s) [689.616568] [076/133] (344s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [689.708721] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [698.702276] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.996s) [698.810879] [077/133] (334s left) perf (buffer-fill) [698.918904] Starting subtest: buffer-fill [698.919953] Starting dynamic subtest: 0-rcs0 [701.182305] Dynamic subtest 0-rcs0: SUCCESS (2.254s) [701.193390] Starting dynamic subtest: 1-vecs0 [705.622719] Dynamic subtest 1-vecs0: SUCCESS (4.440s) [705.623752] Subtest buffer-fill: SUCCESS (6.697s) [705.662974] [078/133] (328s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait) [707.584939] Starting subtest: modeset-non-lpsp-stress-no-wait [707.634908] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.051s) [707.966177] [079/133] (325s left) kms_content_protection (atomic-dpms-hdcp14) [708.096960] Starting subtest: atomic-dpms-hdcp14 [708.098825] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [708.218705] [080/133] (325s left) prime_vgem (basic-fence-read) [708.284619] Starting subtest: basic-fence-read [708.300851] Subtest basic-fence-read: SKIP (0.015s) [708.423617] [081/133] (325s left) kms_properties (get_properties-sanity-non-atomic) [708.515638] Starting subtest: get_properties-sanity-non-atomic [708.517608] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s) [708.605751] [082/133] (325s left) gem_partial_pwrite_pread (write) [708.667520] Subtest write: SKIP (0.000s) [708.729143] [083/133] (325s left) kms_properties (plane-properties-atomic) [708.822416] Starting subtest: plane-properties-atomic [708.823405] Starting dynamic subtest: pipe-A-eDP-1 [709.388124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s) [709.403034] Starting dynamic subtest: pipe-B-eDP-1 [710.655717] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.266s) [710.664472] Starting dynamic subtest: pipe-C-eDP-1 [711.983187] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.327s) [711.991421] Starting dynamic subtest: pipe-D-eDP-1 [713.223565] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s) [713.224496] Subtest plane-properties-atomic: SUCCESS (4.402s) [714.033649] [084/133] (320s left) syncobj_timeline (invalid-wait-bad-flags) [714.089488] Starting subtest: invalid-wait-bad-flags [714.090366] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [714.183981] [085/133] (319s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [714.277434] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [714.279203] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [714.378166] [086/133] (319s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [714.468811] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [714.470586] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [714.538951] [087/133] (319s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [714.620666] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [714.622796] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [715.747812] [088/133] (318s left) gem_readwrite (write-bad-handle) [715.798241] Subtest write-bad-handle: SKIP (0.000s) [715.855385] [089/133] (318s left) sw_sync (timeline_closed_signaled) [715.891542] Starting subtest: timeline_closed_signaled [715.892480] Subtest timeline_closed_signaled: SUCCESS (0.000s) [715.949277] [090/133] (318s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [717.481273] Starting subtest: dpms-mode-unset-non-lpsp [718.649148] Subtest dpms-mode-unset-non-lpsp: SKIP (1.170s) [719.035495] [091/133] (315s left) kms_addfb_basic (bad-pitch-63) [719.079644] Starting subtest: bad-pitch-63 [719.080533] Subtest bad-pitch-63: SUCCESS (0.000s) [719.199183] [092/133] (315s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [719.296618] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [719.298198] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [719.413734] [093/133] (314s left) gem_userptr_blits (map-fixed-invalidate-busy) [719.475694] Starting subtest: map-fixed-invalidate-busy [719.477531] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [719.593622] [094/133] (314s left) perf_pmu (busy-idle) [719.628563] Starting subtest: busy-idle [719.629502] Starting dynamic subtest: rcs0 [720.321698] Dynamic subtest rcs0: SUCCESS (0.694s) [720.334154] Starting dynamic subtest: bcs0 [720.982460] Dynamic subtest bcs0: SUCCESS (0.658s) [720.996634] Starting dynamic subtest: vcs0 [722.424860] Dynamic subtest vcs0: SUCCESS (1.430s) [722.438378] Starting dynamic subtest: vcs1 [724.472549] Dynamic subtest vcs1: SUCCESS (2.045s) [724.483854] Starting dynamic subtest: vecs0 [726.457418] Dynamic subtest vecs0: SUCCESS (1.983s) [726.468605] Starting dynamic subtest: ccs0 [727.114126] Dynamic subtest ccs0: SUCCESS (0.664s) [727.117144] Subtest busy-idle: SUCCESS (7.489s) [727.215068] [095/133] (307s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [727.310225] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [727.312045] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [727.399364] [096/133] (307s left) kms_psr (psr-sprite-mmap-gtt) [727.490036] Starting subtest: psr-sprite-mmap-gtt [727.490929] Starting dynamic subtest: eDP-1 [728.960003] Dynamic subtest eDP-1: SKIP (1.459s) [728.962199] Subtest psr-sprite-mmap-gtt: SKIP (1.461s) [729.127166] [097/133] (305s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [729.233282] Starting subtest: cursorB-vs-flipA-varying-size [729.236439] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s) [729.386585] [098/133] (305s left) gem_create (create-ext-placement-all) [729.569512] Starting subtest: create-ext-placement-all [729.570363] Subtest create-ext-placement-all: SUCCESS (0.000s) [729.639869] [099/133] (304s left) gem_render_copy (linear-to-vebox-yf-tiled) [729.684670] Starting subtest: linear-to-vebox-yf-tiled [729.686553] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [729.873371] [100/133] (304s left) kms_color (ctm-max) [729.954211] Starting subtest: ctm-max [729.955115] Starting dynamic subtest: pipe-A-eDP-1 [730.685900] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s) [730.696745] Starting dynamic subtest: pipe-B-eDP-1 [732.058357] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.372s) [732.067370] Starting dynamic subtest: pipe-C-eDP-1 [733.435520] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s) [733.446208] Starting dynamic subtest: pipe-D-eDP-1 [734.767910] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [734.768845] Subtest ctm-max: SUCCESS (4.814s) [735.565160] [101/133] (299s left) kms_psr (psr2-no-drrs) [735.655962] Starting subtest: psr2-no-drrs [735.656864] Starting dynamic subtest: eDP-1 [737.247402] Dynamic subtest eDP-1: SUCCESS (1.592s) [737.248254] Subtest psr2-no-drrs: SUCCESS (1.593s) [738.043898] [102/133] (296s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [738.152034] Starting subtest: yf-tiled-8bpp-rotate-270 [738.153808] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [738.224440] [103/133] (296s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic) [738.325596] Starting subtest: async-flip-with-page-flip-events-linear-atomic [738.704529] Starting dynamic subtest: pipe-A-eDP-1 [741.446994] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.733s) [741.828281] Starting dynamic subtest: pipe-B-eDP-1 [744.576811] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.747s) [744.942861] Starting dynamic subtest: pipe-C-eDP-1 [747.711422] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s) [748.075442] Starting dynamic subtest: pipe-D-eDP-1 [750.837352] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.760s) [750.838561] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.506s) [752.009463] [104/133] (282s left) kms_psr2_su (page_flip-xrgb8888) [752.062677] Subtest page_flip-XRGB8888: SKIP (0.000s) [752.116922] [105/133] (282s left) syncobj_eventfd (invalid-illegal-handle) [752.168091] Starting subtest: invalid-illegal-handle [752.168902] Subtest invalid-illegal-handle: SUCCESS (0.000s) [752.261297] [106/133] (282s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [752.349011] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [752.350747] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [752.437277] [107/133] (282s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [752.540135] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [752.541965] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [752.628756] [108/133] (282s left) gem_mmap_gtt (basic-small-bo-tiledx) [752.672434] Subtest basic-small-bo-tiledX: SKIP (0.000s) [752.723688] [109/133] (282s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [752.815943] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [752.817678] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [752.905740] [110/133] (282s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [753.001777] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [754.036750] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.035s) [754.156168] [111/133] (280s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [754.254769] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [754.256507] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [754.327177] [112/133] (280s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [754.379845] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [754.484396] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s) [754.572395] [113/133] (280s left) gem_softpin (allocator-basic) [754.629837] Starting subtest: allocator-basic [754.705372] Subtest allocator-basic: SUCCESS (0.075s) [754.844131] [114/133] (280s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [754.935752] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [754.937468] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [755.047575] [115/133] (280s left) gem_flink_basic (bad-open) [755.095627] Starting subtest: bad-open [755.096693] Subtest bad-open: SUCCESS (0.000s) [755.181202] [116/133] (279s left) gem_exec_whisper (basic-fds-priority-all) [755.236237] Starting subtest: basic-fds-priority-all [778.710633] Subtest basic-fds-priority-all: SUCCESS (23.469s) [778.881224] [117/133] (256s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [778.982577] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [778.983591] Starting dynamic subtest: pipe-A [779.003793] Dynamic subtest pipe-A: SKIP (0.020s) [779.012897] Starting dynamic subtest: pipe-B [779.040892] Dynamic subtest pipe-B: SKIP (0.036s) [779.049790] Starting dynamic subtest: pipe-C [779.079071] Dynamic subtest pipe-C: SKIP (0.037s) [779.089676] Starting dynamic subtest: pipe-D [779.117187] Dynamic subtest pipe-D: SKIP (0.037s) [779.118929] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.133s) [779.225104] [118/133] (256s left) gem_ctx_param (basic) [779.279823] Starting subtest: basic [779.280827] Subtest basic: SUCCESS (0.001s) [779.397945] [119/133] (255s left) kms_cursor_edge_walk (64x64-top-bottom) [779.479859] Starting subtest: 64x64-top-bottom [779.480864] Starting dynamic subtest: pipe-A-eDP-1 [782.991398] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.511s) [783.000203] Starting dynamic subtest: pipe-D-eDP-1 [786.110379] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s) [786.111259] Subtest 64x64-top-bottom: SUCCESS (6.632s) [786.907139] [120/133] (248s left) kms_psr (fbc-psr-primary-blt) [786.993844] Starting subtest: fbc-psr-primary-blt [786.994792] Starting dynamic subtest: eDP-1 [786.996717] Dynamic subtest eDP-1: SKIP (0.000s) [786.998543] Subtest fbc-psr-primary-blt: SKIP (0.001s) [787.064087] [121/133] (248s left) gem_mmap_gtt (cpuset-big-copy-xy) [787.112792] Subtest cpuset-big-copy-XY: SKIP (0.000s) [787.165553] [122/133] (248s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [787.216466] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [787.218178] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [787.396826] [123/133] (248s left) api_intel_allocator (default-alignment) [787.442031] Starting subtest: default-alignment [787.445102] Subtest default-alignment: SUCCESS (0.004s) [787.545708] [124/133] (247s left) kms_lease (lease-get) [787.634863] Starting subtest: lease-get [787.635762] Starting dynamic subtest: pipe-A-eDP-1 [787.636643] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [787.645498] Starting dynamic subtest: pipe-B-eDP-1 [787.646317] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [787.655127] Starting dynamic subtest: pipe-C-eDP-1 [787.656040] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [787.664809] Starting dynamic subtest: pipe-D-eDP-1 [787.665697] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [787.666583] Subtest lease-get: SUCCESS (0.009s) [787.752002] [125/133] (247s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [787.836443] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [794.569390] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.734s) [794.691442] [126/133] (240s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [794.788540] Starting subtest: plane-use-after-nonblocking-unbind [794.789388] Starting dynamic subtest: pipe-A-eDP-1 [794.855629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.066s) [795.161354] Starting dynamic subtest: pipe-B-eDP-1 [795.937317] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.785s) [796.246038] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.457s) [797.094743] [127/133] (238s left) kms_busy (extended-pageflip-hang-newfb) [797.182692] Starting subtest: extended-pageflip-hang-newfb [797.183594] Starting dynamic subtest: pipe-A [823.309795] Dynamic subtest pipe-A: SUCCESS (26.131s) [823.319798] Starting dynamic subtest: pipe-D [838.206918] Dynamic subtest pipe-D: SUCCESS (14.898s) [838.207769] Subtest extended-pageflip-hang-newfb: SUCCESS (41.034s) [839.042101] [128/133] (196s left) dumb_buffer (create-valid-dumb) [839.089964] Starting subtest: create-valid-dumb [839.090894] Subtest create-valid-dumb: SUCCESS (0.000s) [839.182637] [129/133] (196s left) gem_lmem_swapping (heavy-multi) [839.218779] Subtest heavy-multi: SKIP (0.000s) [839.258170] [130/133] (196s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [839.347408] Starting subtest: psr-1p-primscrn-cur-indfb-move [846.768129] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.423s) [846.890239] [131/133] (188s left) perf_pmu (all-busy-check-all) [846.933630] Starting subtest: all-busy-check-all [848.441360] Subtest all-busy-check-all: SUCCESS (1.498s) [848.516433] [132/133] (187s left) gem_exec_nop (basic-parallel) [848.588711] Starting subtest: basic-parallel [863.418017] Subtest basic-parallel: SUCCESS (14.753s) [863.625377] [133/133] (172s left) gem_exec_flush (basic-batch-kernel-default-uc) [863.690698] Starting subtest: basic-batch-kernel-default-uc [870.394954] Subtest basic-batch-kernel-default-uc: SUCCESS (6.683s) [870.582137] Closing watchdogs results: parsing output: 0/ for test: kms_flip_scaled_crc results: parsing output: 1/ for test: i915_pm_rpm results: parsing output: 2/ for test: vgem_basic results: parsing output: 3/ for test: kms_addfb_basic results: parsing output: 4/ for test: kms_atomic_transition results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_exec_fence results: parsing output: 7/ for test: gem_busy results: parsing output: 8/ for test: gem_softpin results: parsing output: 9/ for test: kms_chamelium_hpd results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: perf results: parsing output: 12/ for test: kms_rotation_crc results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: prime_self_import results: parsing output: 16/ for test: kms_psr2_sf results: parsing output: 17/ for test: gem_wait results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: kms_vblank results: parsing output: 22/ for test: kms_cursor_crc results: parsing output: 23/ for test: i915_hangman results: parsing output: 24/ for test: gem_exec_schedule results: parsing output: 25/ for test: kms_ccs results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: i915_selftest results: parsing output: 28/ for test: kms_plane results: parsing output: 29/ for test: kms_dither results: parsing output: 30/ for test: gem_exec_flush results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_ccs results: parsing output: 33/ for test: kms_cursor_crc results: parsing output: 34/ for test: gem_exec_balancer results: parsing output: 35/ for test: prime_mmap results: parsing output: 36/ for test: kms_plane results: parsing output: 37/ for test: kms_chamelium_edid results: parsing output: 38/ for test: gen9_exec_parse results: parsing output: 39/ for test: gem_ctx_persistence results: parsing output: 40/ for test: prime_vgem results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: perf results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: gem_set_tiling_vs_blt results: parsing output: 45/ for test: gem_mmap_wc results: parsing output: 46/ for test: syncobj_timeline results: parsing output: 47/ for test: kms_psr results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: gem_exec_alignment results: parsing output: 50/ for test: kms_joiner results: parsing output: 51/ for test: api_intel_bb results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: syncobj_basic results: parsing output: 54/ for test: gem_ctx_param results: parsing output: 55/ for test: gem_exec_fence results: parsing output: 56/ for test: gem_exec_schedule results: parsing output: 57/ for test: kms_selftest results: parsing output: 58/ for test: gem_mmap_gtt results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_psr results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_exec_fence results: parsing output: 63/ for test: syncobj_wait results: parsing output: 64/ for test: kms_cdclk results: parsing output: 65/ for test: kms_flip results: parsing output: 66/ for test: gem_ctx_isolation results: parsing output: 67/ for test: kms_pipe_stress results: parsing output: 68/ for test: gem_close_race results: parsing output: 69/ for test: kms_feature_discovery results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: kms_plane results: parsing output: 72/ for test: gem_exec_balancer results: parsing output: 73/ for test: perf_pmu results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: perf results: parsing output: 77/ for test: kms_pm_rpm results: parsing output: 78/ for test: kms_content_protection results: parsing output: 79/ for test: prime_vgem results: parsing output: 80/ for test: kms_properties results: parsing output: 81/ for test: gem_partial_pwrite_pread results: parsing output: 82/ for test: kms_properties results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_flip_scaled_crc results: parsing output: 86/ for test: kms_ccs results: parsing output: 87/ for test: gem_readwrite results: parsing output: 88/ for test: sw_sync results: parsing output: 89/ for test: kms_pm_rpm results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: gem_userptr_blits results: parsing output: 93/ for test: perf_pmu results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_psr results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: gem_create results: parsing output: 98/ for test: gem_render_copy results: parsing output: 99/ for test: kms_color results: parsing output: 100/ for test: kms_psr results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_async_flips results: parsing output: 103/ for test: kms_psr2_su results: parsing output: 104/ for test: syncobj_eventfd results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_mmap_gtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_big_fb results: parsing output: 110/ for test: kms_psr2_sf results: parsing output: 111/ for test: syncobj_timeline results: parsing output: 112/ for test: gem_softpin results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_flink_basic results: parsing output: 115/ for test: gem_exec_whisper results: parsing output: 116/ for test: kms_plane_scaling results: parsing output: 117/ for test: gem_ctx_param results: parsing output: 118/ for test: kms_cursor_edge_walk results: parsing output: 119/ for test: kms_psr results: parsing output: 120/ for test: gem_mmap_gtt results: parsing output: 121/ for test: gem_render_copy results: parsing output: 122/ for test: api_intel_allocator results: parsing output: 123/ for test: kms_lease results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_atomic_transition results: parsing output: 126/ for test: kms_busy results: parsing output: 127/ for test: dumb_buffer results: parsing output: 128/ for test: gem_lmem_swapping results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: perf_pmu results: parsing output: 131/ for test: gem_exec_nop results: parsing output: 132/ for test: gem_exec_flush Done.