[57.649482] Initializing watchdogs [57.649528] /dev/watchdog0 [57.663076] [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] [57.667408] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.669520] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.672700] [001/133] (960s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [57.746788] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [57.749188] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [57.854173] [002/133] (960s left) kms_flip (flip-vs-panning) [57.949440] Starting subtest: flip-vs-panning [57.951697] Starting dynamic subtest: A-eDP1 [66.699668] Dynamic subtest A-eDP1: SUCCESS (8.848s) [66.708392] Starting dynamic subtest: B-eDP1 [75.457941] Dynamic subtest B-eDP1: SUCCESS (8.787s) [75.466940] Starting dynamic subtest: C-eDP1 [84.141436] Dynamic subtest C-eDP1: SUCCESS (8.690s) [84.151213] Starting dynamic subtest: D-eDP1 [92.882439] Dynamic subtest D-eDP1: SUCCESS (8.738s) [92.886625] Subtest flip-vs-panning: SUCCESS (35.075s) [94.041030] [003/133] (924s left) i915_pm_rps (thresholds-park) [94.119552] Starting subtest: thresholds-park [94.123918] Subtest thresholds-park: SKIP (0.001s) [94.220577] [004/133] (924s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [94.341668] Starting subtest: cursor-vs-flip-atomic-transitions [124.539808] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.195s) [125.365205] [005/133] (892s left) kms_atomic_transition (plane-all-transition) [125.451921] Starting subtest: plane-all-transition [125.454164] Starting dynamic subtest: pipe-A-eDP-1 [127.944715] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s) [128.266166] Starting dynamic subtest: pipe-B-eDP-1 [131.511934] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.257s) [131.820123] Subtest plane-all-transition: SUCCESS (6.370s) [132.631564] [006/133] (885s left) gem_mmap_offset (open-flood) [132.701725] Starting subtest: open-flood [154.190544] Subtest open-flood: SUCCESS (21.490s) [154.302202] [007/133] (864s left) kms_lease (setcrtc-implicit-plane) [154.401875] Starting subtest: setcrtc-implicit-plane [154.403835] Starting dynamic subtest: pipe-A-eDP-1 [154.879866] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s) [154.888646] Starting dynamic subtest: pipe-B-eDP-1 [155.998800] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.116s) [156.007053] Starting dynamic subtest: pipe-C-eDP-1 [157.112828] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s) [157.121639] Starting dynamic subtest: pipe-D-eDP-1 [158.235719] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s) [158.238111] Subtest setcrtc-implicit-plane: SUCCESS (3.833s) [159.089232] [008/133] (859s left) kms_color (legacy-gamma) [159.182762] Starting subtest: legacy-gamma [159.184622] Starting dynamic subtest: pipe-A-eDP-1 [159.906367] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.724s) [159.913561] Starting dynamic subtest: pipe-B-eDP-1 [161.308676] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s) [161.315812] Starting dynamic subtest: pipe-C-eDP-1 [162.671533] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.361s) [162.679229] Starting dynamic subtest: pipe-D-eDP-1 [164.005394] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s) [164.007619] Subtest legacy-gamma: SUCCESS (4.823s) [164.831466] [009/133] (853s left) kms_universal_plane (universal-plane-functional) [164.919962] Starting subtest: universal-plane-functional [164.922186] Starting dynamic subtest: pipe-A-eDP-1 [168.849644] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.930s) [168.857128] Starting dynamic subtest: pipe-B-eDP-1 [173.496567] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.645s) [173.507088] Starting dynamic subtest: pipe-C-eDP-1 [177.704592] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.201s) [177.712758] Starting dynamic subtest: pipe-D-eDP-1 [182.004742] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.301s) [182.007246] Subtest universal-plane-functional: SUCCESS (17.086s) [182.886403] [010/133] (835s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [182.988521] Starting subtest: coverage-vs-premult-vs-constant [183.289227] Starting dynamic subtest: pipe-A-eDP-1 [183.880736] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s) [183.888754] Starting dynamic subtest: pipe-D-eDP-1 [185.211082] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s) [185.213348] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.223s) [186.057024] [011/133] (832s left) gem_exec_reloc (basic-wc-read-noreloc) [186.125572] Subtest basic-wc-read-noreloc: SKIP (0.000s) [186.202393] [012/133] (832s left) kms_content_protection (uevent-hdcp14) [186.329580] Starting subtest: uevent-hdcp14 [186.333887] Subtest uevent-hdcp14: SKIP (0.000s) [186.465342] [013/133] (832s left) perf_pmu (most-busy-check-all) [186.510238] Starting subtest: most-busy-check-all [186.512148] Starting dynamic subtest: rcs0 [188.294411] Dynamic subtest rcs0: SUCCESS (1.784s) [188.306040] Starting dynamic subtest: bcs0 [190.279190] Dynamic subtest bcs0: SUCCESS (1.982s) [190.290355] Starting dynamic subtest: vcs0 [192.327443] Dynamic subtest vcs0: SUCCESS (2.044s) [192.338261] Starting dynamic subtest: vcs1 [194.311559] Dynamic subtest vcs1: SUCCESS (1.981s) [194.323293] Starting dynamic subtest: vecs0 [196.294790] Dynamic subtest vecs0: SUCCESS (1.981s) [196.306984] Starting dynamic subtest: ccs0 [198.279069] Dynamic subtest ccs0: SUCCESS (1.982s) [198.281885] Subtest most-busy-check-all: SUCCESS (11.770s) [198.396734] [014/133] (820s left) core_hotunplug (unbind-rebind) [198.496536] Starting subtest: unbind-rebind [202.891328] Subtest unbind-rebind: SUCCESS (4.397s) [202.927635] [015/133] (815s left) kms_addfb_basic (no-handle) [204.268609] Starting subtest: no-handle [204.270686] Subtest no-handle: SUCCESS (0.000s) [204.402524] [016/133] (814s left) syncobj_wait (single-wait-all-for-submit-signaled) [204.470601] Starting subtest: single-wait-all-for-submit-signaled [204.473037] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [204.582172] [017/133] (814s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [204.670694] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [204.674776] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [204.764312] [018/133] (814s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [204.854465] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [204.858438] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [204.949879] [019/133] (813s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [205.002818] Starting subtest: yf-tiled-to-vebox-y-tiled [205.007246] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [205.196509] [020/133] (813s left) kms_psr (fbc-psr2-sprite-mmap-gtt) [205.289531] Starting subtest: fbc-psr2-sprite-mmap-gtt [205.291853] Starting dynamic subtest: eDP-1 [205.296144] Dynamic subtest eDP-1: SKIP (0.000s) [205.300388] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s) [205.357436] [021/133] (813s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [205.452313] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [205.456564] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [205.547369] [022/133] (813s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [205.690109] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [216.892770] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.203s) [217.725053] [023/133] (801s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [217.830977] Starting subtest: yf-tiled-8bpp-rotate-90 [217.835320] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [217.928258] [024/133] (801s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [218.027546] Starting subtest: plane-downscale-factor-0-5-with-modifiers [218.029670] Starting dynamic subtest: pipe-A [218.044751] Dynamic subtest pipe-A: SKIP (0.015s) [218.056630] Starting dynamic subtest: pipe-B [218.077117] Dynamic subtest pipe-B: SKIP (0.032s) [218.086084] Starting dynamic subtest: pipe-C [218.112300] Dynamic subtest pipe-C: SKIP (0.032s) [218.120829] Starting dynamic subtest: pipe-D [218.143749] Dynamic subtest pipe-D: SKIP (0.031s) [218.148082] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.114s) [218.251336] [025/133] (800s left) gem_exec_balancer (bonded-pair) [218.322936] Starting subtest: bonded-pair [218.327336] Subtest bonded-pair: SKIP (0.000s) [218.631730] [026/133] (800s left) i915_drm_fdinfo (virtual-busy-hang) [218.675686] Starting subtest: virtual-busy-hang [218.680041] Subtest virtual-busy-hang: SKIP (0.000s) [218.748996] [027/133] (800s left) gem_partial_pwrite_pread (reads-uncached) [218.808734] Subtest reads-uncached: SKIP (0.000s) [218.873227] [028/133] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [218.967874] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [218.972128] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [219.079876] [029/133] (800s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [219.183905] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [219.188161] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [219.290322] [030/133] (800s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [219.385175] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [219.389571] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [219.492011] [031/133] (799s left) perf (invalid-oa-format-id) [219.619857] Starting subtest: invalid-oa-format-id [219.630472] Subtest invalid-oa-format-id: SUCCESS (0.010s) [219.671468] [032/133] (799s left) kms_psr (pr-cursor-render) [219.763968] Starting subtest: pr-cursor-render [219.767518] Subtest pr-cursor-render: SKIP (0.000s) [219.836558] [033/133] (799s left) gem_pread (display) [219.896887] Subtest display: SKIP (0.000s) [219.950496] [034/133] (799s left) gem_pxp (create-protected-buffer) [220.087935] Starting subtest: create-protected-buffer [220.090209] Subtest create-protected-buffer: SUCCESS (0.000s) [220.188427] [035/133] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [220.283585] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [220.286944] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [220.366483] [036/133] (799s left) kms_chamelium_frames (dp-crc-fast) [220.744778] Subtest dp-crc-fast: SKIP (0.000s) [221.517454] [037/133] (798s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [221.614235] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [221.618095] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [221.703787] [038/133] (797s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [221.814938] Starting subtest: 2x-long-flip-vs-cursor-legacy [221.819812] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s) [221.954489] [039/133] (797s left) perf (short-reads) [222.037512] Starting subtest: short-reads [222.049818] Subtest short-reads: SUCCESS (0.012s) [222.091167] [040/133] (797s left) kms_plane_lowres (tiling-x) [222.175425] Starting subtest: tiling-x [222.177713] Starting dynamic subtest: pipe-A-eDP-1 [222.182230] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [222.466525] Starting dynamic subtest: pipe-B-eDP-1 [222.471082] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [222.479493] Starting dynamic subtest: pipe-C-eDP-1 [222.484018] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [222.492523] Starting dynamic subtest: pipe-D-eDP-1 [222.496903] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [222.501234] Subtest tiling-x: SKIP (0.291s) [223.260874] [041/133] (796s left) gem_lmem_swapping (heavy-verify-random) [223.301089] Subtest heavy-verify-random: SKIP (0.000s) [223.345776] [042/133] (796s left) gem_exec_balancer (parallel-contexts) [223.597239] Starting subtest: parallel-contexts [226.224969] Subtest parallel-contexts: SUCCESS (2.628s) [227.374952] [043/133] (792s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [227.426495] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [227.428627] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [227.522563] [044/133] (792s left) gem_exec_whisper (basic-contexts-forked-all) [227.594289] Starting subtest: basic-contexts-forked-all [250.060377] Subtest basic-contexts-forked-all: SUCCESS (22.460s) [250.240883] [045/133] (769s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [250.342944] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [250.347402] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [250.414997] [046/133] (769s left) gem_exec_reloc (basic-wc-cpu) [250.478725] Subtest basic-wc-cpu: SKIP (0.000s) [250.548987] [047/133] (769s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [250.638976] Starting subtest: fbc-psr2-cursor-mmap-gtt [250.641198] Starting dynamic subtest: eDP-1 [250.645412] Dynamic subtest eDP-1: SKIP (0.000s) [250.649690] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s) [250.713891] [048/133] (769s left) kms_atomic_transition (modeset-transition-nonblocking) [250.805885] Starting subtest: modeset-transition-nonblocking [250.807737] Starting dynamic subtest: 1x-outputs [261.861022] Dynamic subtest 1x-outputs: SUCCESS (11.053s) [261.863525] Subtest modeset-transition-nonblocking: SUCCESS (11.055s) [262.722952] [049/133] (757s left) gem_exec_schedule (timeslicing) [262.800394] Starting subtest: timeslicing [262.802277] Starting dynamic subtest: rcs0 [262.812563] Dynamic subtest rcs0: SUCCESS (0.022s) [262.825045] Starting dynamic subtest: bcs0 [262.834036] Dynamic subtest bcs0: SUCCESS (0.020s) [262.842916] Starting dynamic subtest: vcs0 [262.856440] Dynamic subtest vcs0: SUCCESS (0.022s) [262.866679] Starting dynamic subtest: vcs1 [262.877664] Dynamic subtest vcs1: SUCCESS (0.020s) [262.889163] Starting dynamic subtest: vecs0 [262.897892] Dynamic subtest vecs0: SUCCESS (0.019s) [262.906997] Starting dynamic subtest: ccs0 [262.918411] Dynamic subtest ccs0: SUCCESS (0.020s) [262.920497] Subtest timeslicing: SUCCESS (0.129s) [264.301660] [050/133] (755s left) syncobj_wait (multi-wait-for-submit-signaled) [264.344984] Starting subtest: multi-wait-for-submit-signaled [264.347148] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [264.484836] [051/133] (755s left) kms_chamelium_hpd (hdmi-hpd-fast) [264.868471] Subtest hdmi-hpd-fast: SKIP (0.000s) [265.646061] [052/133] (754s left) perf_pmu (busy-accuracy-98) [265.685145] Starting subtest: busy-accuracy-98 [265.687357] Starting dynamic subtest: rcs0 [268.721430] Dynamic subtest rcs0: SUCCESS (3.034s) [268.730525] Starting dynamic subtest: bcs0 [271.772057] Dynamic subtest bcs0: SUCCESS (3.048s) [271.783658] Starting dynamic subtest: vcs0 [274.813826] Dynamic subtest vcs0: SUCCESS (3.039s) [274.823385] Starting dynamic subtest: vcs1 [277.854525] Dynamic subtest vcs1: SUCCESS (3.038s) [277.865856] Starting dynamic subtest: vecs0 [280.898845] Dynamic subtest vecs0: SUCCESS (3.042s) [280.910241] Starting dynamic subtest: ccs0 [283.950996] Dynamic subtest ccs0: SUCCESS (3.049s) [283.954568] Subtest busy-accuracy-98: SUCCESS (18.264s) [284.090690] [053/133] (736s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [284.205826] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [284.208139] Starting dynamic subtest: pipe-A-eDP-1 [284.228537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [284.239441] Starting dynamic subtest: pipe-B-eDP-1 [284.259067] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [284.268440] Starting dynamic subtest: pipe-C-eDP-1 [284.288148] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [284.297609] Starting dynamic subtest: pipe-D-eDP-1 [284.316631] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [284.318509] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s) [286.448226] [054/133] (733s left) gem_exec_reloc (basic-wc-cpu-active) [286.500598] Subtest basic-wc-cpu-active: SKIP (0.000s) [286.581693] [055/133] (733s left) syncobj_timeline (single-wait-all-available-submitted) [286.628913] Starting subtest: single-wait-all-available-submitted [286.631201] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [286.716812] [056/133] (733s left) kms_joiner (basic-force-ultra-joiner) [286.816498] Starting subtest: basic-force-ultra-joiner [286.820674] Subtest basic-force-ultra-joiner: SKIP (0.000s) [286.893377] [057/133] (733s left) gen7_exec_parse (oacontrol-tracking) [286.941345] Subtest oacontrol-tracking: SKIP (0.000s) [286.999044] [058/133] (733s left) api_intel_bb (object-noreloc-purge-cache-simple) [287.053904] Starting subtest: object-noreloc-purge-cache-simple [287.056719] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s) [287.182562] [059/133] (733s left) gem_ctx_shared (exec-single-timeline) [287.244285] Starting subtest: exec-single-timeline [287.246631] Starting dynamic subtest: rcs0 [288.291653] Dynamic subtest rcs0: SUCCESS (1.045s) [288.304231] Starting dynamic subtest: bcs0 [289.377970] Dynamic subtest bcs0: SUCCESS (1.084s) [289.392627] Starting dynamic subtest: vcs0 [290.467912] Dynamic subtest vcs0: SUCCESS (1.085s) [290.483210] Starting dynamic subtest: vcs1 [291.556071] Dynamic subtest vcs1: SUCCESS (1.084s) [291.568548] Starting dynamic subtest: vecs0 [292.643766] Dynamic subtest vecs0: SUCCESS (1.084s) [292.657210] Starting dynamic subtest: ccs0 [293.731397] Dynamic subtest ccs0: SUCCESS (1.085s) [293.734141] Subtest exec-single-timeline: SUCCESS (6.487s) [293.921147] [060/133] (726s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [294.033301] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [295.122630] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.090s) [295.242964] [061/133] (725s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [295.287145] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [295.394227] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s) [295.471770] [062/133] (725s left) gem_workarounds (suspend-resume-context) [295.535407] Starting subtest: suspend-resume-context [311.762452] Subtest suspend-resume-context: SUCCESS (1.315s) [311.914525] [063/133] (708s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [312.046586] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [312.983527] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.965s) [313.787843] [064/133] (706s left) kms_big_fb (4-tiled-64bpp-rotate-0) [313.889049] Starting subtest: 4-tiled-64bpp-rotate-0 [315.328916] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.479s) [315.483335] [065/133] (705s left) gem_exec_reloc (basic-write-gtt-active) [315.543070] Subtest basic-write-gtt-active: SKIP (0.000s) [315.607354] [066/133] (705s left) kms_plane_scaling (planes-upscale-factor-0-25) [315.688313] Starting subtest: planes-upscale-factor-0-25 [315.690123] Starting dynamic subtest: pipe-A [315.746237] Dynamic subtest pipe-A: SUCCESS (0.062s) [315.758074] Starting dynamic subtest: pipe-B [316.845812] Dynamic subtest pipe-B: SUCCESS (1.121s) [316.855766] Starting dynamic subtest: pipe-C [317.934876] Dynamic subtest pipe-C: SUCCESS (1.108s) [317.945349] Starting dynamic subtest: pipe-D [319.064012] Dynamic subtest pipe-D: SUCCESS (1.147s) [319.066294] Subtest planes-upscale-factor-0-25: SUCCESS (3.443s) [320.214448] [067/133] (700s left) gem_eio (wait-wedge-immediate) [320.440128] Starting subtest: wait-wedge-immediate [322.243377] Subtest wait-wedge-immediate: SUCCESS (1.823s) [322.352986] [068/133] (698s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [322.462769] Starting subtest: short-flip-before-cursor-atomic-transitions [323.421943] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.967s) [324.231121] [069/133] (696s left) gem_render_copy (linear-to-vebox-y-tiled) [324.298978] Starting subtest: linear-to-vebox-y-tiled [324.303187] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [324.483495] [070/133] (696s left) gem_ctx_param (root-set) [324.537702] Starting subtest: root-set [324.540221] Subtest root-set: SUCCESS (0.001s) [324.653276] [071/133] (696s left) gem_partial_pwrite_pread (writes-after-reads) [324.722160] Subtest writes-after-reads: SKIP (0.000s) [324.786467] [072/133] (696s left) kms_flip (2x-flip-vs-suspend) [324.883784] Starting subtest: 2x-flip-vs-suspend [324.887839] Subtest 2x-flip-vs-suspend: SKIP (0.002s) [324.984941] [073/133] (696s left) kms_psr (psr2-sprite-plane-onoff) [325.076916] Starting subtest: psr2-sprite-plane-onoff [325.079254] Starting dynamic subtest: eDP-1 [326.799049] Dynamic subtest eDP-1: SUCCESS (1.734s) [326.801326] Subtest psr2-sprite-plane-onoff: SUCCESS (1.735s) [327.656146] [074/133] (693s left) kms_big_fb (y-tiled-16bpp-rotate-0) [327.750071] Starting subtest: y-tiled-16bpp-rotate-0 [327.754539] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [327.876730] [075/133] (693s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [327.933827] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [328.041223] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s) [328.124022] [076/133] (693s left) kms_psr (psr-no-drrs) [328.213298] Starting subtest: psr-no-drrs [328.215605] Starting dynamic subtest: eDP-1 [329.847902] Dynamic subtest eDP-1: SUCCESS (1.647s) [329.850084] Subtest psr-no-drrs: SUCCESS (1.648s) [330.720243] [077/133] (690s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [330.828487] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [330.830927] Starting dynamic subtest: pipe-A-eDP-1 [330.854150] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [330.867101] Starting dynamic subtest: pipe-B-eDP-1 [330.888253] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [330.897514] Starting dynamic subtest: pipe-C-eDP-1 [330.918679] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [330.927946] Starting dynamic subtest: pipe-D-eDP-1 [330.949340] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [330.954088] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [333.070495] [078/133] (688s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [333.168010] Starting subtest: yf-tiled-16bpp-rotate-270 [333.172312] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [333.279305] [079/133] (687s left) kms_chamelium_audio (dp-audio-edid) [333.650434] Subtest dp-audio-edid: SKIP (0.000s) [334.479017] [080/133] (686s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [334.577364] Starting subtest: addfb25-yf-tiled-legacy [334.579233] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [334.672906] [081/133] (686s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [334.766072] Starting subtest: pr-plane-move-sf-dmg-area [334.770232] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s) [334.833024] [082/133] (686s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [334.941804] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [338.582634] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.651s) [339.696006] [083/133] (681s left) kms_hdr (invalid-hdr) [339.787780] Starting subtest: invalid-hdr [341.884299] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [344.882706] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (3.001s) [346.000452] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [348.857759] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (2.868s) [348.860242] Subtest invalid-hdr: SUCCESS (9.075s) [348.974441] [084/133] (672s left) i915_pm_rpm (gem-idle) [350.503490] Starting subtest: gem-idle [356.698643] Subtest gem-idle: SUCCESS (6.196s) [357.042598] [085/133] (664s left) kms_properties (get_properties-sanity-atomic) [358.157103] Starting subtest: get_properties-sanity-atomic [358.159357] Subtest get_properties-sanity-atomic: SUCCESS (0.002s) [358.229935] [086/133] (663s left) kms_vblank (ts-continuation-idle) [358.330168] Starting subtest: ts-continuation-idle [358.332331] Starting dynamic subtest: pipe-A-eDP-1 [359.805287] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.475s) [359.820190] Starting dynamic subtest: pipe-D-eDP-1 [360.857900] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.048s) [360.859908] Subtest ts-continuation-idle: SUCCESS (2.527s) [361.716367] [087/133] (659s left) gem_exec_params (invalid-flag) [361.786680] Starting subtest: invalid-flag [361.788605] Subtest invalid-flag: SUCCESS (0.000s) [361.881013] [088/133] (659s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [361.963817] Starting subtest: plane-all-modeset-transition-internal-panels [361.966006] Starting dynamic subtest: pipe-A-eDP-1 [363.263813] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.300s) [363.544765] Starting dynamic subtest: pipe-B-eDP-1 [364.586694] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s) [364.856296] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.894s) [365.699976] [089/133] (655s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [365.813458] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [372.666818] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.860s) [372.792397] [090/133] (648s left) kms_pm_rpm (cursor) [374.317440] Starting subtest: cursor [374.322258] Subtest cursor: SKIP (0.000s) [375.028396] [091/133] (646s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [375.119130] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [382.279785] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.167s) [382.406539] [092/133] (639s left) kms_dither (fb-8bpc-vs-panel-8bpc) [382.490611] Starting subtest: fb-8bpc-vs-panel-8bpc [382.492944] Starting dynamic subtest: pipe-A-eDP-1 [383.890918] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.402s) [383.893253] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.403s) [384.700516] [093/133] (637s left) fbdev (eof) [384.754572] Starting subtest: eof [384.756774] Subtest eof: SUCCESS (0.000s) [384.823320] [094/133] (637s left) gem_exec_schedule (deep) [385.009240] Starting subtest: deep [385.011947] Starting dynamic subtest: rcs0 [390.805156] Dynamic subtest rcs0: SKIP (5.794s) [390.824510] Starting dynamic subtest: vcs0 [401.700272] Dynamic subtest vcs0: SUCCESS (10.901s) [401.715527] Starting dynamic subtest: vcs1 [413.229496] Dynamic subtest vcs1: SUCCESS (11.527s) [413.241521] Starting dynamic subtest: vecs0 [424.691472] Dynamic subtest vecs0: SUCCESS (11.456s) [424.706759] Starting dynamic subtest: ccs0 [437.231570] Dynamic subtest ccs0: SUCCESS (12.537s) [437.234096] Subtest deep: SUCCESS (52.221s) [438.399727] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true [438.403245] [095/133] (583s left) gem_exec_gttfill (basic) [438.462911] Starting subtest: basic [442.011958] Subtest basic: SUCCESS (3.550s) [442.206087] [096/133] (579s left) gem_exec_schedule (preempt-queue-chain) [442.331833] Subtest preempt-queue-chain: SKIP (0.000s) [442.625929] [097/133] (579s left) prime_vgem (basic-fence-mmap) [442.696068] Starting subtest: basic-fence-mmap [442.700789] Subtest basic-fence-mmap: SKIP (0.000s) [442.846821] [098/133] (579s left) kms_pm_rpm (modeset-non-lpsp-stress) [444.407455] Starting subtest: modeset-non-lpsp-stress [445.558469] Subtest modeset-non-lpsp-stress: SKIP (1.151s) [445.942712] [099/133] (576s left) kms_cursor_crc (cursor-onscreen-512x512) [446.239222] Starting subtest: cursor-onscreen-512x512 [446.243073] Subtest cursor-onscreen-512x512: SKIP (0.001s) [446.404412] [100/133] (575s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [446.511572] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [453.814071] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.308s) [453.941238] [101/133] (568s left) kms_panel_fitting (atomic-fastset) [454.033740] Starting subtest: atomic-fastset [454.036033] Starting dynamic subtest: pipe-A-eDP-1 [454.175241] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s) [454.189994] Starting dynamic subtest: pipe-B-eDP-1 [455.409036] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.233s) [455.422767] Starting dynamic subtest: pipe-C-eDP-1 [456.618491] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s) [456.633194] Starting dynamic subtest: pipe-D-eDP-1 [457.841302] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s) [457.843687] Subtest atomic-fastset: SUCCESS (3.811s) [458.991501] [102/133] (563s left) gen7_exec_parse (basic-allowed) [459.060639] Subtest basic-allowed: SKIP (0.000s) [459.136925] [103/133] (563s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip) [459.231673] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip [459.236354] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [459.331001] [104/133] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [459.417324] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [459.421741] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [459.511750] [105/133] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [459.603689] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [459.608052] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [459.700903] [106/133] (562s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [459.804318] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [463.794630] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.995s) [465.001869] [107/133] (557s left) kms_psr (fbc-pr-dpms) [465.088804] Starting subtest: fbc-pr-dpms [465.093221] Subtest fbc-pr-dpms: SKIP (0.000s) [465.167103] [108/133] (557s left) gem_softpin (evict-single-offset) [465.229464] Starting subtest: evict-single-offset [490.182021] Subtest evict-single-offset: SUCCESS (24.955s) [490.271855] [109/133] (532s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping) [490.412205] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping [490.416450] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s) [490.485827] [110/133] (532s left) gem_ctx_persistence (heartbeat-hostile) [490.543338] Starting subtest: heartbeat-hostile [490.547839] Subtest heartbeat-hostile: SKIP (0.000s) [490.669024] [111/133] (531s left) gem_exec_fence (keep-in-fence) [490.846155] Starting subtest: keep-in-fence [490.848624] Starting dynamic subtest: rcs0 [490.911967] Dynamic subtest rcs0: SUCCESS (0.066s) [490.925729] Starting dynamic subtest: bcs0 [490.965025] Dynamic subtest bcs0: SUCCESS (0.051s) [490.977140] Starting dynamic subtest: vcs0 [492.229671] Dynamic subtest vcs0: SUCCESS (1.261s) [492.241490] Starting dynamic subtest: vcs1 [494.213849] Dynamic subtest vcs1: SUCCESS (1.982s) [494.230877] Starting dynamic subtest: vecs0 [496.198207] Dynamic subtest vecs0: SUCCESS (1.982s) [496.211961] Starting dynamic subtest: ccs0 [496.432359] Dynamic subtest ccs0: SUCCESS (0.233s) [496.435212] Subtest keep-in-fence: SUCCESS (5.588s) [498.278411] [112/133] (524s left) syncobj_wait (multi-wait-submitted-signaled) [498.339773] Starting subtest: multi-wait-submitted-signaled [498.341688] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [498.441829] [113/133] (524s left) kms_prop_blob (invalid-set-prop-any) [498.501275] Starting subtest: invalid-set-prop-any [498.503549] Subtest invalid-set-prop-any: SUCCESS (0.000s) [498.605837] [114/133] (524s left) gem_ctx_persistence (engines-cleanup) [498.662397] Starting subtest: engines-cleanup [498.664852] Starting dynamic subtest: rcs0 [498.740699] Dynamic subtest rcs0: SUCCESS (0.078s) [498.758395] Starting dynamic subtest: bcs0 [498.764878] Dynamic subtest bcs0: SUCCESS (0.022s) [498.781656] Starting dynamic subtest: vcs0 [498.830031] Dynamic subtest vcs0: SUCCESS (0.064s) [498.844633] Starting dynamic subtest: vcs1 [498.867809] Dynamic subtest vcs1: SUCCESS (0.037s) [498.878900] Starting dynamic subtest: vecs0 [498.909022] Dynamic subtest vecs0: SUCCESS (0.039s) [498.920955] Starting dynamic subtest: ccs0 [498.954962] Dynamic subtest ccs0: SUCCESS (0.044s) [498.957340] Subtest engines-cleanup: SUCCESS (0.293s) [499.036773] [115/133] (523s left) kms_draw_crc (draw-method-render) [499.139447] Starting subtest: draw-method-render [499.141680] Starting dynamic subtest: xrgb8888-untiled [499.394381] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s) [499.405595] Starting dynamic subtest: rgb565-untiled [499.649743] Dynamic subtest rgb565-untiled: SUCCESS (0.255s) [499.660009] Starting dynamic subtest: xrgb2101010-untiled [499.871902] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [499.885882] Starting dynamic subtest: xbgr16161616f-untiled [500.094139] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s) [500.105402] Starting dynamic subtest: xrgb8888-xtiled [500.216344] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s) [500.227967] Starting dynamic subtest: rgb565-xtiled [500.327479] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s) [500.338968] Starting dynamic subtest: xrgb2101010-xtiled [500.438351] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [500.448860] Starting dynamic subtest: xbgr16161616f-xtiled [500.560688] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s) [500.571828] Starting dynamic subtest: xrgb8888-4tiled [500.682835] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s) [500.694267] Starting dynamic subtest: rgb565-4tiled [500.794091] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s) [500.804616] Starting dynamic subtest: xrgb2101010-4tiled [500.916212] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s) [500.929517] Starting dynamic subtest: xbgr16161616f-4tiled [501.049443] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s) [501.051710] Subtest draw-method-render: SUCCESS (1.913s) [501.159036] [116/133] (521s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [501.247871] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [501.249835] Starting dynamic subtest: pipe-A-eDP-1 [501.267122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [501.279697] Starting dynamic subtest: pipe-B-eDP-1 [501.296220] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [501.307528] Starting dynamic subtest: pipe-C-eDP-1 [501.323723] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [501.335726] Starting dynamic subtest: pipe-D-eDP-1 [501.352057] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [501.353875] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s) [503.528718] [117/133] (519s left) api_intel_allocator (alloc-simple) [503.592797] Starting subtest: alloc-simple [503.594781] Subtest alloc-simple: SUCCESS (0.003s) [503.720112] [118/133] (519s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [503.815865] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [503.819885] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [503.936788] [119/133] (519s left) vgem_basic (setversion) [503.996921] Starting subtest: setversion [504.001413] Subtest setversion: SUCCESS (0.000s) [504.065875] [120/133] (518s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [504.157022] Starting subtest: fbc-farfromfence-mmap-gtt [504.160979] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [504.260335] [121/133] (518s left) sysfs_heartbeat_interval (precise) [504.308251] Starting subtest: precise [504.310566] Starting dynamic subtest: vecs0 [512.191899] Dynamic subtest vecs0: SUCCESS (7.882s) [512.206140] Starting dynamic subtest: ccs0 [513.291132] Dynamic subtest ccs0: SUCCESS (1.099s) [513.307207] Starting dynamic subtest: vcs0 [521.220011] Dynamic subtest vcs0: SUCCESS (7.930s) [521.232818] Starting dynamic subtest: bcs0 [522.302466] Dynamic subtest bcs0: SUCCESS (1.079s) [522.314004] Starting dynamic subtest: rcs0 [523.374174] Dynamic subtest rcs0: SUCCESS (1.072s) [523.385337] Starting dynamic subtest: vcs1 [531.202564] Dynamic subtest vcs1: SUCCESS (7.829s) [531.204987] Subtest precise: SUCCESS (26.903s) [531.296677] [122/133] (491s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs) [531.404475] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs [531.406723] Starting dynamic subtest: pipe-A-eDP-1 [531.415940] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [531.428518] Starting dynamic subtest: pipe-B-eDP-1 [531.437251] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [531.447720] Starting dynamic subtest: pipe-C-eDP-1 [531.456050] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [531.466210] Starting dynamic subtest: pipe-D-eDP-1 [531.474707] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [531.478724] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s) [533.584180] [123/133] (489s left) kms_cursor_crc (cursor-sliding-256x256) [533.826027] Starting subtest: cursor-sliding-256x256 [533.831034] Starting dynamic subtest: pipe-A-eDP-1 [538.614880] Dynamic subtest pipe-A-eDP-1: FAIL (4.290s) [538.627212] Starting dynamic subtest: pipe-D-eDP-1 [541.590279] Dynamic subtest pipe-D-eDP-1: FAIL (2.854s) [541.592306] Subtest cursor-sliding-256x256: FAIL (7.180s) [542.365923] [124/133] (480s left) prime_busy (hang) [542.430235] Starting subtest: hang [542.432154] Starting dynamic subtest: rcs0 [568.734541] Dynamic subtest rcs0: SUCCESS (26.295s) [568.747723] Starting dynamic subtest: bcs0 [575.894362] Dynamic subtest bcs0: SUCCESS (7.156s) [575.907146] Starting dynamic subtest: vcs0 [582.864331] Dynamic subtest vcs0: SUCCESS (6.968s) [582.877204] Starting dynamic subtest: vcs1 [589.840710] Dynamic subtest vcs1: SUCCESS (6.976s) [589.854015] Starting dynamic subtest: vecs0 [596.880472] Dynamic subtest vecs0: SUCCESS (7.037s) [596.893133] Starting dynamic subtest: ccs0 [610.713349] Dynamic subtest ccs0: SUCCESS (13.836s) [610.716073] Subtest hang: SUCCESS (68.276s) [610.838104] [125/133] (412s left) syncobj_timeline (invalid-signal-zero-handles) [610.887267] Starting subtest: invalid-signal-zero-handles [610.889560] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [610.982021] [126/133] (412s left) gem_ccs (suspend-resume) [611.034351] Starting subtest: suspend-resume [611.038503] Subtest suspend-resume: SKIP (0.000s) [611.140238] [127/133] (412s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [611.227068] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [611.228920] Starting dynamic subtest: pipe-A-eDP-1 [611.248121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s) [611.259306] Starting dynamic subtest: pipe-B-eDP-1 [611.278788] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s) [611.292482] Starting dynamic subtest: pipe-C-eDP-1 [611.312170] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s) [611.323877] Starting dynamic subtest: pipe-D-eDP-1 [611.344089] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s) [611.346322] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.095s) [613.554141] [128/133] (409s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [613.621646] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [613.729477] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s) [613.812013] [129/133] (409s left) kms_cursor_crc (cursor-rapid-movement-512x170) [614.122933] Starting subtest: cursor-rapid-movement-512x170 [614.127711] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [614.273333] [130/133] (409s left) prime_self_import (basic-llseek-bad) [614.309701] Starting subtest: basic-llseek-bad [614.321227] Subtest basic-llseek-bad: SUCCESS (0.011s) [614.430114] [131/133] (409s left) gem_lmem_swapping (verify-random) [614.475351] Subtest verify-random: SKIP (0.000s) [614.514315] [132/133] (409s left) i915_hangman (engine-engine-hang) [614.570934] Starting subtest: engine-engine-hang [614.573042] Starting dynamic subtest: rcs0 [616.163002] Dynamic subtest rcs0: SUCCESS (1.591s) [616.176787] Starting dynamic subtest: bcs0 [618.147175] Dynamic subtest bcs0: SUCCESS (1.982s) [618.161149] Starting dynamic subtest: vcs0 [620.195318] Dynamic subtest vcs0: SUCCESS (2.046s) [620.209156] Starting dynamic subtest: vcs1 [622.179384] Dynamic subtest vcs1: SUCCESS (1.981s) [622.194149] Starting dynamic subtest: vecs0 [624.163063] Dynamic subtest vecs0: SUCCESS (1.981s) [624.177512] Starting dynamic subtest: ccs0 [626.151108] Dynamic subtest ccs0: SUCCESS (1.983s) [626.154101] Subtest engine-engine-hang: SUCCESS (11.579s) [626.231762] [133/133] (397s left) gem_wait (invalid-flags) [626.283411] Starting subtest: invalid-flags [626.285705] Subtest invalid-flags: SUCCESS (0.000s) [626.485201] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_flip results: parsing output: 2/ for test: i915_pm_rps results: parsing output: 3/ for test: kms_cursor_legacy results: parsing output: 4/ for test: kms_atomic_transition results: parsing output: 5/ for test: gem_mmap_offset results: parsing output: 6/ for test: kms_lease results: parsing output: 7/ for test: kms_color results: parsing output: 8/ for test: kms_universal_plane results: parsing output: 9/ for test: kms_plane_alpha_blend results: parsing output: 10/ for test: gem_exec_reloc results: parsing output: 11/ for test: kms_content_protection results: parsing output: 12/ for test: perf_pmu results: parsing output: 13/ for test: core_hotunplug results: parsing output: 14/ for test: kms_addfb_basic results: parsing output: 15/ for test: syncobj_wait results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_render_copy results: parsing output: 19/ for test: kms_psr results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_cursor_legacy results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: kms_plane_scaling results: parsing output: 24/ for test: gem_exec_balancer results: parsing output: 25/ for test: i915_drm_fdinfo results: parsing output: 26/ for test: gem_partial_pwrite_pread results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: gem_pread results: parsing output: 33/ for test: gem_pxp results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_chamelium_frames results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_cursor_legacy results: parsing output: 38/ for test: perf results: parsing output: 39/ for test: kms_plane_lowres results: parsing output: 40/ for test: gem_lmem_swapping results: parsing output: 41/ for test: gem_exec_balancer results: parsing output: 42/ for test: syncobj_wait results: parsing output: 43/ for test: gem_exec_whisper results: parsing output: 44/ for test: kms_flip_scaled_crc results: parsing output: 45/ for test: gem_exec_reloc results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: kms_atomic_transition results: parsing output: 48/ for test: gem_exec_schedule results: parsing output: 49/ for test: syncobj_wait results: parsing output: 50/ for test: kms_chamelium_hpd results: parsing output: 51/ for test: perf_pmu results: parsing output: 52/ for test: kms_ccs results: parsing output: 53/ for test: gem_exec_reloc results: parsing output: 54/ for test: syncobj_timeline results: parsing output: 55/ for test: kms_joiner results: parsing output: 56/ for test: gen7_exec_parse results: parsing output: 57/ for test: api_intel_bb results: parsing output: 58/ for test: gem_ctx_shared results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: gem_workarounds results: parsing output: 62/ for test: kms_cursor_legacy results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: gem_exec_reloc results: parsing output: 65/ for test: kms_plane_scaling results: parsing output: 66/ for test: gem_eio results: parsing output: 67/ for test: kms_cursor_legacy results: parsing output: 68/ for test: gem_render_copy results: parsing output: 69/ for test: gem_ctx_param results: parsing output: 70/ for test: gem_partial_pwrite_pread results: parsing output: 71/ for test: kms_flip results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: kms_big_fb results: parsing output: 74/ for test: syncobj_timeline results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: kms_chamelium_audio results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: kms_psr2_sf results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_hdr results: parsing output: 83/ for test: i915_pm_rpm results: parsing output: 84/ for test: kms_properties results: parsing output: 85/ for test: kms_vblank results: parsing output: 86/ for test: gem_exec_params results: parsing output: 87/ for test: kms_atomic_transition results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_pm_rpm results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_dither results: parsing output: 92/ for test: fbdev results: parsing output: 93/ for test: gem_exec_schedule results: parsing output: 94/ for test: gem_exec_gttfill results: parsing output: 95/ for test: gem_exec_schedule results: parsing output: 96/ for test: prime_vgem results: parsing output: 97/ for test: kms_pm_rpm results: parsing output: 98/ for test: kms_cursor_crc results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_panel_fitting results: parsing output: 101/ for test: gen7_exec_parse results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_psr results: parsing output: 107/ for test: gem_softpin results: parsing output: 108/ for test: kms_plane results: parsing output: 109/ for test: gem_ctx_persistence results: parsing output: 110/ for test: gem_exec_fence results: parsing output: 111/ for test: syncobj_wait results: parsing output: 112/ for test: kms_prop_blob results: parsing output: 113/ for test: gem_ctx_persistence results: parsing output: 114/ for test: kms_draw_crc results: parsing output: 115/ for test: kms_ccs results: parsing output: 116/ for test: api_intel_allocator results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: vgem_basic results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: sysfs_heartbeat_interval results: parsing output: 121/ for test: kms_ccs results: parsing output: 122/ for test: kms_cursor_crc results: parsing output: 123/ for test: prime_busy results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: gem_ccs results: parsing output: 126/ for test: kms_ccs results: parsing output: 127/ for test: syncobj_wait results: parsing output: 128/ for test: kms_cursor_crc results: parsing output: 129/ for test: prime_self_import results: parsing output: 130/ for test: gem_lmem_swapping results: parsing output: 131/ for test: i915_hangman results: parsing output: 132/ for test: gem_wait Done.