[62.430667] Initializing watchdogs [62.430717] /dev/watchdog0 [62.445910] [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.450565] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.452884] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.454974] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [62.562033] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [62.563970] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [62.664923] [002/131] (960s left) i915_pm_rpm (debugfs-read) [64.227058] Starting subtest: debugfs-read [65.386532] Subtest debugfs-read: SUCCESS (1.154s) [65.745895] [003/131] (957s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [65.848283] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [65.850107] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [65.934237] [004/131] (957s left) kms_plane (plane-panning-top-left) [66.011229] Starting subtest: plane-panning-top-left [66.012195] Starting dynamic subtest: pipe-A [67.716172] Dynamic subtest pipe-A: SUCCESS (1.700s) [67.723566] Starting dynamic subtest: pipe-B [70.062922] Dynamic subtest pipe-B: SUCCESS (2.340s) [70.063862] Subtest plane-panning-top-left: SUCCESS (4.042s) [70.886981] [005/131] (952s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [70.986079] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [70.987094] Starting dynamic subtest: pipe-A-eDP-1 [71.004433] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [71.012183] Starting dynamic subtest: pipe-B-eDP-1 [71.021023] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [71.027078] Starting dynamic subtest: pipe-C-eDP-1 [71.035200] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [71.041070] Starting dynamic subtest: pipe-D-eDP-1 [71.049516] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [71.051209] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s) [73.156048] [006/131] (949s left) gem_vm_create (execbuf) [73.221958] Starting subtest: execbuf [73.227813] Subtest execbuf: SUCCESS (0.007s) [73.349704] [007/131] (949s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [73.452609] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [74.267805] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.815s) [74.423090] [008/131] (948s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [74.509962] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [74.512211] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [74.594044] [009/131] (948s left) kms_pipe_stress (stress-xrgb8888-untiled) [74.682945] Starting subtest: stress-xrgb8888-untiled [80.535032] Subtest stress-xrgb8888-untiled: SUCCESS (5.848s) [80.578821] [010/131] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [80.664890] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [80.666744] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [80.785992] [011/131] (942s left) gem_pipe_control_store_loop (fresh-buffer) [80.845185] Starting subtest: fresh-buffer [83.007834] Subtest fresh-buffer: SUCCESS (2.151s) [83.110226] [012/131] (940s left) i915_drm_fdinfo (all-busy-check-all) [83.145079] Starting subtest: all-busy-check-all [83.150317] Subtest all-busy-check-all: SKIP (0.004s) [83.206340] [013/131] (940s left) gem_mmap_gtt (cpuset-medium-copy-xy) [83.250449] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [83.314754] [014/131] (940s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [83.402482] Starting subtest: fbcpsr-farfromfence-mmap-gtt [83.404281] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [83.481929] [015/131] (939s left) kms_lease (cursor-implicit-plane) [83.569230] Starting subtest: cursor-implicit-plane [83.570182] Starting dynamic subtest: pipe-A-eDP-1 [84.026699] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s) [84.034246] Starting dynamic subtest: pipe-B-eDP-1 [85.192067] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.163s) [85.199189] Starting dynamic subtest: pipe-C-eDP-1 [86.301681] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s) [86.311064] Starting dynamic subtest: pipe-D-eDP-1 [87.437062] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [87.437968] Subtest cursor-implicit-plane: SUCCESS (3.867s) [88.297616] [016/131] (935s left) gem_ctx_persistence (processes) [88.350102] Starting subtest: processes [89.895565] Subtest processes: SUCCESS (1.544s) [89.970450] [017/131] (933s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [90.067083] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [90.068768] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [90.146245] [018/131] (933s left) i915_pm_rps (waitboost) [90.202369] Starting subtest: waitboost [96.297280] Subtest waitboost: SUCCESS (6.087s) [96.415847] [019/131] (927s left) perf (gen12-group-concurrent-oa-buffer-read) [96.544931] Starting subtest: gen12-group-concurrent-oa-buffer-read [106.626874] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.032s) [106.657634] [020/131] (916s left) kms_rotation_crc (bad-pixel-format) [106.741096] Starting subtest: bad-pixel-format [106.742915] Subtest bad-pixel-format: SKIP (0.001s) [106.813847] [021/131] (916s left) gem_ctx_shared (single-timeline) [106.874080] Starting subtest: single-timeline [106.888690] Subtest single-timeline: SUCCESS (0.014s) [107.107074] [022/131] (916s left) gem_readwrite (beyond-eob) [107.165279] Subtest beyond-EOB: SKIP (0.000s) [107.225048] [023/131] (916s left) kms_panel_fitting (atomic-fastset) [107.308164] Starting subtest: atomic-fastset [107.308999] Starting dynamic subtest: pipe-A-eDP-1 [107.450780] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.142s) [107.460238] Starting dynamic subtest: pipe-B-eDP-1 [108.665750] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.214s) [108.675365] Starting dynamic subtest: pipe-C-eDP-1 [109.851474] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.184s) [109.858932] Starting dynamic subtest: pipe-D-eDP-1 [110.982111] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s) [110.983145] Subtest atomic-fastset: SUCCESS (3.674s) [112.234812] [024/131] (911s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [112.323279] Starting subtest: fbc-modesetfrombusy [116.099812] Subtest fbc-modesetfrombusy: SUCCESS (3.776s) [117.273649] [025/131] (906s left) kms_psr (psr2-sprite-plane-move) [117.355402] Starting subtest: psr2-sprite-plane-move [117.356347] Starting dynamic subtest: eDP-1 [119.094784] Dynamic subtest eDP-1: SUCCESS (1.739s) [119.095911] Subtest psr2-sprite-plane-move: SUCCESS (1.739s) [119.926870] [026/131] (903s left) gem_mmap_wc (pf-nonblock) [119.986452] Subtest pf-nonblock: SKIP (0.000s) [120.044704] [027/131] (903s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [120.434654] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [121.241418] [028/131] (902s left) kms_selftest (drm_format_helper) [121.272985] Starting subtest: drm_format_helper [121.317854] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [121.401717] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.084s) [121.408791] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [121.482798] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.080s) [121.490414] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [121.565323] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.082s) [121.573268] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [121.649732] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.084s) [121.657259] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [121.743235] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.091s) [121.751045] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [121.839430] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.096s) [121.847238] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [121.950061] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.110s) [121.957829] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [122.040840] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.089s) [122.049349] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [122.123033] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.081s) [122.130608] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [122.209887] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.087s) [122.218838] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [122.303089] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.092s) [122.309682] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [122.392921] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.089s) [122.400886] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [122.477615] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.085s) [122.486235] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [122.568721] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.090s) [122.576210] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [122.658241] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.086s) [122.666192] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [122.764904] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.108s) [122.777464] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [122.874013] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.108s) [122.874993] Subtest drm_format_helper: SUCCESS (1.601s) [123.021294] [029/131] (900s left) gem_exec_reloc (basic-wc-cpu-active) [123.070559] Subtest basic-wc-cpu-active: SKIP (0.000s) [123.131443] [030/131] (900s left) syncobj_eventfd (binary-wait-signaled) [123.189094] Starting subtest: binary-wait-signaled [123.189989] Subtest binary-wait-signaled: SUCCESS (0.000s) [123.296267] [031/131] (900s left) perf (whitelisted-registers-userspace-config) [123.381578] Starting subtest: whitelisted-registers-userspace-config [123.382698] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s) [123.415055] [032/131] (900s left) gem_exec_flush (basic-wb-ro-before-default) [123.466159] Starting subtest: basic-wb-ro-before-default [128.927662] Subtest basic-wb-ro-before-default: SUCCESS (5.461s) [129.107482] [033/131] (894s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [129.189146] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [129.190175] Starting dynamic subtest: pipe-A-eDP-1 [146.081379] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.913s) [146.089131] Starting dynamic subtest: pipe-B-eDP-1 [164.025122] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.818s) [164.033377] Starting dynamic subtest: pipe-C-eDP-1 [181.966264] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.784s) [181.974226] Starting dynamic subtest: pipe-D-eDP-1 [199.998142] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.780s) [199.999190] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.300s) [206.261567] [034/131] (822s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [206.353041] Starting subtest: plane-upscale-20x20-with-modifiers [206.354138] Starting dynamic subtest: pipe-A [206.689598] Dynamic subtest pipe-A: SUCCESS (0.338s) [206.697889] Starting dynamic subtest: pipe-B [208.172540] Dynamic subtest pipe-B: SUCCESS (1.442s) [208.187179] Starting dynamic subtest: pipe-C [209.639646] Dynamic subtest pipe-C: SUCCESS (1.427s) [209.648207] Starting dynamic subtest: pipe-D [211.112174] Dynamic subtest pipe-D: SUCCESS (1.440s) [211.113091] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.653s) [212.298302] [035/131] (816s left) kms_color (invalid-degamma-lut-sizes) [212.398748] Starting subtest: invalid-degamma-lut-sizes [212.399614] Starting dynamic subtest: pipe-A [212.692417] Dynamic subtest pipe-A: SUCCESS (0.288s) [212.700278] Starting dynamic subtest: pipe-B [212.701216] Dynamic subtest pipe-B: SUCCESS (0.000s) [212.709270] Starting dynamic subtest: pipe-C [212.710193] Dynamic subtest pipe-C: SUCCESS (0.000s) [212.717907] Starting dynamic subtest: pipe-D [212.719174] Dynamic subtest pipe-D: SUCCESS (0.000s) [212.720514] Subtest invalid-degamma-lut-sizes: SUCCESS (0.292s) [213.557572] [036/131] (815s left) gem_softpin (32b-excludes-last-page) [213.609663] Starting subtest: 32b-excludes-last-page [213.613499] Subtest 32b-excludes-last-page: SUCCESS (0.004s) [213.727384] [037/131] (815s left) i915_fb_tiling (basic-x-tiling) [213.779870] Subtest basic-x-tiling: SKIP (0.000s) [213.848756] [038/131] (815s left) gem_exec_whisper (basic-contexts-priority) [213.911222] Starting subtest: basic-contexts-priority [238.882202] Subtest basic-contexts-priority: SUCCESS (24.822s) [239.022354] [039/131] (790s left) gem_exec_params (rsvd2-dirt) [239.077349] Starting subtest: rsvd2-dirt [239.079093] Subtest rsvd2-dirt: SKIP (0.000s) [239.169275] [040/131] (790s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [239.215193] Starting subtest: multi-wait-available-unsubmitted-signaled [239.215975] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [239.302991] [041/131] (790s left) kms_big_fb (4-tiled-32bpp-rotate-90) [239.417678] Starting subtest: 4-tiled-32bpp-rotate-90 [239.438028] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s) [239.560431] [042/131] (789s left) gem_exec_reloc (basic-cpu-read-noreloc) [239.614292] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [239.673979] [043/131] (789s left) kms_psr (psr-dpms) [239.775695] Starting subtest: psr-dpms [239.776660] Starting dynamic subtest: eDP-1 [242.810110] Dynamic subtest eDP-1: SUCCESS (3.033s) [242.811019] Subtest psr-dpms: SUCCESS (3.034s) [243.669459] [044/131] (785s left) kms_hdr (invalid-hdr) [243.756952] Starting subtest: invalid-hdr [245.870740] Starting dynamic subtest: pipe-A-eDP-1 [248.879930] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.008s) [248.880756] Subtest invalid-hdr: SUCCESS (5.123s) [248.977537] [045/131] (780s left) kms_cursor_edge_walk (256x256-top-bottom) [249.057290] Starting subtest: 256x256-top-bottom [249.058229] Starting dynamic subtest: pipe-A-eDP-1 [252.567015] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.508s) [252.576631] Starting dynamic subtest: pipe-D-eDP-1 [255.689213] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s) [255.690031] Subtest 256x256-top-bottom: SUCCESS (6.631s) [256.495363] [046/131] (772s left) gem_exec_fence (syncobj-timeline-export) [257.106169] Starting subtest: syncobj-timeline-export [257.107590] Subtest syncobj-timeline-export: SUCCESS (0.007s) [258.485042] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true [258.487371] [047/131] (771s left) kms_psr (fbc-psr-suspend) [258.572831] Starting subtest: fbc-psr-suspend [258.573826] Starting dynamic subtest: eDP-1 [258.575762] Dynamic subtest eDP-1: SKIP (0.000s) [258.577720] Subtest fbc-psr-suspend: SKIP (0.001s) [258.652045] [048/131] (770s left) syncobj_wait (invalid-wait-illegal-handle) [258.695253] Starting subtest: invalid-wait-illegal-handle [258.696273] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [258.789316] [049/131] (770s left) kms_cursor_crc (cursor-offscreen-128x128) [258.999844] Starting subtest: cursor-offscreen-128x128 [259.006763] Starting dynamic subtest: pipe-A-eDP-1 [260.973453] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.965s) [261.002038] Starting dynamic subtest: pipe-D-eDP-1 [263.627028] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.630s) [263.627894] Subtest cursor-offscreen-128x128: SUCCESS (4.625s) [264.481031] [050/131] (765s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [264.571583] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [287.638275] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.057s) [287.745158] [051/131] (741s left) gem_exec_params (invalid-ring) [287.806901] Starting subtest: invalid-ring [287.808020] Subtest invalid-ring: SUCCESS (0.000s) [287.916439] [052/131] (741s left) gem_exec_schedule (preempt-hang) [288.093001] Starting subtest: preempt-hang [288.094698] Starting dynamic subtest: rcs0 [288.329644] Dynamic subtest rcs0: SUCCESS (0.236s) [288.339549] Starting dynamic subtest: bcs0 [288.560598] Dynamic subtest bcs0: SUCCESS (0.229s) [288.569404] Starting dynamic subtest: vcs0 [288.790176] Dynamic subtest vcs0: SUCCESS (0.228s) [288.800730] Starting dynamic subtest: vcs1 [289.015858] Dynamic subtest vcs1: SUCCESS (0.224s) [289.027583] Starting dynamic subtest: vecs0 [289.240068] Dynamic subtest vecs0: SUCCESS (0.225s) [289.248687] Starting dynamic subtest: ccs0 [289.469828] Dynamic subtest ccs0: SUCCESS (0.227s) [289.470804] Subtest preempt-hang: SUCCESS (1.377s) [290.509582] [053/131] (739s left) api_intel_allocator (default-alignment) [290.571002] Starting subtest: default-alignment [290.576030] Subtest default-alignment: SUCCESS (0.006s) [290.688484] [054/131] (739s left) gen9_exec_parse (allowed-single) [290.745860] Subtest allowed-single: SKIP (0.000s) [290.813983] [055/131] (739s left) gem_exec_flush (basic-batch-kernel-default-wb) [290.882576] Starting subtest: basic-batch-kernel-default-wb [297.629909] Subtest basic-batch-kernel-default-wb: SUCCESS (6.745s) [297.829820] [056/131] (732s left) kms_psr (fbc-psr-basic) [297.912216] Starting subtest: fbc-psr-basic [297.913092] Starting dynamic subtest: eDP-1 [297.914833] Dynamic subtest eDP-1: SKIP (0.000s) [297.916560] Subtest fbc-psr-basic: SKIP (0.001s) [297.981302] [057/131] (731s left) gem_readwrite (new-obj) [298.031031] Subtest new-obj: SKIP (0.000s) [298.100889] [058/131] (731s left) kms_big_fb (4-tiled-16bpp-rotate-180) [298.195776] Starting subtest: 4-tiled-16bpp-rotate-180 [299.440311] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.245s) [299.578470] [059/131] (730s left) gem_ctx_engines (none) [299.637356] Starting subtest: none [299.640276] Subtest none: SUCCESS (0.002s) [299.823120] [060/131] (730s left) kms_flip (wf_vblank-ts-check-interruptible) [299.923660] Starting subtest: wf_vblank-ts-check-interruptible [299.926095] Starting dynamic subtest: A-eDP1 [308.886541] Dynamic subtest A-eDP1: SUCCESS (8.939s) [308.901085] Starting dynamic subtest: B-eDP1 [317.815670] Dynamic subtest B-eDP1: SUCCESS (8.929s) [317.826411] Starting dynamic subtest: C-eDP1 [326.755268] Dynamic subtest C-eDP1: SUCCESS (8.928s) [326.769185] Starting dynamic subtest: D-eDP1 [335.688383] Dynamic subtest D-eDP1: SUCCESS (8.931s) [335.689208] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.739s) [336.883514] [061/131] (693s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [336.977691] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [336.979461] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [337.062139] [062/131] (693s left) gem_huc_copy (huc-copy) [337.118305] Starting subtest: huc-copy [337.121894] Subtest huc-copy: SUCCESS (0.004s) [337.227959] [063/131] (692s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [337.308860] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [337.310605] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s) [337.380064] [064/131] (692s left) kms_addfb_basic (bad-pitch-63) [337.425760] Starting subtest: bad-pitch-63 [337.427002] Subtest bad-pitch-63: SUCCESS (0.000s) [337.548151] [065/131] (692s left) kms_feature_discovery (psr2) [337.645472] Starting subtest: psr2 [337.646306] Subtest psr2: SUCCESS (0.000s) [337.725667] [066/131] (692s left) gem_exec_reloc (basic-gtt-active) [337.775515] Subtest basic-gtt-active: SKIP (0.000s) [337.836543] [067/131] (692s left) device_reset (unbind-reset-rebind) [337.888408] Starting subtest: unbind-reset-rebind [342.506740] Subtest unbind-reset-rebind: SUCCESS (4.607s) [342.540879] [068/131] (687s left) gem_busy (parallel) [342.732232] Starting subtest: parallel [342.732979] Starting dynamic subtest: rcs0 [344.442980] Dynamic subtest rcs0: SUCCESS (1.704s) [344.454934] Starting dynamic subtest: bcs0 [346.426970] Dynamic subtest bcs0: SUCCESS (1.980s) [346.439610] Starting dynamic subtest: vcs0 [348.410842] Dynamic subtest vcs0: SUCCESS (1.981s) [348.421404] Starting dynamic subtest: vcs1 [350.460171] Dynamic subtest vcs1: SUCCESS (2.046s) [350.471700] Starting dynamic subtest: vecs0 [352.380484] Dynamic subtest vecs0: SUCCESS (1.916s) [352.390870] Starting dynamic subtest: ccs0 [354.426465] Dynamic subtest ccs0: SUCCESS (2.042s) [354.427668] Subtest parallel: SUCCESS (11.687s) [354.651823] [069/131] (675s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [354.778897] Starting subtest: cursorB-vs-flipB-atomic-transitions [354.780862] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [354.921107] [070/131] (675s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [354.971655] Starting subtest: invalid-smem-bo-on-discrete [354.973662] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s) [355.120488] [071/131] (675s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [355.226027] Starting subtest: flip-vs-cursor-busy-crc-atomic [356.064556] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.838s) [356.863055] [072/131] (673s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [356.958718] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [364.868458] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.909s) [364.977176] [073/131] (665s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [365.068777] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [368.778464] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.709s) [369.913402] [074/131] (660s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area) [370.000862] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area [370.002685] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [370.080353] [075/131] (660s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [370.172990] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [370.174835] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [370.284171] [076/131] (660s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping) [370.377693] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping [370.405699] Starting dynamic subtest: pipe-A-plane-0 [370.705620] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s) [370.715962] Starting dynamic subtest: pipe-A-plane-3 [370.950144] Dynamic subtest pipe-A-plane-3: SUCCESS (0.242s) [372.101861] Starting dynamic subtest: pipe-B-plane-0 [372.392841] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [372.401694] Starting dynamic subtest: pipe-B-plane-3 [372.626259] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s) [372.934013] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.555s) [373.767348] [077/131] (656s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [373.864791] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [380.711818] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.846s) [380.831325] [078/131] (649s left) kms_plane_multiple (2x-tiling-yf) [380.926511] Starting subtest: 2x-tiling-yf [380.928418] Subtest 2x-tiling-yf: SKIP (0.000s) [380.992658] [079/131] (649s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf) [381.075378] Starting subtest: psr2-overlay-plane-update-continuous-sf [381.076396] Starting dynamic subtest: pipe-A-eDP-1 [382.209645] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.133s) [382.220172] Starting dynamic subtest: pipe-B-eDP-1 [383.962326] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.751s) [383.963183] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.887s) [384.766541] [080/131] (645s left) sw_sync (sync_random_merge) [384.800369] Starting subtest: sync_random_merge [384.845766] Subtest sync_random_merge: SUCCESS (0.045s) [384.902632] [081/131] (645s left) api_intel_bb (reset-bb) [384.956122] Starting subtest: reset-bb [384.960044] Subtest reset-bb: SUCCESS (0.003s) [385.074485] [082/131] (645s left) kms_chamelium_color (ctm-green-to-red) [385.156388] Subtest ctm-green-to-red: SKIP (0.000s) [385.196800] [083/131] (645s left) gem_exec_suspend (basic) [385.253852] Starting subtest: basic [385.254878] Starting dynamic subtest: smem [386.426819] Dynamic subtest smem: SUCCESS (1.163s) [386.428188] Subtest basic: SUCCESS (1.165s) [386.621747] [084/131] (644s left) kms_big_fb (x-tiled-8bpp-rotate-90) [386.715638] Starting subtest: x-tiled-8bpp-rotate-90 [386.736718] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s) [386.849403] [085/131] (644s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [386.904335] Starting subtest: mixed-tiled-to-y-tiled-ccs [386.906073] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [387.099665] [086/131] (643s left) kms_force_connector_basic (force-connector-state) [387.167055] Starting subtest: force-connector-state [387.779172] Subtest force-connector-state: SUCCESS (0.612s) [388.728877] [087/131] (642s left) kms_chamelium_edid (hdmi-mode-timings) [389.101875] Subtest hdmi-mode-timings: SKIP (0.000s) [389.879753] [088/131] (641s left) kms_dp_link_training (uhbr-mst) [389.968348] Starting subtest: uhbr-mst [389.971605] Subtest uhbr-mst: SKIP (0.000s) [390.041336] [089/131] (641s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [390.140368] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [390.141940] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [390.239743] [090/131] (640s left) syncobj_timeline (host-signal-ordered) [390.297682] Starting subtest: host-signal-ordered [390.298590] Subtest host-signal-ordered: SUCCESS (0.001s) [390.403426] [091/131] (640s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [390.502975] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [390.504926] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [390.596840] [092/131] (640s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [390.642283] Starting subtest: multi-wait-all-for-submit-available-signaled [390.643036] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [390.730206] [093/131] (640s left) kms_invalid_mode (uint-max-clock) [390.817360] Starting subtest: uint-max-clock [390.818163] Starting dynamic subtest: pipe-A-eDP-1 [391.103472] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [391.112811] Starting dynamic subtest: pipe-B-eDP-1 [391.113766] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [391.122271] Starting dynamic subtest: pipe-C-eDP-1 [391.123323] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [391.131817] Starting dynamic subtest: pipe-D-eDP-1 [391.132804] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [391.133694] Subtest uint-max-clock: SUCCESS (0.292s) [391.897306] [094/131] (639s left) prime_busy (before-wait) [391.953585] Starting subtest: before-wait [391.957007] Starting dynamic subtest: rcs0 [391.989165] Dynamic subtest rcs0: SUCCESS (0.032s) [392.000166] Starting dynamic subtest: bcs0 [392.028887] Dynamic subtest bcs0: SUCCESS (0.039s) [392.038203] Starting dynamic subtest: vcs0 [392.071637] Dynamic subtest vcs0: SUCCESS (0.042s) [392.088294] Starting dynamic subtest: vcs1 [392.113751] Dynamic subtest vcs1: SUCCESS (0.040s) [392.123631] Starting dynamic subtest: vecs0 [392.155054] Dynamic subtest vecs0: SUCCESS (0.041s) [392.163942] Starting dynamic subtest: ccs0 [392.196010] Dynamic subtest ccs0: SUCCESS (0.040s) [392.303624] Subtest before-wait: SUCCESS (0.349s) [392.388576] [095/131] (638s left) kms_setmode (invalid-clone-single-crtc-stealing) [392.432396] Starting subtest: invalid-clone-single-crtc-stealing [392.435083] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [392.518583] [096/131] (638s left) gem_exec_balancer (persistence) [392.782354] Starting subtest: persistence [393.748059] Subtest persistence: SUCCESS (0.965s) [393.854636] [097/131] (637s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [393.944651] Starting subtest: pr-primary-plane-update-sf-dmg-area [393.946450] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [394.013022] [098/131] (637s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [394.099751] Starting subtest: fbc-psr2-cursor-mmap-gtt [394.100638] Starting dynamic subtest: eDP-1 [394.102499] Dynamic subtest eDP-1: SKIP (0.000s) [394.104224] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s) [394.169036] [099/131] (637s left) syncobj_timeline (signal-array) [394.216363] Starting subtest: signal-array [394.217231] Subtest signal-array: SUCCESS (0.000s) [394.308948] [100/131] (637s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs) [394.395453] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs [394.396289] Starting dynamic subtest: pipe-A-eDP-1 [394.404135] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [394.413144] Starting dynamic subtest: pipe-B-eDP-1 [394.421111] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [394.430122] Starting dynamic subtest: pipe-C-eDP-1 [394.438057] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [394.446872] Starting dynamic subtest: pipe-D-eDP-1 [394.455267] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [394.456746] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s) [396.593363] [101/131] (634s left) kms_pm_rpm (cursor) [398.615020] Starting subtest: cursor [398.617791] Subtest cursor: SKIP (0.000s) [398.986251] [102/131] (632s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [399.077399] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [402.656345] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.578s) [403.805443] [103/131] (627s left) kms_cursor_crc (cursor-rapid-movement-32x32) [403.952876] Starting subtest: cursor-rapid-movement-32x32 [403.997360] Subtest cursor-rapid-movement-32x32: SKIP (0.043s) [404.287326] [104/131] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [404.379339] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [404.380994] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [404.496029] [105/131] (627s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [404.557812] Starting subtest: map-fixed-invalidate-overlap-busy [404.569421] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [404.679567] [106/131] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [404.765706] Starting subtest: fbcpsr-1p-rte [411.742204] Subtest fbcpsr-1p-rte: SUCCESS (6.976s) [411.887423] [107/131] (619s left) kms_big_fb (linear-16bpp-rotate-180) [411.995891] Starting subtest: linear-16bpp-rotate-180 [413.418936] Subtest linear-16bpp-rotate-180: SUCCESS (1.423s) [413.565269] [108/131] (618s left) kms_vblank (wait-busy) [413.650500] Starting subtest: wait-busy [413.651547] Starting dynamic subtest: pipe-A-eDP-1 [415.526530] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s) [415.537270] Starting dynamic subtest: pipe-D-eDP-1 [418.142986] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.613s) [418.143947] Subtest wait-busy: SUCCESS (4.491s) [419.006076] [109/131] (612s left) drm_read (short-buffer-nonblock) [419.144039] Starting subtest: short-buffer-nonblock [419.145091] Subtest short-buffer-nonblock: SUCCESS (0.000s) [419.279317] [110/131] (612s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [419.361406] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [419.362373] Starting dynamic subtest: pipe-A-eDP-1 [419.370908] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [419.380497] Starting dynamic subtest: pipe-B-eDP-1 [419.389048] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [419.398540] Starting dynamic subtest: pipe-C-eDP-1 [419.406925] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [419.415945] Starting dynamic subtest: pipe-D-eDP-1 [419.424270] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [419.425830] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.005s) [421.615053] [111/131] (610s left) gem_ctx_freq (sysfs) [421.678787] Starting subtest: sysfs [421.679975] Starting dynamic subtest: gt0 [427.180937] Dynamic subtest gt0: SUCCESS (5.501s) [427.194690] Starting dynamic subtest: gt1 [468.410037] Dynamic subtest gt1: SUCCESS (41.225s) [468.411165] Subtest sysfs: SUCCESS (46.730s) [468.513227] [112/131] (563s left) gem_exec_flush (basic-uc-ro-default) [468.567038] Starting subtest: basic-uc-ro-default [474.027014] Subtest basic-uc-ro-default: SUCCESS (5.461s) [474.209928] [113/131] (557s left) gem_exec_balancer (fairslice) [474.278157] Starting subtest: fairslice [477.257827] Subtest fairslice: SUCCESS (2.970s) [477.583373] [114/131] (554s left) gem_sync (basic-store-each) [477.652455] Starting subtest: basic-store-each [480.154699] Subtest basic-store-each: SUCCESS (2.501s) [480.339416] [115/131] (551s left) kms_content_protection (mei-interface) [480.489541] Starting subtest: mei-interface [480.491348] Subtest mei-interface: SKIP (0.001s) [480.611147] [116/131] (551s left) kms_flip (dpms-off-confusion) [480.694247] Starting subtest: dpms-off-confusion [480.696314] Starting dynamic subtest: A-eDP1 [489.394043] Dynamic subtest A-eDP1: SUCCESS (8.670s) [489.405943] Starting dynamic subtest: B-eDP1 [498.083699] Dynamic subtest B-eDP1: SUCCESS (8.689s) [498.095338] Starting dynamic subtest: C-eDP1 [506.784314] Dynamic subtest C-eDP1: SUCCESS (8.685s) [506.794800] Starting dynamic subtest: D-eDP1 [515.489039] Dynamic subtest D-eDP1: SUCCESS (8.702s) [515.490121] Subtest dpms-off-confusion: SUCCESS (34.759s) [516.694616] [117/131] (515s left) perf_pmu (init-wait) [516.733571] Starting subtest: init-wait [516.734448] Starting dynamic subtest: rcs0 [516.735298] Dynamic subtest rcs0: SUCCESS (0.001s) [516.745497] Starting dynamic subtest: bcs0 [516.746305] Dynamic subtest bcs0: SUCCESS (0.000s) [516.754604] Starting dynamic subtest: vcs0 [516.755471] Dynamic subtest vcs0: SUCCESS (0.001s) [516.766014] Starting dynamic subtest: vcs1 [516.766898] Dynamic subtest vcs1: SUCCESS (0.001s) [516.775428] Starting dynamic subtest: vecs0 [516.776307] Dynamic subtest vecs0: SUCCESS (0.001s) [516.784838] Starting dynamic subtest: ccs0 [516.785667] Dynamic subtest ccs0: SUCCESS (0.000s) [516.786453] Subtest init-wait: SUCCESS (0.007s) [516.852476] [118/131] (515s left) syncobj_basic (bad-pad-handle-to-fd) [516.907005] Starting subtest: bad-pad-handle-to-fd [516.907942] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [517.015604] [119/131] (515s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [517.102573] Starting subtest: yf-tiled-8bpp-rotate-180 [517.104367] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [517.185289] [120/131] (514s left) gem_exec_params (cliprects-invalid) [517.235469] Starting subtest: cliprects-invalid [517.236529] Subtest cliprects-invalid: SUCCESS (0.000s) [517.328141] [121/131] (514s left) sysfs_timeslice_duration (idempotent) [517.388110] Starting subtest: idempotent [517.389024] Starting dynamic subtest: vecs0 [517.389872] Dynamic subtest vecs0: SUCCESS (0.000s) [517.398739] Starting dynamic subtest: ccs0 [517.399590] Dynamic subtest ccs0: SUCCESS (0.000s) [517.408035] Starting dynamic subtest: vcs0 [517.408895] Dynamic subtest vcs0: SUCCESS (0.000s) [517.417606] Starting dynamic subtest: bcs0 [517.418476] Dynamic subtest bcs0: SUCCESS (0.000s) [517.427065] Starting dynamic subtest: rcs0 [517.427939] Dynamic subtest rcs0: SUCCESS (0.000s) [517.436609] Starting dynamic subtest: vcs1 [517.437725] Dynamic subtest vcs1: SUCCESS (0.000s) [517.438723] Subtest idempotent: SUCCESS (0.007s) [517.508037] [122/131] (514s left) kms_big_fb (y-tiled-8bpp-rotate-0) [517.597725] Starting subtest: y-tiled-8bpp-rotate-0 [517.599477] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [517.686932] [123/131] (514s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [517.782680] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [517.784405] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [517.852455] [124/131] (514s left) gem_mmap_gtt (hang-user) [517.912003] Subtest hang-user: SKIP (0.000s) [517.972134] [125/131] (514s left) gem_userptr_blits (sync-unmap-cycles) [518.037446] Starting subtest: sync-unmap-cycles [523.415371] Subtest sync-unmap-cycles: SUCCESS (5.376s) [523.554298] [126/131] (508s left) gem_spin_batch (engines) [523.607403] Starting subtest: engines [523.608301] Starting dynamic subtest: rcs0 [526.892793] Dynamic subtest rcs0: SUCCESS (3.239s) [526.904577] Starting dynamic subtest: bcs0 [530.129776] Dynamic subtest bcs0: SUCCESS (3.233s) [530.141050] Starting dynamic subtest: vcs0 [533.369378] Dynamic subtest vcs0: SUCCESS (3.236s) [533.380541] Starting dynamic subtest: vcs1 [536.607479] Dynamic subtest vcs1: SUCCESS (3.235s) [536.618574] Starting dynamic subtest: vecs0 [539.847452] Dynamic subtest vecs0: SUCCESS (3.237s) [539.858421] Starting dynamic subtest: ccs0 [543.086918] Dynamic subtest ccs0: SUCCESS (3.236s) [543.088451] Subtest engines: SUCCESS (19.433s) [543.282454] [127/131] (489s left) gem_userptr_blits (forbidden-operations) [543.341739] Starting subtest: forbidden-operations [543.343712] Subtest forbidden-operations: SKIP (0.000s) [543.459590] [128/131] (489s left) kms_fbcon_fbt (fbc) [543.503923] Starting subtest: fbc [549.923927] Subtest fbc: SUCCESS (6.412s) [551.083266] [129/131] (481s left) gem_exec_schedule (promotion) [551.136072] Starting subtest: promotion [551.137257] Starting dynamic subtest: rcs0 [551.257449] Dynamic subtest rcs0: SUCCESS (0.120s) [551.271080] Starting dynamic subtest: vcs0 [551.340438] Dynamic subtest vcs0: SUCCESS (0.083s) [551.351544] Starting dynamic subtest: vcs1 [551.420939] Dynamic subtest vcs1: SUCCESS (0.079s) [551.437566] Starting dynamic subtest: vecs0 [551.511823] Dynamic subtest vecs0: SUCCESS (0.089s) [551.524928] Starting dynamic subtest: ccs0 [551.598991] Dynamic subtest ccs0: SUCCESS (0.087s) [551.600607] Subtest promotion: SUCCESS (0.463s) [552.518635] [130/131] (480s left) syncobj_wait (wait-all-complex) [552.567439] Starting subtest: wait-all-complex [552.792183] Subtest wait-all-complex: SUCCESS (0.216s) [552.857212] [131/131] (479s left) gem_exec_params (readonly) [552.898531] Starting subtest: readonly [552.901022] Subtest readonly: SUCCESS (0.002s) [553.010158] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: i915_pm_rpm results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_plane results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: gem_vm_create results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_pipe_stress results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_pipe_control_store_loop results: parsing output: 11/ for test: i915_drm_fdinfo results: parsing output: 12/ for test: gem_mmap_gtt results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_lease results: parsing output: 15/ for test: gem_ctx_persistence results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: i915_pm_rps results: parsing output: 18/ for test: perf results: parsing output: 19/ for test: kms_rotation_crc results: parsing output: 20/ for test: gem_ctx_shared results: parsing output: 21/ for test: gem_readwrite results: parsing output: 22/ for test: kms_panel_fitting results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: gem_mmap_wc results: parsing output: 26/ for test: kms_chamelium_hpd results: parsing output: 27/ for test: kms_selftest results: parsing output: 28/ for test: gem_exec_reloc results: parsing output: 29/ for test: syncobj_eventfd results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: gem_exec_flush results: parsing output: 32/ for test: kms_ccs results: parsing output: 33/ for test: kms_plane_scaling results: parsing output: 34/ for test: kms_color results: parsing output: 35/ for test: gem_softpin results: parsing output: 36/ for test: i915_fb_tiling results: parsing output: 37/ for test: gem_exec_whisper results: parsing output: 38/ for test: gem_exec_params results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: gem_exec_reloc results: parsing output: 42/ for test: kms_psr results: parsing output: 43/ for test: kms_hdr results: parsing output: 44/ for test: kms_cursor_edge_walk results: parsing output: 45/ for test: gem_exec_fence results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: syncobj_wait results: parsing output: 48/ for test: kms_cursor_crc results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_exec_params results: parsing output: 51/ for test: gem_exec_schedule results: parsing output: 52/ for test: api_intel_allocator results: parsing output: 53/ for test: gen9_exec_parse results: parsing output: 54/ for test: gem_exec_flush results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: gem_readwrite results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: gem_ctx_engines results: parsing output: 59/ for test: kms_flip results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: gem_huc_copy results: parsing output: 62/ for test: kms_flip_scaled_crc results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_feature_discovery results: parsing output: 65/ for test: gem_exec_reloc results: parsing output: 66/ for test: device_reset results: parsing output: 67/ for test: gem_busy results: parsing output: 68/ for test: kms_cursor_legacy results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_psr2_sf results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_plane results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_plane_multiple results: parsing output: 78/ for test: kms_psr2_sf results: parsing output: 79/ for test: sw_sync results: parsing output: 80/ for test: api_intel_bb results: parsing output: 81/ for test: kms_chamelium_color results: parsing output: 82/ for test: gem_exec_suspend results: parsing output: 83/ for test: kms_big_fb results: parsing output: 84/ for test: gem_render_copy results: parsing output: 85/ for test: kms_force_connector_basic results: parsing output: 86/ for test: kms_chamelium_edid results: parsing output: 87/ for test: kms_dp_link_training results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: syncobj_timeline results: parsing output: 90/ for test: kms_big_fb results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: kms_invalid_mode results: parsing output: 93/ for test: prime_busy results: parsing output: 94/ for test: kms_setmode results: parsing output: 95/ for test: gem_exec_balancer results: parsing output: 96/ for test: kms_psr2_sf results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: syncobj_timeline results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: kms_pm_rpm results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_cursor_crc results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_userptr_blits results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: kms_vblank results: parsing output: 108/ for test: drm_read results: parsing output: 109/ for test: kms_ccs results: parsing output: 110/ for test: gem_ctx_freq results: parsing output: 111/ for test: gem_exec_flush results: parsing output: 112/ for test: gem_exec_balancer results: parsing output: 113/ for test: gem_sync results: parsing output: 114/ for test: kms_content_protection results: parsing output: 115/ for test: kms_flip results: parsing output: 116/ for test: perf_pmu results: parsing output: 117/ for test: syncobj_basic results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: gem_exec_params results: parsing output: 120/ for test: sysfs_timeslice_duration results: parsing output: 121/ for test: kms_big_fb results: parsing output: 122/ for test: kms_flip_scaled_crc results: parsing output: 123/ for test: gem_mmap_gtt results: parsing output: 124/ for test: gem_userptr_blits results: parsing output: 125/ for test: gem_spin_batch results: parsing output: 126/ for test: gem_userptr_blits results: parsing output: 127/ for test: kms_fbcon_fbt results: parsing output: 128/ for test: gem_exec_schedule results: parsing output: 129/ for test: syncobj_wait results: parsing output: 130/ for test: gem_exec_params Done.