[57.060533] Initializing watchdogs [57.060575] /dev/watchdog0 [57.073864] [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.078028] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.080305] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.083764] [001/131] (960s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [57.159974] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [57.162358] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [57.271432] [002/131] (960s left) kms_cursor_edge_walk (256x256-top-edge) [57.374029] Starting subtest: 256x256-top-edge [57.376339] Starting dynamic subtest: pipe-A-eDP-1 [60.796054] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.421s) [60.802850] Starting dynamic subtest: pipe-D-eDP-1 [63.918414] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s) [63.920549] Subtest 256x256-top-edge: SUCCESS (6.545s) [64.752880] [003/131] (952s left) kms_async_flips (crc) [64.849833] Starting subtest: crc [65.224907] Starting dynamic subtest: pipe-A-eDP-1 [68.156765] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.932s) [68.529374] Starting dynamic subtest: pipe-B-eDP-1 [71.487631] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.964s) [71.862274] Starting dynamic subtest: pipe-C-eDP-1 [74.698966] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.846s) [75.066335] Starting dynamic subtest: pipe-D-eDP-1 [77.910961] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.852s) [77.913292] Subtest crc: SUCCESS (13.063s) [79.119064] [004/131] (938s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [79.272675] Starting subtest: dp-mst-lic-type-0-hdcp14 [79.277136] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [79.437115] [005/131] (938s left) kms_big_fb (yf-tiled-32bpp-rotate-270) [79.541867] Starting subtest: yf-tiled-32bpp-rotate-270 [79.546222] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s) [79.676967] [006/131] (938s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [79.770141] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [79.774199] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [79.879952] [007/131] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [79.987404] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [79.991779] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [80.087868] [008/131] (937s left) kms_chamelium_frames (hdmi-aspect-ratio) [80.479292] Subtest hdmi-aspect-ratio: SKIP (0.000s) [81.335831] [009/131] (936s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [81.437930] Starting subtest: fbc-1p-primscrn-cur-indfb-move [85.529643] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.095s) [86.759512] [010/131] (931s left) kms_selftest (drm_damage_helper) [86.800731] Starting subtest: drm_damage_helper [86.808200] Starting dynamic subtest: drm_test_damage_iter_no_damage [86.938092] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.129s) [86.946592] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src [87.079153] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.140s) [87.088057] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved [87.219602] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.140s) [87.227048] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved [87.367599] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.147s) [87.378877] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible [87.509239] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.142s) [87.517490] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc [87.654173] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.144s) [87.662750] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb [87.742270] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.089s) [87.750921] Starting dynamic subtest: drm_test_damage_iter_simple_damage [87.876300] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.132s) [87.884631] Starting dynamic subtest: drm_test_damage_iter_single_damage [88.038169] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.161s) [88.046652] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src [88.178222] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.139s) [88.186612] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src [88.316219] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.137s) [88.324724] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src [88.417451] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.102s) [88.425648] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src [88.521571] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.104s) [88.528059] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src [88.638078] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.115s) [88.644437] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved [88.749989] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.112s) [88.756305] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved [88.859310] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.111s) [88.866693] Starting dynamic subtest: drm_test_damage_iter_damage [88.961161] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.100s) [88.968825] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect [89.084341] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.121s) [89.092110] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside [89.191758] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.110s) [89.203698] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved [89.299522] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.105s) [89.311071] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible [89.399554] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.101s) [89.401620] Subtest drm_damage_helper: SUCCESS (2.600s) [89.604786] [011/131] (928s left) gem_eio (banned) [89.792501] Starting subtest: banned [90.295711] Subtest banned: SUCCESS (0.506s) [90.478955] [012/131] (927s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [90.586998] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [91.266581] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.681s) [91.471759] [013/131] (926s left) perf (invalid-oa-exponent) [91.598388] Starting subtest: invalid-oa-exponent [91.609547] Subtest invalid-oa-exponent: SUCCESS (0.012s) [91.644021] [014/131] (926s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [91.766857] Starting subtest: 2x-long-cursor-vs-flip-legacy [91.771295] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [91.930407] [015/131] (926s left) gem_mmap (basic-small-bo) [92.000885] Subtest basic-small-bo: SKIP (0.000s) [92.071241] [016/131] (926s left) gem_ctx_param (invalid-get-engines) [92.129246] Starting subtest: invalid-get-engines [92.131599] Subtest invalid-get-engines: SUCCESS (0.002s) [92.261086] [017/131] (925s left) perf_pmu (interrupts) [92.298579] Starting subtest: interrupts [93.420197] Subtest interrupts: SUCCESS (1.119s) [93.574905] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true [93.579382] [018/131] (924s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [93.684429] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [93.688894] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [93.805172] [019/131] (924s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [93.920060] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [93.924355] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [94.052089] [020/131] (924s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [94.155910] Starting subtest: psr-1p-pri-indfb-multidraw [116.507554] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.354s) [116.669416] [021/131] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [116.769920] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [123.942207] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.173s) [124.129500] [022/131] (894s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [124.188381] Starting subtest: multi-wait-available-unsubmitted-submitted [124.190751] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s) [124.323050] [023/131] (894s left) gem_exec_balancer (semaphore) [124.389678] Starting subtest: semaphore [125.936076] Subtest semaphore: SUCCESS (1.545s) [126.286939] [024/131] (892s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [131.340577] Starting subtest: fbc-pr-plane-move-sf-dmg-area [131.345031] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s) [132.227570] [025/131] (886s left) kms_addfb_basic (unused-handle) [132.291196] Starting subtest: unused-handle [132.293649] Subtest unused-handle: SUCCESS (0.000s) [132.464774] [026/131] (886s left) kms_pm_rpm (modeset-lpsp) [134.096305] Starting subtest: modeset-lpsp [135.550626] Subtest modeset-lpsp: SUCCESS (1.456s) [135.664531] [027/131] (882s left) gem_exec_params (dr1-dirt) [135.738887] Starting subtest: DR1-dirt [135.740758] Subtest DR1-dirt: SUCCESS (0.000s) [135.866812] [028/131] (882s left) gem_exec_alignment (many) [135.928661] Starting subtest: many [157.408287] Subtest many: SUCCESS (21.477s) [159.939690] [029/131] (858s left) syncobj_timeline (invalid-signal-one-illegal-handle) [160.040905] Starting subtest: invalid-signal-one-illegal-handle [160.043160] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [160.141518] [030/131] (858s left) kms_flip (2x-plain-flip) [160.250855] Starting subtest: 2x-plain-flip [160.259312] Subtest 2x-plain-flip: SKIP (0.010s) [160.356514] [031/131] (858s left) core_getstats (basic) [160.423066] Starting subtest: basic [160.425393] Subtest basic: SUCCESS (0.000s) [160.559857] [032/131] (858s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [160.613398] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [160.684171] [033/131] (858s left) kms_invalid_mode (zero-hdisplay) [160.785068] Starting subtest: zero-hdisplay [160.787407] Starting dynamic subtest: pipe-A-eDP-1 [161.072312] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [161.081346] Starting dynamic subtest: pipe-B-eDP-1 [161.083543] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [161.091445] Starting dynamic subtest: pipe-C-eDP-1 [161.093624] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [161.101606] Starting dynamic subtest: pipe-D-eDP-1 [161.103486] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [161.105348] Subtest zero-hdisplay: SUCCESS (0.294s) [161.960697] [034/131] (856s left) kms_setmode (basic-clone-single-crtc) [162.024133] Starting subtest: basic-clone-single-crtc [162.031466] Subtest basic-clone-single-crtc: SKIP (0.000s) [162.144173] [035/131] (856s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [162.211398] Starting subtest: x-tiled-to-vebox-y-tiled [162.215964] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [162.416675] [036/131] (856s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs) [162.513361] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs [162.518158] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s) [163.696889] [037/131] (855s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [163.800491] Starting subtest: bad-aux-stride-yf-tiled-ccs [163.802806] Starting dynamic subtest: pipe-A-eDP-1 [163.826350] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [163.840695] Starting dynamic subtest: pipe-B-eDP-1 [163.862919] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [163.873336] Starting dynamic subtest: pipe-C-eDP-1 [163.895445] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [163.905171] Starting dynamic subtest: pipe-D-eDP-1 [163.926811] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [163.930845] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s) [165.983287] [038/131] (853s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [166.113614] Starting subtest: cursorB-vs-flipB-toggle [166.118170] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [166.279473] [039/131] (852s left) kms_plane (planar-pixel-format-settings) [166.370016] Starting subtest: planar-pixel-format-settings [166.416564] Subtest planar-pixel-format-settings: SUCCESS (0.048s) [166.532573] [040/131] (852s left) gem_exec_schedule (semaphore-user) [166.610754] Starting subtest: semaphore-user [166.660717] Subtest semaphore-user: SUCCESS (0.056s) [167.956201] [041/131] (851s left) gem_userptr_blits (sync-overlap) [168.022283] Starting subtest: sync-overlap [168.024201] Subtest sync-overlap: SUCCESS (0.000s) [168.189993] [042/131] (851s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [168.280754] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [168.283084] Starting dynamic subtest: pipe-A-eDP-1 [168.338479] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [168.346634] Starting dynamic subtest: pipe-B-eDP-1 [168.403191] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [168.412841] Starting dynamic subtest: pipe-C-eDP-1 [168.470108] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [168.479107] Starting dynamic subtest: pipe-D-eDP-1 [168.533792] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [168.538039] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s) [170.435792] [043/131] (848s left) i915_getparams_basic (basic-subslice-total) [170.499247] Starting subtest: basic-subslice-total [170.503710] Subtest basic-subslice-total: SUCCESS (0.000s) [170.605729] [044/131] (848s left) gem_exec_whisper (basic-queues-forked-all) [170.682611] Starting subtest: basic-queues-forked-all [192.184531] Subtest basic-queues-forked-all: SUCCESS (21.502s) [192.394052] [045/131] (826s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [192.501485] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [192.505847] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [192.634900] [046/131] (826s left) kms_big_fb (linear-32bpp-rotate-270) [192.755502] Starting subtest: linear-32bpp-rotate-270 [192.777284] Subtest linear-32bpp-rotate-270: SKIP (0.021s) [192.939487] [047/131] (826s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [193.037133] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [193.039410] Starting dynamic subtest: pipe-A-eDP-1 [193.062975] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [193.072754] Starting dynamic subtest: pipe-B-eDP-1 [193.094114] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [193.101916] Starting dynamic subtest: pipe-C-eDP-1 [193.123127] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [193.130821] Starting dynamic subtest: pipe-D-eDP-1 [193.152452] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [193.156798] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s) [195.213130] [048/131] (824s left) gem_exec_whisper (basic-contexts-all) [195.282167] Starting subtest: basic-contexts-all [206.211473] Subtest basic-contexts-all: SUCCESS (10.900s) [206.392390] [049/131] (813s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [206.496308] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [206.498666] Starting dynamic subtest: pipe-A [206.516582] Dynamic subtest pipe-A: SKIP (0.017s) [206.525976] Starting dynamic subtest: pipe-B [206.546637] Dynamic subtest pipe-B: SKIP (0.030s) [206.555373] Starting dynamic subtest: pipe-C [206.579408] Dynamic subtest pipe-C: SKIP (0.030s) [206.587892] Starting dynamic subtest: pipe-D [206.607428] Dynamic subtest pipe-D: SKIP (0.029s) [206.611214] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.109s) [206.742694] [050/131] (812s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs) [206.833089] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs [206.835234] Starting dynamic subtest: pipe-A-eDP-1 [206.859274] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [206.869927] Starting dynamic subtest: pipe-B-eDP-1 [206.892572] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [206.900935] Starting dynamic subtest: pipe-C-eDP-1 [206.923521] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [206.931933] Starting dynamic subtest: pipe-D-eDP-1 [206.955533] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [206.959879] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s) [209.019685] [051/131] (810s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [209.135653] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [216.467426] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.334s) [216.627028] [052/131] (803s left) gem_ccs (ctrl-surf-copy-new-ctx) [216.687829] Starting subtest: ctrl-surf-copy-new-ctx [216.691954] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [216.834372] [053/131] (802s left) perf (i915-ref-count) [216.940942] Starting subtest: i915-ref-count [216.978415] Subtest i915-ref-count: SUCCESS (0.035s) [217.032367] [054/131] (802s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [217.088791] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [217.093292] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [217.297682] [055/131] (802s left) gem_exec_balancer (parallel) [217.570918] Starting subtest: parallel [218.494100] Subtest parallel: SUCCESS (0.926s) [218.900796] [056/131] (800s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [219.001417] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [225.846440] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.847s) [226.032734] [057/131] (793s left) gem_spin_batch (spin-each) [226.103251] Starting subtest: spin-each [229.366771] Subtest spin-each: SUCCESS (3.257s) [229.973762] [058/131] (789s left) perf (gen12-mi-rpc) [230.081098] Starting subtest: gen12-mi-rpc [230.083392] Starting dynamic subtest: rcs0 [230.099119] Dynamic subtest rcs0: SUCCESS (0.015s) [230.101454] Subtest gen12-mi-rpc: SUCCESS (0.016s) [230.136849] [059/131] (789s left) syncobj_wait (invalid-signal-zero-handles) [230.244086] Starting subtest: invalid-signal-zero-handles [230.246656] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [230.373144] [060/131] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [230.477480] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [237.012390] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.538s) [237.146944] [061/131] (782s left) kms_content_protection (atomic-dpms) [237.282842] Starting subtest: atomic-dpms [237.287328] Subtest atomic-dpms: SKIP (0.000s) [237.445051] [062/131] (782s left) kms_getfb (getfb2-handle-zero) [237.531288] Starting subtest: getfb2-handle-zero [237.533550] Subtest getfb2-handle-zero: SUCCESS (0.000s) [237.661503] [063/131] (782s left) kms_feature_discovery (psr1) [237.757954] Starting subtest: psr1 [237.760118] Subtest psr1: SUCCESS (0.000s) [237.853639] [064/131] (782s left) perf_pmu (busy-idle-no-semaphores) [237.892689] Starting subtest: busy-idle-no-semaphores [237.895078] Starting dynamic subtest: rcs0 [238.559311] Dynamic subtest rcs0: SUCCESS (0.668s) [238.571065] Starting dynamic subtest: bcs0 [239.209859] Dynamic subtest bcs0: SUCCESS (0.648s) [239.221627] Starting dynamic subtest: vcs0 [239.860469] Dynamic subtest vcs0: SUCCESS (0.648s) [239.872091] Starting dynamic subtest: vcs1 [241.531882] Dynamic subtest vcs1: SUCCESS (1.669s) [241.543509] Starting dynamic subtest: vecs0 [243.518479] Dynamic subtest vecs0: SUCCESS (1.984s) [243.527710] Starting dynamic subtest: ccs0 [245.500452] Dynamic subtest ccs0: SUCCESS (1.979s) [245.503262] Subtest busy-idle-no-semaphores: SUCCESS (7.611s) [245.639180] [065/131] (774s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [245.735785] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [245.738018] Starting dynamic subtest: pipe-A-default-mode [246.025722] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [246.039303] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.283s) [246.900170] [066/131] (773s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [246.959454] Starting subtest: etime-multi-wait-all-submitted-signaled [247.065401] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s) [247.166873] [067/131] (773s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [247.259931] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [247.268169] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s) [247.410236] [068/131] (772s left) kms_flip (2x-flip-vs-fences) [247.518887] Starting subtest: 2x-flip-vs-fences [247.523257] Subtest 2x-flip-vs-fences: SKIP (0.000s) [247.660179] [069/131] (772s left) kms_async_flips (test-time-stamp) [247.759746] Starting subtest: test-time-stamp [248.131339] Starting dynamic subtest: pipe-A-eDP-1 [248.973259] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.839s) [249.339725] Starting dynamic subtest: pipe-B-eDP-1 [250.095956] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s) [250.466357] Starting dynamic subtest: pipe-C-eDP-1 [251.226945] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s) [251.590349] Starting dynamic subtest: pipe-D-eDP-1 [252.355780] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s) [252.358278] Subtest test-time-stamp: SUCCESS (4.596s) [253.533067] [070/131] (766s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [253.634813] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [253.638947] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [253.770457] [071/131] (766s left) gem_exec_schedule (noreorder-corked) [253.945352] Starting subtest: noreorder-corked [253.947806] Starting dynamic subtest: rcs0 [255.079389] Dynamic subtest rcs0: SUCCESS (1.136s) [255.089852] Starting dynamic subtest: vcs0 [256.935971] Dynamic subtest vcs0: SUCCESS (1.853s) [256.950336] Starting dynamic subtest: vcs1 [258.908270] Dynamic subtest vcs1: SUCCESS (1.970s) [258.919621] Starting dynamic subtest: vecs0 [260.887450] Dynamic subtest vecs0: SUCCESS (1.976s) [260.898738] Starting dynamic subtest: ccs0 [262.048349] Dynamic subtest ccs0: SUCCESS (1.159s) [262.050989] Subtest noreorder-corked: SUCCESS (8.105s) [262.259615] [072/131] (758s left) i915_drm_fdinfo (busy-idle) [262.303063] Starting subtest: busy-idle [262.305323] Starting dynamic subtest: rcs0 [262.335794] Dynamic subtest rcs0: SKIP (0.032s) [262.345885] Starting dynamic subtest: bcs0 [262.350179] Dynamic subtest bcs0: SKIP (0.000s) [262.358808] Starting dynamic subtest: vcs0 [262.362824] Dynamic subtest vcs0: SKIP (0.000s) [262.371052] Starting dynamic subtest: vcs1 [262.375267] Dynamic subtest vcs1: SKIP (0.000s) [262.383180] Starting dynamic subtest: vecs0 [262.387520] Dynamic subtest vecs0: SKIP (0.000s) [262.395484] Starting dynamic subtest: ccs0 [262.399921] Dynamic subtest ccs0: SKIP (0.000s) [262.404299] Subtest busy-idle: SKIP (0.038s) [262.440623] [073/131] (758s left) gem_ctx_persistence (heartbeat-stop) [262.508339] Starting subtest: heartbeat-stop [262.513139] Subtest heartbeat-stop: SKIP (0.000s) [262.639258] [074/131] (757s left) i915_pm_rpm (debugfs-read) [264.180467] Starting subtest: debugfs-read [265.341653] Subtest debugfs-read: SUCCESS (1.158s) [265.728936] [075/131] (754s left) gem_exec_reloc (basic-wc-cpu-active) [265.790104] Subtest basic-wc-cpu-active: SKIP (0.000s) [265.866954] [076/131] (754s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite) [265.954526] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite [270.257461] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.306s) [271.430964] [077/131] (749s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [271.559450] Starting subtest: flip-vs-cursor-crc-legacy [272.234502] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.672s) [273.044213] [078/131] (747s left) gem_exec_fence (invalid-fence-array) [273.492129] Starting subtest: invalid-fence-array [273.494583] Subtest invalid-fence-array: SUCCESS (0.002s) [275.009017] [079/131] (745s left) gem_exec_gttfill (multigpu-basic) [275.181358] Starting subtest: multigpu-basic [289.091470] Subtest multigpu-basic: SUCCESS (13.910s) [289.197475] [080/131] (731s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [289.369438] Starting subtest: short-flip-before-cursor-atomic-transitions [290.368818] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.000s) [291.219278] [081/131] (729s left) gem_mmap_wc (write-prefaulted) [291.282696] Subtest write-prefaulted: SKIP (0.000s) [291.352674] [082/131] (729s left) kms_psr2_su (page_flip-nv12) [291.419093] Subtest page_flip-NV12: SKIP (0.000s) [291.480249] [083/131] (729s left) kms_cursor_legacy (torture-move) [291.608535] Starting subtest: torture-move [291.610416] Starting dynamic subtest: pipe-A [297.777627] Dynamic subtest pipe-A: SUCCESS (6.165s) [297.789232] Starting dynamic subtest: pipe-B [303.504988] Dynamic subtest pipe-B: SUCCESS (5.726s) [303.516382] Starting dynamic subtest: pipe-C [309.668804] Dynamic subtest pipe-C: SUCCESS (6.161s) [309.682103] Starting dynamic subtest: pipe-D [316.561133] Dynamic subtest pipe-D: SUCCESS (6.889s) [316.573585] Starting dynamic subtest: all-pipes [323.039221] Dynamic subtest all-pipes: SUCCESS (6.476s) [323.042090] Subtest torture-move: SUCCESS (31.429s) [323.225844] [084/131] (697s left) api_intel_bb (purge-bb) [323.299532] Starting subtest: purge-bb [323.304779] Subtest purge-bb: SUCCESS (0.004s) [323.451733] [085/131] (697s left) api_intel_allocator (reopen-fork) [323.521905] Starting subtest: reopen-fork [326.980824] Subtest reopen-fork: SUCCESS (3.458s) [327.082318] [086/131] (693s left) gem_caching (reads) [327.145394] Subtest reads: SKIP (0.000s) [327.221129] [087/131] (693s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [327.319055] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [327.323047] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [327.447254] [088/131] (693s left) gem_render_copy (y-tiled-ccs-to-linear) [327.505134] Starting subtest: y-tiled-ccs-to-linear [327.509674] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [327.714403] [089/131] (693s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [327.814576] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [327.816750] Starting dynamic subtest: pipe-A-eDP-1 [327.839096] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [327.849643] Starting dynamic subtest: pipe-B-eDP-1 [327.870875] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [327.879765] Starting dynamic subtest: pipe-C-eDP-1 [327.900687] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [327.909626] Starting dynamic subtest: pipe-D-eDP-1 [327.931804] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [327.935861] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [330.072626] [090/131] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [330.173389] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [330.177484] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [330.301888] [091/131] (690s left) kms_cursor_crc (cursor-sliding-128x42) [330.527096] Starting subtest: cursor-sliding-128x42 [330.570162] Subtest cursor-sliding-128x42: SKIP (0.039s) [330.819647] [092/131] (690s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [330.912211] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [330.914335] Starting dynamic subtest: pipe-A-default-mode [333.690594] Dynamic subtest pipe-A-default-mode: SUCCESS (2.777s) [333.692726] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.778s) [334.550408] [093/131] (686s left) i915_query (query-topology-unsupported) [334.606861] Starting subtest: query-topology-unsupported [334.611134] Subtest query-topology-unsupported: SKIP (0.000s) [334.735108] [094/131] (686s left) kms_cursor_crc (cursor-offscreen-32x32) [334.881245] Starting subtest: cursor-offscreen-32x32 [334.919893] Subtest cursor-offscreen-32x32: SKIP (0.038s) [335.233685] [095/131] (686s left) gem_busy (parallel) [335.414733] Starting subtest: parallel [335.416727] Starting dynamic subtest: rcs0 [336.917307] Dynamic subtest rcs0: SUCCESS (1.504s) [336.930088] Starting dynamic subtest: bcs0 [338.902045] Dynamic subtest bcs0: SUCCESS (1.982s) [338.913802] Starting dynamic subtest: vcs0 [340.885672] Dynamic subtest vcs0: SUCCESS (1.981s) [340.898460] Starting dynamic subtest: vcs1 [342.932704] Dynamic subtest vcs1: SUCCESS (2.044s) [342.943820] Starting dynamic subtest: vecs0 [344.917102] Dynamic subtest vecs0: SUCCESS (1.982s) [344.929596] Starting dynamic subtest: ccs0 [346.903390] Dynamic subtest ccs0: SUCCESS (1.983s) [346.906248] Subtest parallel: SUCCESS (11.491s) [347.190485] [096/131] (674s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [347.572896] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [348.425963] [097/131] (673s left) i915_query (query-regions-sanity-check) [348.483143] Starting subtest: query-regions-sanity-check [348.490639] Subtest query-regions-sanity-check: SUCCESS (0.010s) [348.649271] [098/131] (672s left) kms_psr (fbc-psr2-sprite-render) [348.746091] Starting subtest: fbc-psr2-sprite-render [348.748288] Starting dynamic subtest: eDP-1 [348.752254] Dynamic subtest eDP-1: SKIP (0.000s) [348.756236] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [348.841605] [099/131] (672s left) gem_vm_create (isolation) [348.905236] Starting subtest: isolation [348.913263] Subtest isolation: SUCCESS (0.008s) [349.081206] [100/131] (672s left) tools_test (sysfs_l3_parity) [349.129855] Starting subtest: sysfs_l3_parity [349.213617] Subtest sysfs_l3_parity: SKIP (0.092s) [349.294133] [101/131] (672s left) gem_exec_reloc (basic-write-read-noreloc) [349.362854] Subtest basic-write-read-noreloc: SKIP (0.000s) [349.456873] [102/131] (672s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [349.556537] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [355.678927] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.124s) [356.878435] [103/131] (664s left) prime_busy (hang-wait) [356.936629] Starting subtest: hang-wait [356.938918] Starting dynamic subtest: rcs0 [383.352788] Dynamic subtest rcs0: SUCCESS (26.412s) [383.363162] Starting dynamic subtest: bcs0 [390.498647] Dynamic subtest bcs0: SUCCESS (7.143s) [390.509166] Starting dynamic subtest: vcs0 [397.545312] Dynamic subtest vcs0: SUCCESS (7.046s) [397.553722] Starting dynamic subtest: vcs1 [404.514042] Dynamic subtest vcs1: SUCCESS (6.967s) [404.523337] Starting dynamic subtest: vecs0 [411.485538] Dynamic subtest vecs0: SUCCESS (6.973s) [411.494251] Starting dynamic subtest: ccs0 [425.386770] Dynamic subtest ccs0: SUCCESS (13.897s) [425.389183] Subtest hang-wait: SUCCESS (68.450s) [425.549494] [104/131] (596s left) kms_psr (fbc-pr-basic) [425.649747] Starting subtest: fbc-pr-basic [425.653879] Subtest fbc-pr-basic: SKIP (0.000s) [425.745966] [105/131] (596s left) gem_mmap_offset (oob-read) [425.813402] Starting subtest: oob-read [425.815560] Subtest oob-read: SUCCESS (0.000s) [425.929972] [106/131] (595s left) kms_big_fb (x-tiled-16bpp-rotate-180) [426.039794] Starting subtest: x-tiled-16bpp-rotate-180 [427.298048] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.257s) [427.456108] [107/131] (594s left) kms_psr (pr-primary-render) [427.553275] Starting subtest: pr-primary-render [427.556779] Subtest pr-primary-render: SKIP (0.000s) [427.652415] [108/131] (594s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [427.744169] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [431.341433] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.599s) [432.482307] [109/131] (589s left) gem_lmem_swapping (verify) [432.537178] Subtest verify: SKIP (0.000s) [432.615825] [110/131] (589s left) gem_eio (unwedge-stress) [432.842061] Starting subtest: unwedge-stress [432.844387] Starting dynamic subtest: render [437.673943] Dynamic subtest render: SUCCESS (4.828s) [437.689777] Starting dynamic subtest: bsd1 [455.423398] Dynamic subtest bsd1: SUCCESS (17.749s) [455.439742] Starting dynamic subtest: bsd2 [473.313575] Dynamic subtest bsd2: SUCCESS (17.889s) [473.330092] Starting dynamic subtest: blt [473.334462] Dynamic subtest blt: SKIP (0.000s) [473.343067] Starting dynamic subtest: vebox [491.397467] Dynamic subtest vebox: SUCCESS (18.081s) [491.399766] Subtest unwedge-stress: SUCCESS (58.553s) [492.951379] [111/131] (529s left) kms_plane_alpha_blend (alpha-opaque-fb) [493.052122] Starting subtest: alpha-opaque-fb [493.331929] Starting dynamic subtest: pipe-A-eDP-1 [493.990867] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.656s) [493.999979] Starting dynamic subtest: pipe-D-eDP-1 [495.393577] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.403s) [495.396049] Subtest alpha-opaque-fb: SUCCESS (2.344s) [496.221468] [112/131] (525s left) sriov_basic (enable-vfs-bind-unbind-each) [496.282654] Starting subtest: enable-vfs-bind-unbind-each [496.285067] Starting dynamic subtest: numvfs-1 [496.364021] Dynamic subtest numvfs-1: FAIL (0.028s) [496.374280] Starting dynamic subtest: numvfs-2 [496.443844] Dynamic subtest numvfs-2: FAIL (0.004s) [496.455128] Starting dynamic subtest: numvfs-3 [496.529476] Dynamic subtest numvfs-3: FAIL (0.003s) [496.539271] Starting dynamic subtest: numvfs-4 [496.610618] Dynamic subtest numvfs-4: FAIL (0.003s) [496.620953] Starting dynamic subtest: numvfs-5 [496.692690] Dynamic subtest numvfs-5: FAIL (0.003s) [496.702986] Starting dynamic subtest: numvfs-6 [496.776080] Dynamic subtest numvfs-6: FAIL (0.004s) [496.786280] Starting dynamic subtest: numvfs-7 [496.858985] Dynamic subtest numvfs-7: FAIL (0.003s) [496.869068] Starting dynamic subtest: numvfs-random [496.941197] Dynamic subtest numvfs-random: FAIL (0.004s) [496.943493] Subtest enable-vfs-bind-unbind-each: FAIL (0.059s) [496.985751] [113/131] (525s left) gem_ctx_bad_destroy (double-destroy) [497.039066] Starting subtest: double-destroy [497.041259] Subtest double-destroy: SUCCESS (0.000s) [497.137425] [114/131] (525s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [497.238679] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [497.241958] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [497.360094] [115/131] (524s left) gem_linear_blits (interruptible) [497.543419] Starting subtest: interruptible [501.570217] Subtest interruptible: SUCCESS (4.026s) [501.732421] [116/131] (520s left) sysfs_heartbeat_interval (precise) [501.822451] Starting subtest: precise [501.824373] Starting dynamic subtest: vecs0 [509.943489] Dynamic subtest vecs0: SUCCESS (8.121s) [509.954192] Starting dynamic subtest: ccs0 [511.175309] Dynamic subtest ccs0: SUCCESS (1.232s) [511.187330] Starting dynamic subtest: vcs0 [518.949721] Dynamic subtest vcs0: SUCCESS (7.769s) [518.961498] Starting dynamic subtest: bcs0 [520.184254] Dynamic subtest bcs0: SUCCESS (1.235s) [520.194621] Starting dynamic subtest: rcs0 [521.319451] Dynamic subtest rcs0: SUCCESS (1.133s) [521.331416] Starting dynamic subtest: vcs1 [528.929336] Dynamic subtest vcs1: SUCCESS (7.607s) [528.931876] Subtest precise: SUCCESS (27.110s) [529.035281] [117/131] (493s left) kms_prime (basic-crc-hybrid) [529.142354] Subtest basic-crc-hybrid: SKIP (0.000s) [529.258789] [118/131] (493s left) gen7_exec_parse (oacontrol-tracking) [529.323165] Subtest oacontrol-tracking: SKIP (0.000s) [529.392256] [119/131] (493s left) kms_flip (plain-flip-ts-check-interruptible) [529.476502] Starting subtest: plain-flip-ts-check-interruptible [529.478851] Starting dynamic subtest: A-eDP1 [538.389169] Dynamic subtest A-eDP1: SUCCESS (8.911s) [538.405215] Starting dynamic subtest: B-eDP1 [547.225567] Dynamic subtest B-eDP1: SUCCESS (8.834s) [547.235706] Starting dynamic subtest: C-eDP1 [556.043073] Dynamic subtest C-eDP1: SUCCESS (8.816s) [556.054210] Starting dynamic subtest: D-eDP1 [564.873602] Dynamic subtest D-eDP1: SUCCESS (8.828s) [564.879701] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.400s) [566.075937] [120/131] (456s left) kms_atomic_transition (plane-toggle-modeset-transition) [566.173869] Starting subtest: plane-toggle-modeset-transition [566.178352] Starting dynamic subtest: pipe-A-eDP-1 [578.872337] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.701s) [578.885748] Starting dynamic subtest: pipe-B-eDP-1 [591.273662] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.397s) [591.276236] Subtest plane-toggle-modeset-transition: SUCCESS (25.105s) [592.115330] [121/131] (430s left) vgem_basic (mmap) [592.168154] Starting subtest: mmap [592.186036] Subtest mmap: SUCCESS (0.022s) [592.269931] [122/131] (430s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [592.366373] Starting subtest: plane-scaler-unity-scaling-with-modifiers [592.368531] Starting dynamic subtest: pipe-A [592.714723] Dynamic subtest pipe-A: SUCCESS (0.351s) [592.723956] Starting dynamic subtest: pipe-B [594.103031] Dynamic subtest pipe-B: SUCCESS (1.387s) [594.112277] Starting dynamic subtest: pipe-C [595.556832] Dynamic subtest pipe-C: SUCCESS (1.453s) [595.565616] Starting dynamic subtest: pipe-D [597.001703] Dynamic subtest pipe-D: SUCCESS (1.444s) [597.003952] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.639s) [598.244130] [123/131] (424s left) kms_lease (lease-uevent) [598.344880] Starting subtest: lease-uevent [599.357327] Subtest lease-uevent: SUCCESS (1.015s) [599.456129] [124/131] (423s left) kms_psr (pr-cursor-render) [599.540213] Starting subtest: pr-cursor-render [599.544709] Subtest pr-cursor-render: SKIP (0.000s) [599.635449] [125/131] (423s left) gem_eio (hibernate) [599.850787] Starting subtest: hibernate [614.521943] Subtest hibernate: SUCCESS (14.670s) [622.750903] [126/131] (408s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [622.909668] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu [629.480355] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.572s) [629.646690] [127/131] (401s left) kms_vblank (ts-continuation-idle-hang) [629.746172] Starting subtest: ts-continuation-idle-hang [629.748052] Starting dynamic subtest: pipe-A-eDP-1 [631.661874] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.915s) [631.683435] Starting dynamic subtest: pipe-D-eDP-1 [634.273079] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.610s) [634.275470] Subtest ts-continuation-idle-hang: SUCCESS (4.529s) [635.096995] [128/131] (395s left) kms_psr (psr-sprite-mmap-gtt) [635.212041] Starting subtest: psr-sprite-mmap-gtt [635.214330] Starting dynamic subtest: eDP-1 [636.700821] Dynamic subtest eDP-1: SKIP (1.484s) [636.705968] Subtest psr-sprite-mmap-gtt: SKIP (1.487s) [636.931111] [129/131] (393s left) gem_workarounds (basic-read) [637.002798] Starting subtest: basic-read [637.014398] Subtest basic-read: SUCCESS (0.012s) [637.172919] [130/131] (393s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [637.280567] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [637.284984] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [637.396859] [131/131] (393s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [637.488859] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [637.492974] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [637.602391] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_cursor_edge_walk results: parsing output: 2/ for test: kms_async_flips results: parsing output: 3/ for test: kms_content_protection results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_chamelium_frames results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_selftest results: parsing output: 10/ for test: gem_eio results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: perf results: parsing output: 13/ for test: kms_cursor_legacy results: parsing output: 14/ for test: gem_mmap results: parsing output: 15/ for test: gem_ctx_param results: parsing output: 16/ for test: perf_pmu results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: syncobj_timeline results: parsing output: 22/ for test: gem_exec_balancer results: parsing output: 23/ for test: kms_psr2_sf results: parsing output: 24/ for test: kms_addfb_basic results: parsing output: 25/ for test: kms_pm_rpm results: parsing output: 26/ for test: gem_exec_params results: parsing output: 27/ for test: gem_exec_alignment results: parsing output: 28/ for test: syncobj_timeline results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: core_getstats results: parsing output: 31/ for test: kms_pipe_b_c_ivb results: parsing output: 32/ for test: kms_invalid_mode results: parsing output: 33/ for test: kms_setmode results: parsing output: 34/ for test: gem_render_copy results: parsing output: 35/ for test: kms_ccs results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: kms_cursor_legacy results: parsing output: 38/ for test: kms_plane results: parsing output: 39/ for test: gem_exec_schedule results: parsing output: 40/ for test: gem_userptr_blits results: parsing output: 41/ for test: kms_ccs results: parsing output: 42/ for test: i915_getparams_basic results: parsing output: 43/ for test: gem_exec_whisper results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: kms_ccs results: parsing output: 47/ for test: gem_exec_whisper results: parsing output: 48/ for test: kms_plane_scaling results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_ccs results: parsing output: 52/ for test: perf results: parsing output: 53/ for test: gem_render_copy results: parsing output: 54/ for test: gem_exec_balancer results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_spin_batch results: parsing output: 57/ for test: perf results: parsing output: 58/ for test: syncobj_wait results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_content_protection results: parsing output: 61/ for test: kms_getfb results: parsing output: 62/ for test: kms_feature_discovery results: parsing output: 63/ for test: perf_pmu results: parsing output: 64/ for test: kms_flip_scaled_crc results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: kms_async_flips results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: gem_exec_schedule results: parsing output: 71/ for test: i915_drm_fdinfo results: parsing output: 72/ for test: gem_ctx_persistence results: parsing output: 73/ for test: i915_pm_rpm results: parsing output: 74/ for test: gem_exec_reloc results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_cursor_legacy results: parsing output: 77/ for test: gem_exec_fence results: parsing output: 78/ for test: gem_exec_gttfill results: parsing output: 79/ for test: kms_cursor_legacy results: parsing output: 80/ for test: gem_mmap_wc results: parsing output: 81/ for test: kms_psr2_su results: parsing output: 82/ for test: kms_cursor_legacy results: parsing output: 83/ for test: api_intel_bb results: parsing output: 84/ for test: api_intel_allocator results: parsing output: 85/ for test: gem_caching results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_render_copy results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: kms_flip_scaled_crc results: parsing output: 92/ for test: i915_query results: parsing output: 93/ for test: kms_cursor_crc results: parsing output: 94/ for test: gem_busy results: parsing output: 95/ for test: kms_chamelium_hpd results: parsing output: 96/ for test: i915_query results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: gem_vm_create results: parsing output: 99/ for test: tools_test results: parsing output: 100/ for test: gem_exec_reloc results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: prime_busy results: parsing output: 103/ for test: kms_psr results: parsing output: 104/ for test: gem_mmap_offset results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_psr results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: gem_lmem_swapping results: parsing output: 109/ for test: gem_eio results: parsing output: 110/ for test: kms_plane_alpha_blend results: parsing output: 111/ for test: sriov_basic results: parsing output: 112/ for test: gem_ctx_bad_destroy results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_linear_blits results: parsing output: 115/ for test: sysfs_heartbeat_interval results: parsing output: 116/ for test: kms_prime results: parsing output: 117/ for test: gen7_exec_parse results: parsing output: 118/ for test: kms_flip results: parsing output: 119/ for test: kms_atomic_transition results: parsing output: 120/ for test: vgem_basic results: parsing output: 121/ for test: kms_plane_scaling results: parsing output: 122/ for test: kms_lease results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: gem_eio results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_vblank results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: gem_workarounds results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.