[56.579479] Initializing watchdogs [56.579524] /dev/watchdog0 [56.593185] [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] [56.597447] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.599793] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.603212] [001/132] (960s left) api_intel_bb (object-reloc-keep-cache) [56.689924] Starting subtest: object-reloc-keep-cache [56.694613] Subtest object-reloc-keep-cache: SKIP (0.003s) [56.847801] [002/132] (960s left) gem_gpgpu_fill (basic) [56.906911] Starting subtest: basic [56.909224] Starting dynamic subtest: smem [56.917860] Dynamic subtest smem: SUCCESS (0.012s) [56.920150] Subtest basic: SUCCESS (0.012s) [57.073692] [003/132] (960s left) gem_pread (bench) [57.124157] Subtest bench: SKIP (0.000s) [57.184555] [004/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [57.297159] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [57.301360] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [57.428147] [005/132] (959s left) kms_chamelium_audio (dp-audio-edid) [57.823542] Subtest dp-audio-edid: SKIP (0.000s) [58.678782] [006/132] (958s left) kms_vblank (wait-busy-hang) [58.784063] Starting subtest: wait-busy-hang [58.786197] Starting dynamic subtest: pipe-A-eDP-1 [85.724750] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.939s) [85.737920] Starting dynamic subtest: pipe-D-eDP-1 [110.676299] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.950s) [110.678615] Subtest wait-busy-hang: SUCCESS (51.893s) [111.497415] [007/132] (905s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [111.596850] Starting subtest: planes-downscale-factor-0-75-unity-scaling [111.599210] Starting dynamic subtest: pipe-A [111.660882] Dynamic subtest pipe-A: SUCCESS (0.065s) [111.675617] Starting dynamic subtest: pipe-B [112.816769] Dynamic subtest pipe-B: SUCCESS (1.156s) [112.826568] Starting dynamic subtest: pipe-C [113.927076] Dynamic subtest pipe-C: SUCCESS (1.110s) [113.936092] Starting dynamic subtest: pipe-D [115.063575] Dynamic subtest pipe-D: SUCCESS (1.135s) [115.066594] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.469s) [116.240388] [008/132] (901s left) gem_mmap_gtt (isolation) [116.298319] Subtest isolation: SKIP (0.000s) [116.366871] [009/132] (901s left) kms_flip (basic-flip-vs-wf_vblank) [116.469020] Starting subtest: basic-flip-vs-wf_vblank [116.471033] Starting dynamic subtest: A-eDP1 [118.387673] Dynamic subtest A-eDP1: SUCCESS (1.920s) [118.394813] Starting dynamic subtest: B-eDP1 [120.320031] Dynamic subtest B-eDP1: SUCCESS (1.931s) [120.333302] Starting dynamic subtest: C-eDP1 [122.241948] Dynamic subtest C-eDP1: SUCCESS (1.920s) [122.251255] Starting dynamic subtest: D-eDP1 [124.172245] Dynamic subtest D-eDP1: SUCCESS (1.929s) [124.177522] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.711s) [125.411438] [010/132] (892s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [125.525501] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [126.469394] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.945s) [126.631400] [011/132] (890s left) kms_psr (psr2-basic) [126.730867] Starting subtest: psr2-basic [126.732768] Starting dynamic subtest: eDP-1 [128.371419] Dynamic subtest eDP-1: SUCCESS (1.639s) [128.373693] Subtest psr2-basic: SUCCESS (1.639s) [129.187712] [012/132] (888s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [129.289524] Starting subtest: fbc-farfromfence-mmap-gtt [129.294028] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [129.419895] [013/132] (888s left) gen9_exec_parse (batch-zero-length) [129.491768] Subtest batch-zero-length: SKIP (0.000s) [129.563341] [014/132] (888s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [129.657807] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [129.660350] Starting dynamic subtest: pipe-A-eDP-1 [129.684728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s) [129.698904] Starting dynamic subtest: pipe-B-eDP-1 [129.719711] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s) [129.733988] Starting dynamic subtest: pipe-C-eDP-1 [129.755239] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s) [129.770528] Starting dynamic subtest: pipe-D-eDP-1 [129.791158] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s) [129.793433] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s) [132.051145] [015/132] (885s left) i915_pm_rpm (reg-read-ioctl) [134.088233] Starting subtest: reg-read-ioctl [136.370454] Subtest reg-read-ioctl: SUCCESS (2.285s) [136.765346] [016/132] (880s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [136.820974] Starting subtest: multi-wait-all-for-submit-unsubmitted [136.929274] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s) [137.028104] [017/132] (880s left) kms_scaling_modes (scaling-mode-full) [137.105364] Starting subtest: scaling-mode-full [137.107813] Starting dynamic subtest: pipe-A-eDP-1 [137.198257] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.092s) [137.207863] Starting dynamic subtest: pipe-B-eDP-1 [138.371632] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.173s) [138.380342] Starting dynamic subtest: pipe-C-eDP-1 [139.481727] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s) [139.490600] Starting dynamic subtest: pipe-D-eDP-1 [140.614581] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s) [140.616989] Subtest scaling-mode-full: SUCCESS (3.510s) [141.901219] [018/132] (875s left) gem_flink_basic (bad-open) [141.961983] Starting subtest: bad-open [141.964032] Subtest bad-open: SUCCESS (0.000s) [142.099235] [019/132] (875s left) gem_mmap_gtt (big-copy) [142.161141] Subtest big-copy: SKIP (0.000s) [142.228986] [020/132] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [142.337380] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [149.372618] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.038s) [149.508971] [021/132] (868s left) gem_exec_fence (syncobj-signal) [149.952977] Starting subtest: syncobj-signal [149.958112] Subtest syncobj-signal: SUCCESS (0.005s) [152.015531] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true [152.018637] [022/132] (865s left) gem_tiled_blits (normal) [152.080600] Subtest normal: SKIP (0.000s) [152.169285] [023/132] (865s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [157.220201] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [157.222547] Starting dynamic subtest: pipe-A-eDP-1 [158.004814] Dynamic subtest pipe-A-eDP-1: SKIP (0.782s) [158.015938] Starting dynamic subtest: pipe-B-eDP-1 [159.135346] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s) [159.139787] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.914s) [160.376943] [024/132] (857s left) kms_color (ctm-0-50) [160.498097] Starting subtest: ctm-0-50 [160.499972] Starting dynamic subtest: pipe-A-eDP-1 [163.935821] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.437s) [163.944649] Starting dynamic subtest: pipe-B-eDP-1 [168.045526] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.111s) [168.059851] Starting dynamic subtest: pipe-C-eDP-1 [172.099483] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.052s) [172.111216] Starting dynamic subtest: pipe-D-eDP-1 [176.084745] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.986s) [176.087081] Subtest ctm-0-50: SUCCESS (15.587s) [176.931205] [025/132] (841s left) gem_exec_params (no-bsd) [177.000308] Starting subtest: no-bsd [177.005283] Subtest no-bsd: SUCCESS (0.002s) [178.979425] [026/132] (839s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [179.087785] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [186.434505] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.349s) [186.591838] [027/132] (831s left) gem_exec_flush (basic-uc-rw-default) [186.661069] Starting subtest: basic-uc-rw-default [192.133024] Subtest basic-uc-rw-default: SUCCESS (5.472s) [192.346196] [028/132] (825s left) perf (create-destroy-userspace-config) [192.482897] Starting subtest: create-destroy-userspace-config [192.501809] Subtest create-destroy-userspace-config: SUCCESS (0.017s) [192.538179] [029/132] (825s left) kms_atomic (test-only) [192.634983] Starting subtest: test-only [192.683664] Starting dynamic subtest: pipe-A-eDP-1 [195.222901] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.540s) [195.225271] Subtest test-only: SUCCESS (2.589s) [196.053277] [030/132] (822s left) perf_pmu (most-busy-check-all) [196.095541] Starting subtest: most-busy-check-all [196.097457] Starting dynamic subtest: rcs0 [197.911166] Dynamic subtest rcs0: SUCCESS (1.815s) [197.924548] Starting dynamic subtest: bcs0 [199.893522] Dynamic subtest bcs0: SUCCESS (1.980s) [199.902816] Starting dynamic subtest: vcs0 [201.877375] Dynamic subtest vcs0: SUCCESS (1.981s) [201.887636] Starting dynamic subtest: vcs1 [203.924352] Dynamic subtest vcs1: SUCCESS (2.044s) [203.933863] Starting dynamic subtest: vecs0 [205.909289] Dynamic subtest vecs0: SUCCESS (1.983s) [205.919611] Starting dynamic subtest: ccs0 [207.893577] Dynamic subtest ccs0: SUCCESS (1.982s) [207.896125] Subtest most-busy-check-all: SUCCESS (11.799s) [208.034692] [031/132] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [208.134404] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [208.138705] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [208.243236] [032/132] (810s left) sysfs_preempt_timeout (invalid) [208.292420] Starting subtest: invalid [208.294613] Starting dynamic subtest: vecs0 [208.296886] Dynamic subtest vecs0: SUCCESS (0.000s) [208.306708] Starting dynamic subtest: ccs0 [208.308586] Dynamic subtest ccs0: SUCCESS (0.000s) [208.316400] Starting dynamic subtest: vcs0 [208.318290] Dynamic subtest vcs0: SUCCESS (0.000s) [208.326064] Starting dynamic subtest: bcs0 [208.327995] Dynamic subtest bcs0: SUCCESS (0.000s) [208.336438] Starting dynamic subtest: rcs0 [208.338582] Dynamic subtest rcs0: SUCCESS (0.000s) [208.346077] Starting dynamic subtest: vcs1 [208.348184] Dynamic subtest vcs1: SUCCESS (0.000s) [208.350321] Subtest invalid: SUCCESS (0.005s) [208.436342] [033/132] (809s left) gem_ctx_persistence (heartbeat-many) [208.495156] Starting subtest: heartbeat-many [208.500019] Subtest heartbeat-many: SKIP (0.000s) [208.639885] [034/132] (809s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [208.703189] Starting subtest: mixed-tiled-to-yf-tiled-ccs [208.707972] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [208.910704] [035/132] (809s left) gem_exec_capture (capture) [208.978243] Starting subtest: capture [208.980785] Starting dynamic subtest: rcs0-smem [209.790806] Dynamic subtest rcs0-smem: SUCCESS (0.812s) [209.798963] Starting dynamic subtest: bcs0-smem [210.596083] Dynamic subtest bcs0-smem: SUCCESS (0.805s) [210.606313] Starting dynamic subtest: vcs0-smem [211.403571] Dynamic subtest vcs0-smem: SUCCESS (0.806s) [211.411629] Starting dynamic subtest: vcs1-smem [212.722249] Dynamic subtest vcs1-smem: SUCCESS (1.319s) [212.730284] Starting dynamic subtest: vecs0-smem [213.621093] Dynamic subtest vecs0-smem: FAIL (0.838s) [213.630918] Starting dynamic subtest: ccs0-smem [214.880673] Dynamic subtest ccs0-smem: SUCCESS (1.320s) [214.883390] Subtest capture: FAIL (5.903s) [215.055868] [036/132] (803s left) kms_plane_lowres (tiling-4) [215.159704] Starting subtest: tiling-4 [215.161800] Starting dynamic subtest: pipe-A-eDP-1 [215.166276] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [215.459998] Starting dynamic subtest: pipe-B-eDP-1 [215.464961] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [215.473320] Starting dynamic subtest: pipe-C-eDP-1 [215.478051] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [215.486371] Starting dynamic subtest: pipe-D-eDP-1 [215.491078] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [215.495270] Subtest tiling-4: SKIP (0.299s) [216.284058] [037/132] (802s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [216.389148] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [216.391428] Starting dynamic subtest: pipe-A-default-mode [216.676213] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [216.681196] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.286s) [217.509327] [038/132] (801s left) kms_big_fb (y-tiled-8bpp-rotate-270) [217.614121] Starting subtest: y-tiled-8bpp-rotate-270 [217.618663] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [217.754185] [039/132] (800s left) kms_addfb_basic (basic) [217.806961] Starting subtest: basic [217.809185] Subtest basic: SUCCESS (0.000s) [217.984369] [040/132] (800s left) kms_psr (psr2-sprite-mmap-gtt) [218.089763] Starting subtest: psr2-sprite-mmap-gtt [218.092030] Starting dynamic subtest: eDP-1 [219.487520] Dynamic subtest eDP-1: SKIP (1.395s) [219.492072] Subtest psr2-sprite-mmap-gtt: SKIP (1.397s) [219.710592] [041/132] (798s left) gem_exec_reloc (basic-gtt-noreloc) [219.782251] Subtest basic-gtt-noreloc: SKIP (0.000s) [219.871971] [042/132] (798s left) gem_mmap_gtt (basic-read-write) [219.933022] Subtest basic-read-write: SKIP (0.000s) [220.005954] [043/132] (798s left) gem_exec_reloc (basic-wc-read-noreloc) [220.066366] Subtest basic-wc-read-noreloc: SKIP (0.000s) [220.147596] [044/132] (798s left) gem_exec_parallel (userptr) [220.217140] Starting subtest: userptr [220.219499] Starting dynamic subtest: rcs0 [221.658782] Dynamic subtest rcs0: SUCCESS (1.441s) [221.667190] Starting dynamic subtest: bcs0 [223.112334] Dynamic subtest bcs0: SUCCESS (1.452s) [223.123260] Starting dynamic subtest: vcs0 [224.915470] Dynamic subtest vcs0: SUCCESS (1.800s) [224.925058] Starting dynamic subtest: vcs1 [226.836518] Dynamic subtest vcs1: SUCCESS (1.918s) [226.848066] Starting dynamic subtest: vecs0 [228.884303] Dynamic subtest vecs0: SUCCESS (2.045s) [228.894828] Starting dynamic subtest: ccs0 [230.375062] Dynamic subtest ccs0: SUCCESS (1.490s) [230.377439] Subtest userptr: SUCCESS (10.159s) [230.590544] [045/132] (788s left) kms_properties (plane-properties-atomic) [230.689931] Starting subtest: plane-properties-atomic [230.692151] Starting dynamic subtest: pipe-A-eDP-1 [231.240250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s) [231.248560] Starting dynamic subtest: pipe-B-eDP-1 [232.483885] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s) [232.497174] Starting dynamic subtest: pipe-C-eDP-1 [233.729291] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.244s) [233.739221] Starting dynamic subtest: pipe-D-eDP-1 [234.967409] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s) [234.969798] Subtest plane-properties-atomic: SUCCESS (4.277s) [235.778670] [046/132] (783s left) prime_mmap (test_map_unmap) [235.835281] Starting subtest: test_map_unmap [235.837522] Starting dynamic subtest: test_map_unmap-smem [235.864776] Dynamic subtest test_map_unmap-smem: SUCCESS (0.029s) [235.867054] Subtest test_map_unmap: SUCCESS (0.029s) [236.011141] [047/132] (782s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [236.122069] Starting subtest: cursor-tearing-framebuffer-change [236.123922] Starting dynamic subtest: pipe-A-eDP-1 [236.717435] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s) [236.727200] Starting dynamic subtest: pipe-D-eDP-1 [237.911532] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.192s) [237.913720] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.789s) [238.761220] [048/132] (780s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [238.865982] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [238.873288] Starting dynamic subtest: pipe-A-default-mode [240.000197] Dynamic subtest pipe-A-default-mode: SKIP (1.130s) [240.004768] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.133s) [240.193416] [049/132] (778s left) i915_query (test-query-geometry-subslices) [240.258527] Starting subtest: test-query-geometry-subslices [240.260638] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [240.389846] [050/132] (778s left) syncobj_timeline (invalid-query-illegal-handle) [240.439411] Starting subtest: invalid-query-illegal-handle [240.441586] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [240.584147] [051/132] (778s left) kms_hdr (static-toggle) [240.682755] Starting subtest: static-toggle [240.689675] Subtest static-toggle: SKIP (0.000s) [240.810639] [052/132] (778s left) sw_sync (sync_multi_consumer) [240.851964] Starting subtest: sync_multi_consumer [241.290166] Subtest sync_multi_consumer: SUCCESS (0.439s) [241.373614] [053/132] (777s left) kms_psr (fbc-psr-sprite-plane-onoff) [241.474980] Starting subtest: fbc-psr-sprite-plane-onoff [241.477297] Starting dynamic subtest: eDP-1 [241.481618] Dynamic subtest eDP-1: SKIP (0.000s) [241.485938] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s) [241.569092] [054/132] (777s left) gem_userptr_blits (sd-probe) [241.639303] Starting subtest: sd-probe [241.641525] Subtest sd-probe: SUCCESS (0.000s) [241.818779] [055/132] (777s left) gem_eio (wait-immediate) [242.035646] Starting subtest: wait-immediate [242.409567] Subtest wait-immediate: SUCCESS (0.375s) [242.602060] [056/132] (776s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [242.718304] Starting subtest: psr-rgb565-draw-render [249.709898] Subtest psr-rgb565-draw-render: SUCCESS (6.992s) [249.855332] [057/132] (769s left) perf_pmu (event-wait) [249.899693] Starting subtest: event-wait [249.901993] Starting dynamic subtest: rcs0 [249.906450] Dynamic subtest rcs0: SKIP (0.000s) [249.910855] Subtest event-wait: SKIP (0.001s) [250.034975] [058/132] (769s left) gem_exec_schedule (smoketest) [250.218195] Starting subtest: smoketest [250.220325] Starting dynamic subtest: rcs0 [255.764207] Dynamic subtest rcs0: SUCCESS (5.496s) [255.774581] Starting dynamic subtest: bcs0 [261.309480] Dynamic subtest bcs0: SUCCESS (5.538s) [261.324292] Starting dynamic subtest: vcs0 [266.814394] Dynamic subtest vcs0: SUCCESS (5.510s) [266.824325] Starting dynamic subtest: vcs1 [272.311776] Dynamic subtest vcs1: SUCCESS (5.497s) [272.322442] Starting dynamic subtest: vecs0 [277.811147] Dynamic subtest vecs0: SUCCESS (5.501s) [277.821211] Starting dynamic subtest: ccs0 [283.345584] Dynamic subtest ccs0: SUCCESS (5.531s) [283.347700] Subtest smoketest: SUCCESS (33.079s) [283.509220] [059/132] (735s left) gem_userptr_blits (map-fixed-invalidate-busy) [283.586034] Starting subtest: map-fixed-invalidate-busy [283.590464] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [283.742918] [060/132] (735s left) kms_busy (basic) [283.847864] Starting subtest: basic [283.849779] Starting dynamic subtest: flip [284.440072] Dynamic subtest flip: SUCCESS (0.593s) [284.449180] Starting dynamic subtest: modeset [287.834029] Dynamic subtest modeset: SUCCESS (3.392s) [287.836192] Subtest basic: SUCCESS (3.987s) [288.664801] [061/132] (730s left) kms_universal_plane (universal-plane-sanity) [288.765876] Starting subtest: universal-plane-sanity [288.768133] Starting dynamic subtest: pipe-A-eDP-1 [289.354115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s) [289.362783] Starting dynamic subtest: pipe-B-eDP-1 [290.570983] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.217s) [290.579947] Starting dynamic subtest: pipe-C-eDP-1 [291.794196] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.221s) [291.803152] Starting dynamic subtest: pipe-D-eDP-1 [293.019225] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s) [293.021508] Subtest universal-plane-sanity: SUCCESS (4.255s) [293.892016] [062/132] (725s left) kms_flip (flip-vs-panning-interruptible) [293.995219] Starting subtest: flip-vs-panning-interruptible [293.997572] Starting dynamic subtest: A-eDP1 [302.687043] Dynamic subtest A-eDP1: SUCCESS (8.690s) [302.698450] Starting dynamic subtest: B-eDP1 [311.422761] Dynamic subtest B-eDP1: SUCCESS (8.732s) [311.432077] Starting dynamic subtest: C-eDP1 [320.139934] Dynamic subtest C-eDP1: SUCCESS (8.715s) [320.149615] Starting dynamic subtest: D-eDP1 [328.872578] Dynamic subtest D-eDP1: SUCCESS (8.731s) [328.874682] Subtest flip-vs-panning-interruptible: SUCCESS (34.878s) [330.164912] [063/132] (689s left) kms_addfb_basic (legacy-format) [330.238865] Starting subtest: legacy-format [330.266361] Subtest legacy-format: SUCCESS (0.026s) [330.444282] [064/132] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [330.546060] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [330.549809] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [330.690247] [065/132] (689s left) gem_exec_flush (basic-uc-set-default) [330.757774] Starting subtest: basic-uc-set-default [336.205533] Subtest basic-uc-set-default: SUCCESS (5.448s) [336.421069] [066/132] (683s left) gem_ctx_exec (basic-invalid-context) [336.482578] Starting subtest: basic-invalid-context [336.489046] Subtest basic-invalid-context: SUCCESS (0.008s) [336.652226] [067/132] (683s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [336.759893] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [341.199883] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.445s) [342.380183] [068/132] (677s left) gem_close (many-handles-one-vma) [342.449369] Starting subtest: many-handles-one-vma [342.472732] Subtest many-handles-one-vma: SUCCESS (0.024s) [342.636955] [069/132] (677s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [342.737191] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [342.739470] Starting dynamic subtest: pipe-A-eDP-1 [342.761994] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [342.773607] Starting dynamic subtest: pipe-B-eDP-1 [342.794747] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [342.803313] Starting dynamic subtest: pipe-C-eDP-1 [342.825238] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [342.834567] Starting dynamic subtest: pipe-D-eDP-1 [342.858093] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [342.862704] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [344.914265] [070/132] (675s left) gem_exec_suspend (basic-s0) [344.986011] Starting subtest: basic-S0 [344.988410] Starting dynamic subtest: smem [364.838623] Dynamic subtest smem: SUCCESS (8.888s) [364.841340] Subtest basic-S0: SUCCESS (8.890s) [365.051468] [071/132] (654s left) syncobj_eventfd (invalid-illegal-handle) [365.127076] Starting subtest: invalid-illegal-handle [365.129419] Subtest invalid-illegal-handle: SUCCESS (0.000s) [365.273911] [072/132] (654s left) gem_exec_reloc (basic-write-read-active) [365.330602] Subtest basic-write-read-active: SKIP (0.000s) [365.418425] [073/132] (654s left) sw_sync (sync_merge_same) [365.457762] Starting subtest: sync_merge_same [365.459638] Subtest sync_merge_same: SUCCESS (0.000s) [365.539110] [074/132] (654s left) kms_prime (basic-crc-vgem) [365.626960] Starting subtest: basic-crc-vgem [365.629187] Starting dynamic subtest: second-to-first [366.613387] Dynamic subtest second-to-first: SUCCESS (0.988s) [366.615863] Subtest basic-crc-vgem: SUCCESS (0.990s) [366.733817] [075/132] (653s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [366.874193] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [373.415482] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.537s) [373.612639] [076/132] (646s left) prime_self_import (basic-llseek-size) [373.647650] Starting subtest: basic-llseek-size [373.673375] Subtest basic-llseek-size: SUCCESS (0.028s) [373.818800] [077/132] (646s left) gem_ctx_sseu (engines) [373.888308] Subtest engines: SKIP (0.000s) [373.957123] [078/132] (646s left) kms_cursor_crc (cursor-onscreen-max-size) [374.270199] Starting subtest: cursor-onscreen-max-size [374.276799] Subtest cursor-onscreen-max-size: SKIP (0.000s) [374.424511] [079/132] (645s left) syncobj_timeline (transfer-timeline-point) [374.487585] Starting subtest: transfer-timeline-point [374.489642] Subtest transfer-timeline-point: SUCCESS (0.000s) [374.625892] [080/132] (645s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [374.688845] Starting subtest: etime-single-wait-all-for-submit-submitted [374.791136] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.102s) [374.906452] [081/132] (645s left) gem_bad_reloc (negative-reloc) [374.963277] Subtest negative-reloc: SKIP (0.000s) [375.058740] [082/132] (645s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [375.117227] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [375.119245] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [375.261295] [083/132] (645s left) i915_drm_fdinfo (idle) [375.295506] Starting subtest: idle [375.297528] Starting dynamic subtest: rcs0 [375.914483] Dynamic subtest rcs0: SUCCESS (0.618s) [375.926869] Starting dynamic subtest: bcs0 [376.421245] Dynamic subtest bcs0: SUCCESS (0.503s) [376.433185] Starting dynamic subtest: vcs0 [376.927304] Dynamic subtest vcs0: SUCCESS (0.503s) [376.939853] Starting dynamic subtest: vcs1 [377.432593] Dynamic subtest vcs1: SUCCESS (0.503s) [377.444601] Starting dynamic subtest: vecs0 [377.938886] Dynamic subtest vecs0: SUCCESS (0.503s) [377.951668] Starting dynamic subtest: ccs0 [378.447086] Dynamic subtest ccs0: SUCCESS (0.502s) [378.449532] Subtest idle: SUCCESS (3.147s) [378.579327] [084/132] (642s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [378.687029] Starting subtest: fbc-rgb101010-draw-pwrite [384.031408] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.345s) [385.235669] [085/132] (635s left) kms_draw_crc (draw-method-render) [385.342527] Starting subtest: draw-method-render [385.344448] Starting dynamic subtest: xrgb8888-untiled [385.585125] Dynamic subtest xrgb8888-untiled: SUCCESS (0.243s) [385.595133] Starting dynamic subtest: rgb565-untiled [385.796647] Dynamic subtest rgb565-untiled: SUCCESS (0.210s) [385.807209] Starting dynamic subtest: xrgb2101010-untiled [386.020693] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [386.030247] Starting dynamic subtest: xbgr16161616f-untiled [386.229611] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.208s) [386.241772] Starting dynamic subtest: xrgb8888-xtiled [386.351730] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [386.362841] Starting dynamic subtest: rgb565-xtiled [386.484890] Dynamic subtest rgb565-xtiled: SUCCESS (0.131s) [386.493821] Starting dynamic subtest: xrgb2101010-xtiled [386.608241] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [386.623892] Starting dynamic subtest: xbgr16161616f-xtiled [386.740779] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.130s) [386.750683] Starting dynamic subtest: xrgb8888-4tiled [386.862994] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s) [386.872398] Starting dynamic subtest: rgb565-4tiled [386.974264] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s) [386.983973] Starting dynamic subtest: xrgb2101010-4tiled [387.096359] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s) [387.106049] Starting dynamic subtest: xbgr16161616f-4tiled [387.207689] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s) [387.209707] Subtest draw-method-render: SUCCESS (1.867s) [387.327999] [086/132] (633s left) gem_exec_balancer (bonded-sync) [387.409204] Starting subtest: bonded-sync [387.413025] Subtest bonded-sync: SKIP (0.000s) [387.742944] [087/132] (633s left) kms_color (ctm-negative) [387.844591] Starting subtest: ctm-negative [387.846609] Starting dynamic subtest: pipe-A-eDP-1 [388.579272] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s) [388.588598] Starting dynamic subtest: pipe-B-eDP-1 [390.052030] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.472s) [390.063717] Starting dynamic subtest: pipe-C-eDP-1 [391.397157] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.343s) [391.407619] Starting dynamic subtest: pipe-D-eDP-1 [392.725179] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s) [392.727680] Subtest ctm-negative: SUCCESS (4.881s) [393.557504] [088/132] (627s left) gem_ctx_engines (execute-oneforall) [393.632192] Starting subtest: execute-oneforall [394.123839] Subtest execute-oneforall: SUCCESS (0.491s) [396.040644] [089/132] (624s left) kms_psr (fbc-pr-sprite-blt) [396.141634] Starting subtest: fbc-pr-sprite-blt [396.145627] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [396.237004] [090/132] (624s left) kms_lease (lease-revoke) [396.350440] Starting subtest: lease-revoke [396.352716] Starting dynamic subtest: pipe-A-eDP-1 [396.382496] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s) [396.394325] Starting dynamic subtest: pipe-B-eDP-1 [396.409525] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s) [396.419941] Starting dynamic subtest: pipe-C-eDP-1 [396.443651] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.033s) [396.454947] Starting dynamic subtest: pipe-D-eDP-1 [396.469880] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s) [396.472208] Subtest lease-revoke: SUCCESS (0.122s) [396.632602] [091/132] (624s left) kms_plane (plane-position-hole) [396.729812] Starting subtest: plane-position-hole [397.239721] Starting dynamic subtest: pipe-A-plane-1 [398.488638] Dynamic subtest pipe-A-plane-1: SUCCESS (1.246s) [398.500940] Starting dynamic subtest: pipe-A-plane-2 [399.790437] Dynamic subtest pipe-A-plane-2: SUCCESS (1.301s) [399.802302] Starting dynamic subtest: pipe-A-plane-3 [401.138853] Dynamic subtest pipe-A-plane-3: SUCCESS (1.349s) [401.149450] Starting dynamic subtest: pipe-A-plane-4 [402.395046] Dynamic subtest pipe-A-plane-4: SUCCESS (1.257s) [402.405981] Starting dynamic subtest: pipe-A-plane-5 [402.423801] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s) [403.541879] Starting dynamic subtest: pipe-B-plane-1 [404.768196] Dynamic subtest pipe-B-plane-1: SUCCESS (1.237s) [404.779185] Starting dynamic subtest: pipe-B-plane-2 [406.000146] Dynamic subtest pipe-B-plane-2: SUCCESS (1.228s) [406.009628] Starting dynamic subtest: pipe-B-plane-3 [407.234770] Dynamic subtest pipe-B-plane-3: SUCCESS (1.234s) [407.244587] Starting dynamic subtest: pipe-B-plane-4 [408.450912] Dynamic subtest pipe-B-plane-4: SUCCESS (1.216s) [408.461854] Starting dynamic subtest: pipe-B-plane-5 [408.477593] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s) [408.479724] Subtest plane-position-hole: SUCCESS (11.749s) [409.283396] [092/132] (611s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [409.385438] Starting subtest: switch-modeset-ultra-joiner-big-joiner [409.389754] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [409.476911] [093/132] (611s left) syncobj_wait (invalid-wait-illegal-handle) [409.538427] Starting subtest: invalid-wait-illegal-handle [409.540742] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [409.667350] [094/132] (611s left) kms_flip (2x-flip-vs-rmfb-interruptible) [409.762434] Starting subtest: 2x-flip-vs-rmfb-interruptible [409.773983] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s) [409.875958] [095/132] (611s left) kms_cursor_crc (cursor-sliding-128x42) [410.095437] Starting subtest: cursor-sliding-128x42 [410.140984] Subtest cursor-sliding-128x42: SKIP (0.040s) [410.382582] [096/132] (610s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [410.481029] Starting subtest: fbc-1p-primscrn-cur-indfb-move [414.570874] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.092s) [415.786216] [097/132] (605s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [415.891024] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [415.895432] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [416.009742] [098/132] (605s left) i915_drm_fdinfo (virtual-busy-hang-all) [416.051081] Starting subtest: virtual-busy-hang-all [416.055443] Subtest virtual-busy-hang-all: SKIP (0.000s) [416.141458] [099/132] (605s left) kms_chamelium_hpd (common-hpd-after-suspend) [416.526751] Subtest common-hpd-after-suspend: SKIP (0.000s) [417.363381] [100/132] (603s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [417.466264] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [417.468617] Starting dynamic subtest: pipe-A-eDP-1 [418.265240] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.791s) [418.276164] Starting dynamic subtest: pipe-B-eDP-1 [419.932097] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.664s) [419.943100] Starting dynamic subtest: pipe-C-eDP-1 [421.399536] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.466s) [421.409341] Starting dynamic subtest: pipe-D-eDP-1 [422.985477] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.581s) [422.987420] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.510s) [424.228500] [101/132] (597s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [424.321749] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [424.324039] Starting dynamic subtest: pipe-A-eDP-1 [424.345530] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.019s) [424.356723] Starting dynamic subtest: pipe-B-eDP-1 [424.377153] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s) [424.387108] Starting dynamic subtest: pipe-C-eDP-1 [424.407216] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s) [424.416807] Starting dynamic subtest: pipe-D-eDP-1 [424.436948] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s) [424.439150] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.082s) [426.686450] [102/132] (594s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [426.805352] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [426.809713] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [426.968668] [103/132] (594s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [427.086341] Starting subtest: short-flip-before-cursor-atomic-transitions [428.048445] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.962s) [428.918760] [104/132] (592s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [429.020166] Starting subtest: psr-rgb565-draw-blt [436.005777] Subtest psr-rgb565-draw-blt: SUCCESS (6.988s) [436.171424] [105/132] (585s left) kms_content_protection (atomic-dpms-hdcp14) [436.300353] Starting subtest: atomic-dpms-hdcp14 [436.304821] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [436.456236] [106/132] (585s left) kms_pm_backlight (bad-brightness) [436.553626] Starting subtest: bad-brightness [436.600251] Starting dynamic subtest: eDP-1 [436.917541] Dynamic subtest eDP-1: SUCCESS (0.315s) [436.919911] Subtest bad-brightness: SUCCESS (0.365s) [437.761684] [107/132] (583s left) kms_hdmi_inject (inject-audio) [438.119936] Starting subtest: inject-audio [438.396766] Subtest inject-audio: SUCCESS (0.277s) [439.024433] [108/132] (582s left) kms_psr (fbc-psr-basic) [439.127375] Starting subtest: fbc-psr-basic [439.129555] Starting dynamic subtest: eDP-1 [439.133610] Dynamic subtest eDP-1: SKIP (0.000s) [439.137620] Subtest fbc-psr-basic: SKIP (0.001s) [439.228498] [109/132] (582s left) kms_flip (wf_vblank-ts-check) [439.327812] Starting subtest: wf_vblank-ts-check [439.329990] Starting dynamic subtest: A-eDP1 [448.278141] Dynamic subtest A-eDP1: SUCCESS (8.948s) [448.290456] Starting dynamic subtest: B-eDP1 [457.186087] Dynamic subtest B-eDP1: SUCCESS (8.906s) [457.198875] Starting dynamic subtest: C-eDP1 [466.074972] Dynamic subtest C-eDP1: SUCCESS (8.886s) [466.086427] Starting dynamic subtest: D-eDP1 [474.974639] Dynamic subtest D-eDP1: SUCCESS (8.902s) [474.977093] Subtest wf_vblank-ts-check: SUCCESS (35.649s) [476.186861] [110/132] (545s left) syncobj_timeline (multi-wait-all-available-signaled) [476.250518] Starting subtest: multi-wait-all-available-signaled [476.252632] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s) [476.375047] [111/132] (545s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [476.479835] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [477.104112] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s) [477.277863] [112/132] (544s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [477.386116] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [483.971857] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.589s) [484.148044] [113/132] (537s left) kms_psr2_su (page_flip-p010) [484.218289] Subtest page_flip-P010: SKIP (0.000s) [484.293868] [114/132] (537s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [484.398284] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [484.402962] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [484.574670] [115/132] (537s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [484.688536] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [485.756524] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.067s) [485.918768] [116/132] (536s left) api_intel_allocator (standalone) [485.974343] Starting subtest: standalone [485.990626] Subtest standalone: SUCCESS (0.018s) [486.148943] [117/132] (535s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [486.242459] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [486.246095] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [486.361659] [118/132] (535s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [486.459633] Starting subtest: drrs-dirtyfb-ioctl [486.470474] Subtest drrs-dirtyfb-ioctl: SKIP (0.002s) [486.599001] [119/132] (535s left) gem_exec_reloc (basic-cpu-wc-noreloc) [486.661509] Subtest basic-cpu-wc-noreloc: SKIP (0.000s) [486.746474] [120/132] (535s left) kms_cursor_legacy (cursor-vs-flip-toggle) [486.872681] Starting subtest: cursor-vs-flip-toggle [517.468878] Subtest cursor-vs-flip-toggle: SUCCESS (30.592s) [518.295880] [121/132] (503s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [518.400184] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [519.354683] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.956s) [519.517071] [122/132] (502s left) gem_mmap_gtt (medium-copy-odd) [519.581025] Subtest medium-copy-odd: SKIP (0.000s) [519.650555] [123/132] (502s left) core_getstats (basic) [519.699724] Starting subtest: basic [519.701468] Subtest basic: SUCCESS (0.000s) [519.833952] [124/132] (502s left) gem_ringfill (basic-all) [525.863629] Starting subtest: basic-all [527.020526] Subtest basic-all: SUCCESS (1.156s) [527.192087] [125/132] (495s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [527.264613] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [527.267270] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [527.393373] [126/132] (495s left) kms_pm_rpm (modeset-non-lpsp) [528.923599] Starting subtest: modeset-non-lpsp [530.084028] Subtest modeset-non-lpsp: SKIP (1.161s) [530.482138] [127/132] (492s left) gem_exec_schedule (preempt-engines) [530.554373] Starting subtest: preempt-engines [530.556712] Starting dynamic subtest: rcs0 [532.779006] Dynamic subtest rcs0: SUCCESS (2.233s) [532.791927] Starting dynamic subtest: bcs0 [534.977030] Dynamic subtest bcs0: SUCCESS (2.196s) [534.990359] Starting dynamic subtest: vcs0 [537.223033] Dynamic subtest vcs0: SUCCESS (2.243s) [537.236615] Starting dynamic subtest: vcs1 [539.482546] Dynamic subtest vcs1: SUCCESS (2.257s) [539.493897] Starting dynamic subtest: vecs0 [541.742955] Dynamic subtest vecs0: SUCCESS (2.257s) [541.755864] Starting dynamic subtest: ccs0 [544.002039] Dynamic subtest ccs0: SUCCESS (2.256s) [544.004526] Subtest preempt-engines: SUCCESS (13.455s) [544.325643] [128/132] (478s left) syncobj_timeline (multi-wait-submitted-signaled) [544.386148] Starting subtest: multi-wait-submitted-signaled [544.388566] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [544.517958] [129/132] (478s left) gem_lmem_swapping (verify-random) [544.562952] Subtest verify-random: SKIP (0.000s) [544.617393] [130/132] (478s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [544.733795] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [544.737745] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [544.871110] [131/132] (477s left) gem_softpin (allocator-nopin-reserve) [544.941292] Starting subtest: allocator-nopin-reserve [545.019798] Subtest allocator-nopin-reserve: SUCCESS (0.078s) [545.168858] [132/132] (477s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [545.269762] Starting subtest: fbc-modesetfrombusy [549.037802] Subtest fbc-modesetfrombusy: SUCCESS (3.770s) [550.260210] Closing watchdogs results: parsing output: 0/ for test: api_intel_bb results: parsing output: 1/ for test: gem_gpgpu_fill results: parsing output: 2/ for test: gem_pread results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_chamelium_audio results: parsing output: 5/ for test: kms_vblank results: parsing output: 6/ for test: kms_plane_scaling results: parsing output: 7/ for test: gem_mmap_gtt results: parsing output: 8/ for test: kms_flip results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: gen9_exec_parse results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: i915_pm_rpm results: parsing output: 15/ for test: syncobj_wait results: parsing output: 16/ for test: kms_scaling_modes results: parsing output: 17/ for test: gem_flink_basic results: parsing output: 18/ for test: gem_mmap_gtt results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: gem_exec_fence results: parsing output: 21/ for test: gem_tiled_blits results: parsing output: 22/ for test: kms_psr2_sf results: parsing output: 23/ for test: kms_color results: parsing output: 24/ for test: gem_exec_params results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: gem_exec_flush results: parsing output: 27/ for test: perf results: parsing output: 28/ for test: kms_atomic results: parsing output: 29/ for test: perf_pmu results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: sysfs_preempt_timeout results: parsing output: 32/ for test: gem_ctx_persistence results: parsing output: 33/ for test: gem_render_copy results: parsing output: 34/ for test: gem_exec_capture results: parsing output: 35/ for test: kms_plane_lowres results: parsing output: 36/ for test: kms_flip_scaled_crc results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: kms_addfb_basic results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: gem_exec_reloc results: parsing output: 41/ for test: gem_mmap_gtt results: parsing output: 42/ for test: gem_exec_reloc results: parsing output: 43/ for test: gem_exec_parallel results: parsing output: 44/ for test: kms_properties results: parsing output: 45/ for test: prime_mmap results: parsing output: 46/ for test: kms_cursor_crc results: parsing output: 47/ for test: kms_flip_scaled_crc results: parsing output: 48/ for test: i915_query results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: kms_hdr results: parsing output: 51/ for test: sw_sync results: parsing output: 52/ for test: kms_psr results: parsing output: 53/ for test: gem_userptr_blits results: parsing output: 54/ for test: gem_eio results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: perf_pmu results: parsing output: 57/ for test: gem_exec_schedule results: parsing output: 58/ for test: gem_userptr_blits results: parsing output: 59/ for test: kms_busy results: parsing output: 60/ for test: kms_universal_plane results: parsing output: 61/ for test: kms_flip results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_exec_flush results: parsing output: 65/ for test: gem_ctx_exec results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: gem_close results: parsing output: 68/ for test: kms_ccs results: parsing output: 69/ for test: gem_exec_suspend results: parsing output: 70/ for test: syncobj_eventfd results: parsing output: 71/ for test: gem_exec_reloc results: parsing output: 72/ for test: sw_sync results: parsing output: 73/ for test: kms_prime results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: prime_self_import results: parsing output: 76/ for test: gem_ctx_sseu results: parsing output: 77/ for test: kms_cursor_crc results: parsing output: 78/ for test: syncobj_timeline results: parsing output: 79/ for test: syncobj_timeline results: parsing output: 80/ for test: gem_bad_reloc results: parsing output: 81/ for test: syncobj_wait results: parsing output: 82/ for test: i915_drm_fdinfo results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_draw_crc results: parsing output: 85/ for test: gem_exec_balancer results: parsing output: 86/ for test: kms_color results: parsing output: 87/ for test: gem_ctx_engines results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: kms_lease results: parsing output: 90/ for test: kms_plane results: parsing output: 91/ for test: kms_joiner results: parsing output: 92/ for test: syncobj_wait results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: kms_cursor_crc results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: i915_drm_fdinfo results: parsing output: 98/ for test: kms_chamelium_hpd results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_content_protection results: parsing output: 105/ for test: kms_pm_backlight results: parsing output: 106/ for test: kms_hdmi_inject results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: kms_flip results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_psr2_su results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_big_fb results: parsing output: 115/ for test: api_intel_allocator results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_dirtyfb results: parsing output: 118/ for test: gem_exec_reloc results: parsing output: 119/ for test: kms_cursor_legacy results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: gem_mmap_gtt results: parsing output: 122/ for test: core_getstats results: parsing output: 123/ for test: gem_ringfill results: parsing output: 124/ for test: syncobj_wait results: parsing output: 125/ for test: kms_pm_rpm results: parsing output: 126/ for test: gem_exec_schedule results: parsing output: 127/ for test: syncobj_timeline results: parsing output: 128/ for test: gem_lmem_swapping results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_softpin results: parsing output: 131/ for test: kms_frontbuffer_tracking Done.