[62.903401] Initializing watchdogs [62.903500] /dev/watchdog0 [62.919020] [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] [62.923452] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.925866] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.927895] [001/133] (960s left) kms_psr (fbc-pr-sprite-plane-move) [63.036127] Starting subtest: fbc-pr-sprite-plane-move [63.037853] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [63.111996] [002/133] (960s left) gem_ctx_shared (q-out-order) [63.169232] Starting subtest: Q-out-order [63.170192] Starting dynamic subtest: rcs0 [63.290732] Dynamic subtest rcs0: SUCCESS (0.121s) [63.304745] Starting dynamic subtest: vcs0 [63.366604] Dynamic subtest vcs0: SUCCESS (0.075s) [63.381229] Starting dynamic subtest: vcs1 [63.446728] Dynamic subtest vcs1: SUCCESS (0.080s) [63.462176] Starting dynamic subtest: vecs0 [63.520934] Dynamic subtest vecs0: SUCCESS (0.074s) [63.535047] Starting dynamic subtest: ccs0 [63.602050] Dynamic subtest ccs0: SUCCESS (0.081s) [63.603641] Subtest Q-out-order: SUCCESS (0.432s) [65.006859] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true [65.008231] [003/133] (958s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [65.104287] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [65.106124] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [65.207174] [004/133] (958s left) kms_pm_rpm (package-g7) [67.052644] Starting subtest: package-g7 [67.055292] Subtest package-g7: SKIP (0.000s) [67.543842] [005/133] (956s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [67.678378] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [67.679468] Starting dynamic subtest: pipe-A-eDP-1 [67.689354] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [67.696420] Starting dynamic subtest: pipe-B-eDP-1 [67.705920] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [67.712215] Starting dynamic subtest: pipe-C-eDP-1 [67.721596] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [67.727933] Starting dynamic subtest: pipe-D-eDP-1 [67.737528] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [67.739325] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s) [69.972708] [006/133] (953s left) prime_mmap_kms (buffer-sharing) [70.069446] Starting subtest: buffer-sharing [70.513560] Subtest buffer-sharing: SUCCESS (0.444s) [71.303635] [007/133] (952s left) perf_pmu (busy-hang) [71.336589] Starting subtest: busy-hang [71.337462] Starting dynamic subtest: rcs0 [72.606514] Dynamic subtest rcs0: SUCCESS (1.268s) [72.614538] Starting dynamic subtest: bcs0 [73.823583] Dynamic subtest bcs0: SUCCESS (1.217s) [73.832434] Starting dynamic subtest: vcs0 [76.441711] Dynamic subtest vcs0: SUCCESS (2.613s) [76.449858] Starting dynamic subtest: vcs1 [78.429768] Dynamic subtest vcs1: SUCCESS (1.988s) [78.438503] Starting dynamic subtest: vecs0 [80.408714] Dynamic subtest vecs0: SUCCESS (1.976s) [80.416787] Starting dynamic subtest: ccs0 [81.626387] Dynamic subtest ccs0: SUCCESS (1.218s) [81.627482] Subtest busy-hang: SUCCESS (10.284s) [81.716762] [008/133] (941s left) kms_addfb_basic (bad-pitch-256) [81.766965] Starting subtest: bad-pitch-256 [81.767866] Subtest bad-pitch-256: SUCCESS (0.000s) [81.904615] [009/133] (941s left) kms_draw_crc (draw-method-blt) [81.985734] Starting subtest: draw-method-blt [81.986603] Starting dynamic subtest: xrgb8888-untiled [82.240884] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s) [82.248628] Starting dynamic subtest: rgb565-untiled [82.474400] Dynamic subtest rgb565-untiled: SUCCESS (0.233s) [82.481068] Starting dynamic subtest: xrgb2101010-untiled [82.696435] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [82.703879] Starting dynamic subtest: xbgr16161616f-untiled [82.918859] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s) [82.925342] Starting dynamic subtest: xrgb8888-xtiled [83.041060] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s) [83.049421] Starting dynamic subtest: rgb565-xtiled [83.163696] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s) [83.172645] Starting dynamic subtest: xrgb2101010-xtiled [83.274545] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s) [83.282059] Starting dynamic subtest: xbgr16161616f-xtiled [83.396670] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s) [83.404261] Starting dynamic subtest: xrgb8888-4tiled [83.518926] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s) [83.525445] Starting dynamic subtest: rgb565-4tiled [83.641645] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s) [83.654908] Starting dynamic subtest: xrgb2101010-4tiled [83.763553] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s) [83.770776] Starting dynamic subtest: xbgr16161616f-4tiled [83.885775] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.122s) [83.886670] Subtest draw-method-blt: SUCCESS (1.900s) [83.996089] [010/133] (939s left) gem_exec_schedule (noreorder-corked) [84.178547] Starting subtest: noreorder-corked [84.179571] Starting dynamic subtest: rcs0 [85.311448] Dynamic subtest rcs0: SUCCESS (1.137s) [85.320619] Starting dynamic subtest: vcs0 [86.940844] Dynamic subtest vcs0: SUCCESS (1.619s) [86.950059] Starting dynamic subtest: vcs1 [88.934772] Dynamic subtest vcs1: SUCCESS (1.992s) [88.943768] Starting dynamic subtest: vecs0 [90.905895] Dynamic subtest vecs0: SUCCESS (1.970s) [90.915077] Starting dynamic subtest: ccs0 [92.050381] Dynamic subtest ccs0: SUCCESS (1.153s) [92.051542] Subtest noreorder-corked: SUCCESS (7.876s) [92.241720] [011/133] (931s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [92.321196] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [92.323217] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [92.511398] [012/133] (931s left) gem_softpin (evict-prime) [92.565601] Starting subtest: evict-prime [92.566732] Starting dynamic subtest: rcs0 [93.728381] Dynamic subtest rcs0: SUCCESS (1.163s) [93.737181] Starting dynamic subtest: bcs0 [94.851692] Dynamic subtest bcs0: SUCCESS (1.123s) [94.860850] Starting dynamic subtest: vcs0 [96.865336] Dynamic subtest vcs0: SUCCESS (2.003s) [96.875501] Starting dynamic subtest: vcs1 [98.914098] Dynamic subtest vcs1: SUCCESS (2.048s) [98.924229] Starting dynamic subtest: vecs0 [100.898212] Dynamic subtest vecs0: SUCCESS (1.982s) [100.908354] Starting dynamic subtest: ccs0 [102.018698] Dynamic subtest ccs0: SUCCESS (1.129s) [102.028155] Starting dynamic subtest: all [103.843505] Dynamic subtest all: SUCCESS (1.814s) [103.844874] Subtest evict-prime: SUCCESS (11.268s) [103.909874] [013/133] (919s left) gem_exec_suspend (basic-s4-devices) [103.965168] Starting subtest: basic-S4-devices [103.966160] Starting dynamic subtest: smem [115.871691] Dynamic subtest smem: SUCCESS (11.896s) [115.872891] Subtest basic-S4-devices: SUCCESS (11.897s) [121.111209] [014/133] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [121.250053] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [121.251878] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [121.379648] [015/133] (907s left) kms_psr (fbc-pr-primary-mmap-gtt) [121.476183] Starting subtest: fbc-pr-primary-mmap-gtt [121.478062] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [121.548351] [016/133] (907s left) i915_drm_fdinfo (isolation) [121.581698] Starting subtest: isolation [121.582496] Starting dynamic subtest: rcs0 [121.602114] Dynamic subtest rcs0: SKIP (0.019s) [121.616574] Starting dynamic subtest: bcs0 [121.618312] Dynamic subtest bcs0: SKIP (0.000s) [121.628232] Starting dynamic subtest: vcs0 [121.630232] Dynamic subtest vcs0: SKIP (0.000s) [121.637566] Starting dynamic subtest: vcs1 [121.639389] Dynamic subtest vcs1: SKIP (0.000s) [121.646585] Starting dynamic subtest: vecs0 [121.648191] Dynamic subtest vecs0: SKIP (0.000s) [121.655442] Starting dynamic subtest: ccs0 [121.657044] Dynamic subtest ccs0: SKIP (0.000s) [121.658735] Subtest isolation: SKIP (0.022s) [121.687543] [017/133] (907s left) kms_vblank (ts-continuation-dpms-suspend) [121.768752] Starting subtest: ts-continuation-dpms-suspend [121.769812] Starting dynamic subtest: pipe-A-eDP-1 [139.412413] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.281s) [139.422237] Starting dynamic subtest: pipe-D-eDP-1 [157.412284] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.856s) [157.413139] Subtest ts-continuation-dpms-suspend: SUCCESS (5.140s) [163.268533] [018/133] (870s left) i915_pm_rpm (debugfs-forcewake-user) [165.599724] Starting subtest: debugfs-forcewake-user [176.998863] Subtest debugfs-forcewake-user: SUCCESS (11.365s) [177.384246] [019/133] (856s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [177.490237] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [177.491991] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [177.560619] [020/133] (856s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [177.650010] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [177.651035] Starting dynamic subtest: pipe-A-eDP-1 [177.660231] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [177.669724] Starting dynamic subtest: pipe-B-eDP-1 [177.677374] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [177.685383] Starting dynamic subtest: pipe-C-eDP-1 [177.693090] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [177.700801] Starting dynamic subtest: pipe-D-eDP-1 [177.708806] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [177.710382] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.004s) [179.935922] [021/133] (854s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier) [180.033025] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier [180.034676] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s) [180.104681] [022/133] (854s left) gem_userptr_blits (set-cache-level) [180.156701] Starting subtest: set-cache-level [180.158556] Subtest set-cache-level: SKIP (0.000s) [180.274795] [023/133] (854s left) gem_ctx_param (invalid-param-get) [180.325310] Starting subtest: invalid-param-get [180.326750] Subtest invalid-param-get: SUCCESS (0.001s) [180.420214] [024/133] (853s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [180.501852] Starting subtest: psr-indfb-scaledprimary [186.335816] Subtest psr-indfb-scaledprimary: SUCCESS (5.829s) [186.455664] [025/133] (847s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [186.571337] Starting subtest: cursorB-vs-flipA-varying-size [186.574394] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s) [186.712195] [026/133] (847s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [186.861868] Starting subtest: cursorB-vs-flipB-atomic-transitions [186.863714] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.002s) [187.034493] [027/133] (847s left) kms_cursor_crc (cursor-offscreen-128x42) [187.266685] Starting subtest: cursor-offscreen-128x42 [187.311516] Subtest cursor-offscreen-128x42: SKIP (0.043s) [187.502821] [028/133] (847s left) kms_cursor_edge_walk (256x256-top-edge) [187.592969] Starting subtest: 256x256-top-edge [187.594030] Starting dynamic subtest: pipe-A-eDP-1 [191.043696] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s) [191.051728] Starting dynamic subtest: pipe-D-eDP-1 [194.166558] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s) [194.167452] Subtest 256x256-top-edge: SUCCESS (6.568s) [194.980922] [029/133] (839s left) kms_psr (psr2-primary-page-flip) [195.076583] Starting subtest: psr2-primary-page-flip [195.077496] Starting dynamic subtest: eDP-1 [196.745282] Dynamic subtest eDP-1: SUCCESS (1.669s) [196.746613] Subtest psr2-primary-page-flip: SUCCESS (1.669s) [197.645439] [030/133] (836s left) kms_addfb_basic (master-rmfb) [197.706568] Starting subtest: master-rmfb [197.707522] Subtest master-rmfb: SUCCESS (0.001s) [197.835711] [031/133] (836s left) gem_userptr_blits (map-fixed-invalidate-overlap) [197.901804] Starting subtest: map-fixed-invalidate-overlap [197.903700] Subtest map-fixed-invalidate-overlap: SKIP (0.000s) [198.015774] [032/133] (836s left) gem_ccs (block-multicopy-inplace) [198.070807] Starting subtest: block-multicopy-inplace [198.073634] Subtest block-multicopy-inplace: SKIP (0.000s) [198.160452] [033/133] (836s left) gem_mmap_gtt (cpuset-medium-copy-xy) [198.214822] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [198.271162] [034/133] (836s left) gem_userptr_blits (coherency-sync) [198.325205] Starting subtest: coherency-sync [198.678307] Subtest coherency-sync: SKIP (0.333s) [198.799461] [035/133] (835s left) perf (polling) [198.993659] Starting subtest: polling [198.994950] Starting dynamic subtest: 0-rcs0 [209.026817] Dynamic subtest 0-rcs0: SUCCESS (10.028s) [209.037865] Starting dynamic subtest: 1-vecs0 [219.088913] Dynamic subtest 1-vecs0: SUCCESS (10.024s) [219.090333] Subtest polling: SUCCESS (20.053s) [219.121694] [036/133] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [219.222504] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [219.224280] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [219.334939] [037/133] (815s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [219.432543] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [226.419330] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.984s) [226.538594] [038/133] (808s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [226.626284] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [233.645838] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.018s) [233.754656] [039/133] (801s left) gem_tiled_wc [233.868712] [040/133] (801s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [233.961616] Starting subtest: fbcpsr-farfromfence-mmap-gtt [233.963443] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [234.073780] [041/133] (800s left) testdisplay [234.381643] [042/133] (800s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [234.481163] Starting subtest: fbc-rgb101010-draw-mmap-wc [239.039483] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.558s) [240.157884] [043/133] (794s left) kms_chamelium_edid (vga-edid-read) [240.544037] Subtest vga-edid-read: SKIP (0.000s) [241.353431] [044/133] (793s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [241.434005] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [241.435934] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [241.538918] [045/133] (793s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [241.628019] Starting subtest: primary-4-tiled-reflect-x-0 [248.665225] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.034s) [249.850148] [046/133] (785s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [249.908309] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [249.981700] [047/133] (785s left) gem_ctx_param (get-priority-new-ctx) [250.027461] Starting subtest: get-priority-new-ctx [250.028645] Subtest get-priority-new-ctx: SUCCESS (0.001s) [250.129102] [048/133] (785s left) kms_pm_backlight (fade-with-suspend) [250.219514] Starting subtest: fade-with-suspend [266.855723] Starting dynamic subtest: eDP-1 [269.330037] Dynamic subtest eDP-1: SUCCESS (2.475s) [269.331436] Subtest fade-with-suspend: SUCCESS (4.086s) [274.213132] [049/133] (765s left) kms_big_fb (y-tiled-addfb) [274.328378] Starting subtest: y-tiled-addfb [274.330200] Subtest y-tiled-addfb: SKIP (0.000s) [274.418040] [050/133] (764s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [274.504778] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [274.505716] Starting dynamic subtest: pipe-A-eDP-1 [274.645882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s) [274.656829] Starting dynamic subtest: pipe-B-eDP-1 [274.664543] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [274.673026] Starting dynamic subtest: pipe-C-eDP-1 [274.680714] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [274.689307] Starting dynamic subtest: pipe-D-eDP-1 [274.696480] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [274.697331] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s) [276.933164] [051/133] (762s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [277.063184] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [277.064851] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [277.205139] [052/133] (762s left) gem_flink_race (flink_name) [277.241279] Starting subtest: flink_name [282.699917] Subtest flink_name: SUCCESS (5.390s) [282.775530] [053/133] (756s left) kms_plane_lowres (tiling-x) [282.859560] Starting subtest: tiling-x [282.860420] Starting dynamic subtest: pipe-A-eDP-1 [282.862043] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [283.165224] Starting dynamic subtest: pipe-B-eDP-1 [283.166749] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [283.174828] Starting dynamic subtest: pipe-C-eDP-1 [283.176508] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [283.184607] Starting dynamic subtest: pipe-D-eDP-1 [283.186216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [283.187796] Subtest tiling-x: SKIP (0.301s) [283.965205] [054/133] (755s left) gem_userptr_blits (map-fixed-invalidate-busy) [284.033267] Starting subtest: map-fixed-invalidate-busy [284.035151] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [284.145971] [055/133] (755s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [284.225331] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [284.226966] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [284.316232] [056/133] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [284.406711] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [284.408488] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [284.516945] [057/133] (755s left) kms_big_fb (x-tiled-8bpp-rotate-270) [284.613327] Starting subtest: x-tiled-8bpp-rotate-270 [284.636611] Subtest x-tiled-8bpp-rotate-270: SKIP (0.023s) [284.749392] [058/133] (754s left) gen9_exec_parse (basic-rejected) [284.798688] Subtest basic-rejected: SKIP (0.000s) [284.861546] [059/133] (754s left) kms_joiner (invalid-modeset-big-joiner) [284.952678] Starting subtest: invalid-modeset-big-joiner [284.954484] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [285.032945] [060/133] (754s left) kms_universal_plane (universal-plane-pageflip-windowed) [285.127483] Starting subtest: universal-plane-pageflip-windowed [285.128378] Starting dynamic subtest: pipe-A-eDP-1 [285.738826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s) [285.747287] Starting dynamic subtest: pipe-B-eDP-1 [287.020428] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.278s) [287.030299] Starting dynamic subtest: pipe-C-eDP-1 [288.228374] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.204s) [288.237013] Starting dynamic subtest: pipe-D-eDP-1 [289.479038] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s) [289.479988] Subtest universal-plane-pageflip-windowed: SUCCESS (4.344s) [290.316558] [061/133] (749s left) kms_content_protection (dp-mst-type-0) [290.454948] Starting subtest: dp-mst-type-0 [290.456680] Subtest dp-mst-type-0: SKIP (0.000s) [290.589472] [062/133] (749s left) gem_exec_balancer (full) [290.642408] Starting subtest: full [295.340584] Subtest full: SUCCESS (4.692s) [295.660038] [063/133] (744s left) gem_eio (in-flight-contexts-10ms) [295.901039] Starting subtest: in-flight-contexts-10ms [309.430883] Subtest in-flight-contexts-10ms: SUCCESS (13.526s) [309.564151] [064/133] (730s left) kms_psr (fbc-psr2-sprite-plane-move) [309.646612] Starting subtest: fbc-psr2-sprite-plane-move [309.647561] Starting dynamic subtest: eDP-1 [309.649461] Dynamic subtest eDP-1: SKIP (0.000s) [309.651154] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [309.715851] [065/133] (730s left) kms_atomic (atomic-invalid-params) [309.810070] Starting subtest: atomic-invalid-params [309.811101] Starting dynamic subtest: pipe-A-eDP-1 [310.225142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.416s) [310.225978] Subtest atomic-invalid-params: SUCCESS (0.417s) [311.054980] [066/133] (728s left) kms_flip (wf_vblank-ts-check) [311.149432] Starting subtest: wf_vblank-ts-check [311.150250] Starting dynamic subtest: A-eDP1 [320.133544] Dynamic subtest A-eDP1: SUCCESS (8.960s) [320.144529] Starting dynamic subtest: B-eDP1 [329.061804] Dynamic subtest B-eDP1: SUCCESS (8.925s) [329.073159] Starting dynamic subtest: C-eDP1 [337.999349] Dynamic subtest C-eDP1: SUCCESS (8.924s) [338.007912] Starting dynamic subtest: D-eDP1 [346.937116] Dynamic subtest D-eDP1: SUCCESS (8.932s) [346.938259] Subtest wf_vblank-ts-check: SUCCESS (35.753s) [348.133117] [067/133] (691s left) kms_prop_blob (invalid-get-prop) [348.186293] Starting subtest: invalid-get-prop [348.187174] Subtest invalid-get-prop: SUCCESS (0.000s) [348.281918] [068/133] (691s left) kms_color_pipeline (plane-lut1d-post-ctm3x4) [348.377800] Starting subtest: plane-lut1d-post-ctm3x4 [348.547770] Starting dynamic subtest: pipe-A-plane-0 [348.816799] Dynamic subtest pipe-A-plane-0: FAIL (0.206s) [348.826159] Starting dynamic subtest: pipe-A-plane-1 [349.017419] Dynamic subtest pipe-A-plane-1: FAIL (0.190s) [349.027004] Starting dynamic subtest: pipe-A-plane-2 [349.208335] Dynamic subtest pipe-A-plane-2: FAIL (0.177s) [350.357443] Starting dynamic subtest: pipe-B-plane-0 [350.616687] Dynamic subtest pipe-B-plane-0: FAIL (0.175s) [350.625776] Starting dynamic subtest: pipe-B-plane-1 [350.815347] Dynamic subtest pipe-B-plane-1: FAIL (0.177s) [350.824105] Starting dynamic subtest: pipe-B-plane-2 [350.995854] Dynamic subtest pipe-B-plane-2: FAIL (0.177s) [352.093900] Starting dynamic subtest: pipe-C-plane-0 [352.363494] Dynamic subtest pipe-C-plane-0: FAIL (0.140s) [352.372287] Starting dynamic subtest: pipe-C-plane-1 [352.520878] Dynamic subtest pipe-C-plane-1: FAIL (0.159s) [352.530348] Starting dynamic subtest: pipe-C-plane-2 [352.695910] Dynamic subtest pipe-C-plane-2: FAIL (0.160s) [353.718149] Starting dynamic subtest: pipe-D-plane-0 [354.025941] Dynamic subtest pipe-D-plane-0: FAIL (0.141s) [354.036343] Starting dynamic subtest: pipe-D-plane-1 [354.216157] Dynamic subtest pipe-D-plane-1: FAIL (0.154s) [354.224709] Starting dynamic subtest: pipe-D-plane-2 [354.411252] Dynamic subtest pipe-D-plane-2: FAIL (0.319s) [354.639032] Subtest plane-lut1d-post-ctm3x4: FAIL (6.259s) [355.480246] [069/133] (684s left) i915_query (query-topology-coherent-slice-mask) [355.529166] Starting subtest: query-topology-coherent-slice-mask [355.530745] Subtest query-topology-coherent-slice-mask: SKIP (0.000s) [355.624588] [070/133] (684s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [355.672117] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [355.777835] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s) [355.854300] [071/133] (684s left) gem_ctx_param (invalid-get-no-zeromap) [355.908493] Starting subtest: invalid-get-no-zeromap [355.909364] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [356.013425] [072/133] (684s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [356.095210] Starting subtest: fbcpsr-shrfb-scaledprimary [361.898389] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.800s) [362.020572] [073/133] (678s left) kms_psr (pr-primary-page-flip) [362.122447] Starting subtest: pr-primary-page-flip [362.124161] Subtest pr-primary-page-flip: SKIP (0.000s) [362.203703] [074/133] (678s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [362.320695] Starting subtest: basic-flip-before-cursor-varying-size [363.260292] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.938s) [364.077218] [075/133] (676s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [364.144279] Starting subtest: mixed-tiled-to-y-tiled-ccs [364.146167] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [364.324270] [076/133] (675s left) gem_exec_fence (syncobj-invalid-flags) [364.789314] Starting subtest: syncobj-invalid-flags [364.790466] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [366.497335] [077/133] (673s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [366.634011] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [366.635830] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [366.736116] [078/133] (673s left) gem_mmap_offset (partial-remap) [366.787195] Starting subtest: partial-remap [366.788241] Starting dynamic subtest: smem0 [366.792426] Dynamic subtest smem0: SUCCESS (0.004s) [366.793502] Subtest partial-remap: SUCCESS (0.004s) [366.897315] [079/133] (673s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen) [366.981833] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen [370.949931] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.969s) [372.156490] [080/133] (668s left) gem_exec_reloc (basic-gtt-active) [372.209251] Subtest basic-gtt-active: SKIP (0.000s) [372.288208] [081/133] (668s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [372.386564] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [373.200834] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.815s) [373.389289] [082/133] (667s left) gem_exec_params (no-vebox) [373.442313] Starting subtest: no-vebox [373.443232] Subtest no-vebox: SUCCESS (0.002s) [375.453701] [083/133] (665s left) syncobj_wait (wait-any-complex) [375.502335] Starting subtest: wait-any-complex [375.565394] Subtest wait-any-complex: SUCCESS (0.062s) [375.636606] [084/133] (664s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [375.719446] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [383.112906] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.396s) [383.220900] [085/133] (657s left) api_intel_bb (lot-of-buffers) [383.270789] Starting subtest: lot-of-buffers [384.393082] Subtest lot-of-buffers: SUCCESS (1.113s) [384.693733] [086/133] (655s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [384.775504] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [384.776431] Starting dynamic subtest: pipe-A [384.797498] Dynamic subtest pipe-A: SKIP (0.020s) [384.806640] Starting dynamic subtest: pipe-B [384.833160] Dynamic subtest pipe-B: SKIP (0.035s) [384.842145] Starting dynamic subtest: pipe-C [384.865914] Dynamic subtest pipe-C: SKIP (0.033s) [384.874563] Starting dynamic subtest: pipe-D [384.899038] Dynamic subtest pipe-D: SKIP (0.033s) [384.900735] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.123s) [384.998331] [087/133] (655s left) syncobj_timeline (invalid-transfer-illegal-handle) [385.048546] Starting subtest: invalid-transfer-illegal-handle [385.049359] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [385.139879] [088/133] (655s left) gem_exec_schedule (thriceslice) [385.191696] Starting subtest: thriceslice [385.192576] Starting dynamic subtest: rcs0 [385.222419] Dynamic subtest rcs0: SUCCESS (0.031s) [385.232879] Starting dynamic subtest: bcs0 [385.254190] Dynamic subtest bcs0: SUCCESS (0.029s) [385.263629] Starting dynamic subtest: vcs0 [385.305717] Dynamic subtest vcs0: SUCCESS (0.049s) [385.317650] Starting dynamic subtest: vcs1 [385.337062] Dynamic subtest vcs1: SUCCESS (0.029s) [385.346523] Starting dynamic subtest: vecs0 [385.387142] Dynamic subtest vecs0: SUCCESS (0.048s) [385.400488] Starting dynamic subtest: ccs0 [385.419933] Dynamic subtest ccs0: SUCCESS (0.030s) [385.420876] Subtest thriceslice: SUCCESS (0.229s) [386.447458] [089/133] (654s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [386.543591] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [390.617548] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.075s) [391.769951] [090/133] (649s left) api_intel_allocator (simple-allocator) [391.825788] Starting subtest: simple-allocator [391.826657] Starting dynamic subtest: basic [391.828466] Dynamic subtest basic: SUCCESS (0.004s) [391.839110] Starting dynamic subtest: parallel-one [392.034663] Dynamic subtest parallel-one: SUCCESS (0.197s) [392.046595] Starting dynamic subtest: print [392.047634] Dynamic subtest print: SUCCESS (0.000s) [392.055850] Starting dynamic subtest: reuse [392.057347] Dynamic subtest reuse: SUCCESS (0.000s) [392.065299] Starting dynamic subtest: reserve [392.066034] Dynamic subtest reserve: SUCCESS (0.000s) [392.074071] Starting dynamic subtest: fork-reopen-allocator [392.074989] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [392.075859] Subtest simple-allocator: SUCCESS (0.217s) [392.156761] [091/133] (648s left) kms_force_connector_basic (force-edid) [392.230935] Starting subtest: force-edid [392.595306] Subtest force-edid: SUCCESS (0.364s) [392.745170] [092/133] (648s left) kms_lease (lessee-list) [392.845306] Starting subtest: lessee-list [392.846137] Starting dynamic subtest: pipe-A-eDP-1 [392.848413] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [392.860529] Starting dynamic subtest: pipe-B-eDP-1 [392.861370] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [392.870340] Starting dynamic subtest: pipe-C-eDP-1 [392.871184] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [392.879375] Starting dynamic subtest: pipe-D-eDP-1 [392.880198] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [392.881021] Subtest lessee-list: SUCCESS (0.010s) [392.952955] [093/133] (647s left) gem_mmap (pf-nonblock) [392.998961] Subtest pf-nonblock: SKIP (0.000s) [393.060896] [094/133] (647s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [393.143938] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [393.145708] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [393.247260] [095/133] (647s left) i915_drm_fdinfo (virtual-idle) [393.289467] Starting subtest: virtual-idle [396.369492] Subtest virtual-idle: SUCCESS (3.071s) [396.446798] [096/133] (644s left) core_setmaster_vs_auth [396.592502] [097/133] (644s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [396.679127] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [396.679958] Starting dynamic subtest: pipe-A-eDP-1 [396.688801] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [396.697423] Starting dynamic subtest: pipe-B-eDP-1 [396.706338] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [396.714952] Starting dynamic subtest: pipe-C-eDP-1 [396.731207] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [396.739436] Starting dynamic subtest: pipe-D-eDP-1 [396.747022] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [396.748444] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [398.967166] [098/133] (642s left) kms_cursor_crc (cursor-random-256x85) [399.220584] Starting subtest: cursor-random-256x85 [399.266748] Subtest cursor-random-256x85: SKIP (0.044s) [399.443600] [099/133] (641s left) gem_lmem_swapping (parallel-random-engines) [399.482279] Subtest parallel-random-engines: SKIP (0.000s) [399.520436] [100/133] (641s left) kms_big_fb (yf-tiled-addfb) [399.603440] Starting subtest: yf-tiled-addfb [399.605112] Subtest yf-tiled-addfb: SKIP (0.000s) [399.696749] [101/133] (641s left) kms_properties (connector-properties-legacy) [399.786201] Starting subtest: connector-properties-legacy [399.787067] Starting dynamic subtest: pipe-A-eDP-1 [407.930763] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.143s) [407.939924] Starting dynamic subtest: pipe-None-DP-1 [407.942156] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [407.950813] Starting dynamic subtest: pipe-None-HDMI-A-1 [407.952692] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [407.961281] Starting dynamic subtest: pipe-None-DP-2 [407.962915] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [407.971253] Starting dynamic subtest: pipe-None-HDMI-A-2 [407.973364] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [407.982886] Starting dynamic subtest: pipe-None-DP-3 [407.984680] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [407.992959] Starting dynamic subtest: pipe-None-DP-4 [407.994794] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [407.995701] Subtest connector-properties-legacy: SUCCESS (8.155s) [408.782209] [102/133] (632s left) kms_chamelium_audio (dp-audio-edid) [409.158803] Subtest dp-audio-edid: SKIP (0.000s) [409.945852] [103/133] (631s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [410.036176] Starting subtest: nonblocking-crc-frame-sequence [410.037001] Starting dynamic subtest: pipe-A-eDP-1 [410.791028] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s) [410.799859] Starting dynamic subtest: pipe-B-eDP-1 [412.183298] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s) [412.192035] Starting dynamic subtest: pipe-C-eDP-1 [413.524590] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.340s) [413.533530] Starting dynamic subtest: pipe-D-eDP-1 [414.901058] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.375s) [414.901950] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.865s) [415.769175] [104/133] (625s left) gem_exec_big (single) [415.832180] Starting subtest: single [420.670081] Subtest single: SUCCESS (4.792s) [420.876006] [105/133] (620s left) prime_vgem (basic-fence-read) [420.982824] Starting subtest: basic-fence-read [420.999428] Subtest basic-fence-read: SKIP (0.017s) [421.101809] [106/133] (620s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [421.156881] Starting subtest: etime-single-wait-available-unsubmitted [421.265485] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.108s) [421.355907] [107/133] (620s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [421.448551] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [421.449447] Starting dynamic subtest: pipe-A-default-mode [424.165376] Dynamic subtest pipe-A-default-mode: SUCCESS (2.714s) [424.166293] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.716s) [424.961036] [108/133] (616s left) core_sysfs (read-all-entries) [425.022588] Starting subtest: read-all-entries [425.032189] Subtest read-all-entries: SUCCESS (0.011s) [425.106629] [109/133] (616s left) gem_busy (close-race) [425.155584] Starting subtest: close-race [448.438282] Subtest close-race: SUCCESS (23.268s) [448.800412] [110/133] (592s left) i915_suspend (basic-s2idle-without-i915) [448.878156] Starting subtest: basic-s2idle-without-i915 [468.415981] Subtest basic-s2idle-without-i915: SUCCESS (4.530s) [472.522532] [111/133] (573s left) gem_exec_flush (basic-uc-set-default) [472.589421] Starting subtest: basic-uc-set-default [478.087318] Subtest basic-uc-set-default: SUCCESS (5.469s) [478.268491] [112/133] (567s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [478.365521] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [478.366291] Starting dynamic subtest: pipe-A [478.385051] Dynamic subtest pipe-A: SKIP (0.018s) [478.392628] Starting dynamic subtest: pipe-B [478.421752] Dynamic subtest pipe-B: SKIP (0.036s) [478.429812] Starting dynamic subtest: pipe-C [478.459022] Dynamic subtest pipe-C: SKIP (0.036s) [478.466594] Starting dynamic subtest: pipe-D [478.495130] Dynamic subtest pipe-D: SKIP (0.036s) [478.496760] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.128s) [478.585383] [113/133] (567s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode) [478.972187] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s) [479.749133] [114/133] (565s left) gem_exec_whisper (basic-contexts-priority) [479.824922] Starting subtest: basic-contexts-priority [504.943028] Subtest basic-contexts-priority: SUCCESS (25.039s) [505.082391] [115/133] (540s left) syncobj_eventfd (binary-wait) [505.132845] Starting subtest: binary-wait [505.141704] Subtest binary-wait: SUCCESS (0.010s) [505.264901] [116/133] (540s left) gem_eio (wait-wedge-10ms) [505.503046] Starting subtest: wait-wedge-10ms [506.532502] Subtest wait-wedge-10ms: SUCCESS (1.031s) [506.666489] [117/133] (539s left) gem_softpin (invalid) [506.719519] Starting subtest: invalid [506.727575] Subtest invalid: SUCCESS (0.008s) [506.838954] [118/133] (538s left) prime_self_import (basic-with_one_bo_two_files) [506.869428] Starting subtest: basic-with_one_bo_two_files [506.889408] Subtest basic-with_one_bo_two_files: SUCCESS (0.021s) [506.989784] [119/133] (538s left) gem_compute (compute-square) [507.045256] Starting subtest: compute-square [507.051073] Subtest compute-square: SUCCESS (0.007s) [507.185840] [120/133] (538s left) perf (low-oa-exponent-permissions) [507.311013] Starting subtest: low-oa-exponent-permissions [507.349494] Subtest low-oa-exponent-permissions: SUCCESS (0.039s) [507.394320] [121/133] (538s left) sysfs_heartbeat_interval (precise) [507.456439] Starting subtest: precise [507.457371] Starting dynamic subtest: vecs0 [515.463055] Dynamic subtest vecs0: SUCCESS (8.008s) [515.475566] Starting dynamic subtest: ccs0 [516.655719] Dynamic subtest ccs0: SUCCESS (1.190s) [516.664803] Starting dynamic subtest: vcs0 [524.426113] Dynamic subtest vcs0: SUCCESS (7.769s) [524.438083] Starting dynamic subtest: bcs0 [527.362444] Dynamic subtest bcs0: SUCCESS (2.933s) [527.373502] Starting dynamic subtest: rcs0 [528.473446] Dynamic subtest rcs0: SUCCESS (1.110s) [528.483146] Starting dynamic subtest: vcs1 [536.457971] Dynamic subtest vcs1: SUCCESS (7.981s) [536.460979] Subtest precise: SUCCESS (29.002s) [536.533105] [122/133] (509s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [536.624199] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [541.354857] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.729s) [542.537917] [123/133] (503s left) gem_ctx_persistence (legacy-engines-hostile) [542.583308] Starting subtest: legacy-engines-hostile [542.584126] Starting dynamic subtest: render [542.658831] Dynamic subtest render: SUCCESS (0.074s) [542.674583] Starting dynamic subtest: bsd1 [542.757956] Dynamic subtest bsd1: SUCCESS (0.095s) [542.771325] Starting dynamic subtest: bsd2 [542.854757] Dynamic subtest bsd2: SUCCESS (0.094s) [542.867598] Starting dynamic subtest: blt [542.943971] Dynamic subtest blt: SUCCESS (0.086s) [542.957419] Starting dynamic subtest: vebox [543.029823] Dynamic subtest vebox: SUCCESS (0.083s) [543.031087] Subtest legacy-engines-hostile: SUCCESS (0.447s) [543.118479] [124/133] (502s left) kms_big_fb (4-tiled-8bpp-rotate-180) [543.236186] Starting subtest: 4-tiled-8bpp-rotate-180 [544.519331] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.282s) [544.651621] [125/133] (501s left) kms_addfb_basic (invalid-get-prop) [544.703658] Starting subtest: invalid-get-prop [544.704476] Subtest invalid-get-prop: SUCCESS (0.000s) [544.839721] [126/133] (501s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [544.906213] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [544.907366] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [545.011836] [127/133] (501s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [545.103177] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [546.164613] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.061s) [546.284906] [128/133] (499s left) perf_pmu (render-node-busy) [546.348780] Starting subtest: render-node-busy [546.349867] Starting dynamic subtest: rcs0 [546.933525] Dynamic subtest rcs0: SUCCESS (0.584s) [546.947557] Starting dynamic subtest: bcs0 [547.492862] Dynamic subtest bcs0: SUCCESS (0.556s) [547.506140] Starting dynamic subtest: vcs0 [549.462759] Dynamic subtest vcs0: SUCCESS (1.957s) [549.474421] Starting dynamic subtest: vcs1 [551.447056] Dynamic subtest vcs1: SUCCESS (1.981s) [551.458711] Starting dynamic subtest: vecs0 [553.431099] Dynamic subtest vecs0: SUCCESS (1.981s) [553.442817] Starting dynamic subtest: ccs0 [554.000497] Dynamic subtest ccs0: SUCCESS (0.576s) [554.001819] Subtest render-node-busy: SUCCESS (7.650s) [554.073533] [129/133] (492s left) gem_exec_parallel (userptr) [554.125144] Starting subtest: userptr [554.126068] Starting dynamic subtest: rcs0 [555.683279] Dynamic subtest rcs0: SUCCESS (1.557s) [555.698888] Starting dynamic subtest: bcs0 [557.180498] Dynamic subtest bcs0: SUCCESS (1.494s) [557.192441] Starting dynamic subtest: vcs0 [560.406263] Dynamic subtest vcs0: SUCCESS (3.214s) [560.418728] Starting dynamic subtest: vcs1 [562.455939] Dynamic subtest vcs1: SUCCESS (2.046s) [562.468726] Starting dynamic subtest: vecs0 [564.437950] Dynamic subtest vecs0: SUCCESS (1.979s) [564.450031] Starting dynamic subtest: ccs0 [565.954417] Dynamic subtest ccs0: SUCCESS (1.523s) [565.956691] Subtest userptr: SUCCESS (11.826s) [566.144364] [130/133] (480s left) kms_flip (2x-modeset-vs-vblank-race) [566.235061] Starting subtest: 2x-modeset-vs-vblank-race [566.246450] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s) [566.336490] [131/133] (479s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [566.420748] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [571.149048] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.727s) [572.344272] [132/133] (473s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [572.439395] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [579.865783] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.429s) [580.011622] [133/133] (466s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [580.059208] Starting subtest: wait-all-for-submit-delayed-submit [580.165557] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.105s) [580.247304] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: gem_ctx_shared results: parsing output: 2/ for test: kms_psr2_sf results: parsing output: 3/ for test: kms_pm_rpm results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: prime_mmap_kms results: parsing output: 6/ for test: perf_pmu results: parsing output: 7/ for test: kms_addfb_basic results: parsing output: 8/ for test: kms_draw_crc results: parsing output: 9/ for test: gem_exec_schedule results: parsing output: 10/ for test: gem_render_copy results: parsing output: 11/ for test: gem_softpin results: parsing output: 12/ for test: gem_exec_suspend results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_psr results: parsing output: 15/ for test: i915_drm_fdinfo results: parsing output: 16/ for test: kms_vblank results: parsing output: 17/ for test: i915_pm_rpm results: parsing output: 18/ for test: kms_flip_scaled_crc results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: kms_plane results: parsing output: 21/ for test: gem_userptr_blits results: parsing output: 22/ for test: gem_ctx_param results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_cursor_legacy results: parsing output: 25/ for test: kms_cursor_legacy results: parsing output: 26/ for test: kms_cursor_crc results: parsing output: 27/ for test: kms_cursor_edge_walk results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: kms_addfb_basic results: parsing output: 30/ for test: gem_userptr_blits results: parsing output: 31/ for test: gem_ccs results: parsing output: 32/ for test: gem_mmap_gtt results: parsing output: 33/ for test: gem_userptr_blits results: parsing output: 34/ for test: perf results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_tiled_wc results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: testdisplay results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_chamelium_edid results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_rotation_crc results: parsing output: 45/ for test: kms_pipe_b_c_ivb results: parsing output: 46/ for test: gem_ctx_param results: parsing output: 47/ for test: kms_pm_backlight results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_cursor_legacy results: parsing output: 51/ for test: gem_flink_race results: parsing output: 52/ for test: kms_plane_lowres results: parsing output: 53/ for test: gem_userptr_blits results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: gen9_exec_parse results: parsing output: 58/ for test: kms_joiner results: parsing output: 59/ for test: kms_universal_plane results: parsing output: 60/ for test: kms_content_protection results: parsing output: 61/ for test: gem_exec_balancer results: parsing output: 62/ for test: gem_eio results: parsing output: 63/ for test: kms_psr results: parsing output: 64/ for test: kms_atomic results: parsing output: 65/ for test: kms_flip results: parsing output: 66/ for test: kms_prop_blob results: parsing output: 67/ for test: kms_color_pipeline results: parsing output: 68/ for test: i915_query results: parsing output: 69/ for test: syncobj_timeline results: parsing output: 70/ for test: gem_ctx_param results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: kms_cursor_legacy results: parsing output: 74/ for test: gem_render_copy results: parsing output: 75/ for test: gem_exec_fence results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: gem_mmap_offset results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_exec_reloc results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: gem_exec_params results: parsing output: 82/ for test: syncobj_wait results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: api_intel_bb results: parsing output: 85/ for test: kms_plane_scaling results: parsing output: 86/ for test: syncobj_timeline results: parsing output: 87/ for test: gem_exec_schedule results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: api_intel_allocator results: parsing output: 90/ for test: kms_force_connector_basic results: parsing output: 91/ for test: kms_lease results: parsing output: 92/ for test: gem_mmap results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: i915_drm_fdinfo results: parsing output: 95/ for test: core_setmaster_vs_auth results: parsing output: 96/ for test: kms_ccs results: parsing output: 97/ for test: kms_cursor_crc results: parsing output: 98/ for test: gem_lmem_swapping results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: kms_properties results: parsing output: 101/ for test: kms_chamelium_audio results: parsing output: 102/ for test: kms_pipe_crc_basic results: parsing output: 103/ for test: gem_exec_big results: parsing output: 104/ for test: prime_vgem results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: kms_flip_scaled_crc results: parsing output: 107/ for test: core_sysfs results: parsing output: 108/ for test: gem_busy results: parsing output: 109/ for test: i915_suspend results: parsing output: 110/ for test: gem_exec_flush results: parsing output: 111/ for test: kms_plane_scaling results: parsing output: 112/ for test: kms_chamelium_hpd results: parsing output: 113/ for test: gem_exec_whisper results: parsing output: 114/ for test: syncobj_eventfd results: parsing output: 115/ for test: gem_eio results: parsing output: 116/ for test: gem_softpin results: parsing output: 117/ for test: prime_self_import results: parsing output: 118/ for test: gem_compute results: parsing output: 119/ for test: perf results: parsing output: 120/ for test: sysfs_heartbeat_interval results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_ctx_persistence results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: kms_addfb_basic results: parsing output: 125/ for test: syncobj_timeline results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: perf_pmu results: parsing output: 128/ for test: gem_exec_parallel results: parsing output: 129/ for test: kms_flip results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: syncobj_timeline Done.