[58.318362] Initializing watchdogs [58.318407] /dev/watchdog0 [58.332483] [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] [58.336795] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.339144] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.342431] [001/132] (960s left) api_intel_bb (object-reloc-keep-cache) [58.409932] Starting subtest: object-reloc-keep-cache [58.416712] Subtest object-reloc-keep-cache: SKIP (0.005s) [58.526033] [002/132] (960s left) gem_gpgpu_fill (basic) [58.583883] Starting subtest: basic [58.586262] Starting dynamic subtest: smem [58.596205] Dynamic subtest smem: SUCCESS (0.013s) [58.598350] Subtest basic: SUCCESS (0.013s) [58.773966] [003/132] (960s left) gem_pread (bench) [58.825834] Subtest bench: SKIP (0.000s) [58.895979] [004/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [59.000230] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [59.004655] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [59.112281] [005/132] (959s left) kms_chamelium_audio (dp-audio-edid) [59.531466] Subtest dp-audio-edid: SKIP (0.000s) [60.299237] [006/132] (958s left) kms_vblank (wait-busy-hang) [60.394291] Starting subtest: wait-busy-hang [60.396618] Starting dynamic subtest: pipe-A-eDP-1 [86.680143] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.319s) [86.696478] Starting dynamic subtest: pipe-D-eDP-1 [101.649500] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.968s) [101.651817] Subtest wait-busy-hang: SUCCESS (41.291s) [102.556798] [007/132] (916s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [102.660409] Starting subtest: planes-downscale-factor-0-75-unity-scaling [102.662711] Starting dynamic subtest: pipe-A [102.725088] Dynamic subtest pipe-A: SUCCESS (0.065s) [102.733928] Starting dynamic subtest: pipe-B [103.856378] Dynamic subtest pipe-B: SUCCESS (1.130s) [103.866072] Starting dynamic subtest: pipe-C [104.967457] Dynamic subtest pipe-C: SUCCESS (1.110s) [104.977724] Starting dynamic subtest: pipe-D [106.103347] Dynamic subtest pipe-D: SUCCESS (1.135s) [106.105740] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.444s) [107.278233] [008/132] (911s left) gem_mmap_gtt (isolation) [107.333230] Subtest isolation: SKIP (0.000s) [107.395319] [009/132] (911s left) kms_flip (basic-flip-vs-wf_vblank) [107.479980] Starting subtest: basic-flip-vs-wf_vblank [107.482306] Starting dynamic subtest: A-eDP1 [109.401654] Dynamic subtest A-eDP1: SUCCESS (1.924s) [109.409180] Starting dynamic subtest: B-eDP1 [111.326534] Dynamic subtest B-eDP1: SUCCESS (1.924s) [111.336437] Starting dynamic subtest: C-eDP1 [113.255578] Dynamic subtest C-eDP1: SUCCESS (1.928s) [113.265849] Starting dynamic subtest: D-eDP1 [115.182078] Dynamic subtest D-eDP1: SUCCESS (1.926s) [115.184382] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.708s) [116.430777] [010/132] (902s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [116.537893] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [117.601388] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.064s) [117.744173] [011/132] (901s left) kms_psr (psr2-basic) [117.842424] Starting subtest: psr2-basic [117.844477] Starting dynamic subtest: eDP-1 [119.473076] Dynamic subtest eDP-1: SUCCESS (1.629s) [119.475042] Subtest psr2-basic: SUCCESS (1.630s) [120.294226] [012/132] (898s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [120.401671] Starting subtest: fbc-farfromfence-mmap-gtt [120.405877] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [120.532873] [013/132] (898s left) gen9_exec_parse (batch-zero-length) [120.600476] Subtest batch-zero-length: SKIP (0.000s) [120.682940] [014/132] (898s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [120.779594] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [120.781838] Starting dynamic subtest: pipe-A-eDP-1 [120.803048] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s) [120.813485] Starting dynamic subtest: pipe-B-eDP-1 [120.833318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s) [120.840921] Starting dynamic subtest: pipe-C-eDP-1 [120.860375] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s) [120.867768] Starting dynamic subtest: pipe-D-eDP-1 [120.900529] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s) [120.902732] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s) [123.146392] [015/132] (896s left) i915_pm_rpm (reg-read-ioctl) [125.084448] Starting subtest: reg-read-ioctl [127.476944] Subtest reg-read-ioctl: SUCCESS (2.392s) [127.887177] [016/132] (891s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [127.944675] Starting subtest: multi-wait-all-for-submit-unsubmitted [128.049039] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s) [128.146732] [017/132] (891s left) kms_scaling_modes (scaling-mode-full) [128.240065] Starting subtest: scaling-mode-full [128.242536] Starting dynamic subtest: pipe-A-eDP-1 [128.333870] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s) [128.343769] Starting dynamic subtest: pipe-B-eDP-1 [129.480266] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.144s) [129.489985] Starting dynamic subtest: pipe-C-eDP-1 [130.588497] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s) [130.596869] Starting dynamic subtest: pipe-D-eDP-1 [131.730327] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s) [131.732708] Subtest scaling-mode-full: SUCCESS (3.493s) [132.909913] [018/132] (886s left) gem_flink_basic (bad-open) [132.971887] Starting subtest: bad-open [132.974479] Subtest bad-open: SUCCESS (0.000s) [133.084318] [019/132] (886s left) gem_mmap_gtt (big-copy) [133.144339] Subtest big-copy: SKIP (0.000s) [133.209441] [020/132] (886s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [133.304410] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [140.382249] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.081s) [140.530019] [021/132] (879s left) gem_exec_fence (syncobj-signal) [140.977864] Starting subtest: syncobj-signal [140.982874] Subtest syncobj-signal: SUCCESS (0.005s) [143.044188] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true [143.047421] [022/132] (876s left) gem_tiled_blits (normal) [143.114616] Subtest normal: SKIP (0.000s) [143.188642] [023/132] (876s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [148.188507] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [148.190541] Starting dynamic subtest: pipe-A-eDP-1 [148.985197] Dynamic subtest pipe-A-eDP-1: SKIP (0.794s) [148.994278] Starting dynamic subtest: pipe-B-eDP-1 [150.135310] Dynamic subtest pipe-B-eDP-1: SKIP (1.150s) [150.139425] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.947s) [151.341573] [024/132] (868s left) kms_color (ctm-0-50) [151.442085] Starting subtest: ctm-0-50 [151.444398] Starting dynamic subtest: pipe-A-eDP-1 [154.936435] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.494s) [154.945513] Starting dynamic subtest: pipe-B-eDP-1 [159.274962] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.336s) [159.283075] Starting dynamic subtest: pipe-C-eDP-1 [163.269674] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.994s) [163.284171] Starting dynamic subtest: pipe-D-eDP-1 [167.268489] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.997s) [167.270761] Subtest ctm-0-50: SUCCESS (15.824s) [168.109932] [025/132] (851s left) gem_exec_params (no-bsd) [168.173991] Starting subtest: no-bsd [168.176416] Subtest no-bsd: SUCCESS (0.002s) [170.020118] [026/132] (849s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [170.123503] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [177.541381] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.419s) [177.710747] [027/132] (842s left) gem_exec_flush (basic-uc-rw-default) [177.770919] Starting subtest: basic-uc-rw-default [183.226872] Subtest basic-uc-rw-default: SUCCESS (5.456s) [183.438367] [028/132] (836s left) perf (create-destroy-userspace-config) [183.583410] Starting subtest: create-destroy-userspace-config [183.604102] Subtest create-destroy-userspace-config: SUCCESS (0.021s) [183.645335] [029/132] (836s left) kms_atomic (test-only) [183.736657] Starting subtest: test-only [183.785132] Starting dynamic subtest: pipe-A-eDP-1 [186.329442] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.543s) [186.331728] Subtest test-only: SUCCESS (2.594s) [187.149798] [030/132] (832s left) perf_pmu (most-busy-check-all) [187.189757] Starting subtest: most-busy-check-all [187.192068] Starting dynamic subtest: rcs0 [188.902481] Dynamic subtest rcs0: SUCCESS (1.695s) [188.912839] Starting dynamic subtest: bcs0 [190.933841] Dynamic subtest bcs0: SUCCESS (2.048s) [190.944794] Starting dynamic subtest: vcs0 [192.917491] Dynamic subtest vcs0: SUCCESS (1.980s) [192.928628] Starting dynamic subtest: vcs1 [194.900090] Dynamic subtest vcs1: SUCCESS (1.980s) [194.911201] Starting dynamic subtest: vecs0 [196.886340] Dynamic subtest vecs0: SUCCESS (1.984s) [196.897330] Starting dynamic subtest: ccs0 [198.933669] Dynamic subtest ccs0: SUCCESS (2.044s) [198.936264] Subtest most-busy-check-all: SUCCESS (11.746s) [199.065872] [031/132] (820s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [199.177594] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [199.181572] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [199.285345] [032/132] (820s left) sysfs_preempt_timeout (invalid) [199.353181] Starting subtest: invalid [199.355493] Starting dynamic subtest: vecs0 [199.357683] Dynamic subtest vecs0: SUCCESS (0.000s) [199.366886] Starting dynamic subtest: ccs0 [199.369048] Dynamic subtest ccs0: SUCCESS (0.000s) [199.377247] Starting dynamic subtest: vcs0 [199.379382] Dynamic subtest vcs0: SUCCESS (0.000s) [199.387280] Starting dynamic subtest: bcs0 [199.389438] Dynamic subtest bcs0: SUCCESS (0.000s) [199.397346] Starting dynamic subtest: rcs0 [199.399554] Dynamic subtest rcs0: SUCCESS (0.000s) [199.407855] Starting dynamic subtest: vcs1 [199.410064] Dynamic subtest vcs1: SUCCESS (0.000s) [199.412188] Subtest invalid: SUCCESS (0.005s) [199.494674] [033/132] (820s left) gem_ctx_persistence (heartbeat-many) [199.557559] Starting subtest: heartbeat-many [199.562281] Subtest heartbeat-many: SKIP (0.000s) [199.691372] [034/132] (820s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [199.754559] Starting subtest: mixed-tiled-to-yf-tiled-ccs [199.759151] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [199.963987] [035/132] (820s left) gem_exec_capture (capture) [200.026110] Starting subtest: capture [200.028616] Starting dynamic subtest: rcs0-smem [200.842036] Dynamic subtest rcs0-smem: SUCCESS (0.817s) [200.853669] Starting dynamic subtest: bcs0-smem [201.656827] Dynamic subtest bcs0-smem: SUCCESS (0.813s) [201.666493] Starting dynamic subtest: vcs0-smem [202.461622] Dynamic subtest vcs0-smem: SUCCESS (0.807s) [202.472130] Starting dynamic subtest: vcs1-smem [203.774688] Dynamic subtest vcs1-smem: SUCCESS (1.312s) [203.782903] Starting dynamic subtest: vecs0-smem [204.659712] Dynamic subtest vecs0-smem: FAIL (0.827s) [204.669661] Starting dynamic subtest: ccs0-smem [205.927689] Dynamic subtest ccs0-smem: SUCCESS (1.322s) [205.929977] Subtest capture: FAIL (5.902s) [206.073209] [036/132] (814s left) kms_plane_lowres (tiling-4) [206.171830] Starting subtest: tiling-4 [206.174174] Starting dynamic subtest: pipe-A-eDP-1 [206.178627] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [206.465291] Starting dynamic subtest: pipe-B-eDP-1 [206.469875] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [206.478062] Starting dynamic subtest: pipe-C-eDP-1 [206.482811] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [206.491220] Starting dynamic subtest: pipe-D-eDP-1 [206.496047] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [206.500439] Subtest tiling-4: SKIP (0.293s) [207.270904] [037/132] (812s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [207.375965] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [207.378216] Starting dynamic subtest: pipe-A-default-mode [207.672354] Dynamic subtest pipe-A-default-mode: SKIP (0.295s) [207.677094] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.297s) [208.504894] [038/132] (811s left) kms_big_fb (y-tiled-8bpp-rotate-270) [208.618057] Starting subtest: y-tiled-8bpp-rotate-270 [208.622561] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [208.749751] [039/132] (811s left) kms_addfb_basic (basic) [208.812657] Starting subtest: basic [208.814931] Subtest basic: SUCCESS (0.000s) [208.964216] [040/132] (811s left) kms_psr (psr2-sprite-mmap-gtt) [209.062101] Starting subtest: psr2-sprite-mmap-gtt [209.064385] Starting dynamic subtest: eDP-1 [210.487694] Dynamic subtest eDP-1: SKIP (1.420s) [210.492611] Subtest psr2-sprite-mmap-gtt: SKIP (1.422s) [210.673847] [041/132] (809s left) gem_exec_reloc (basic-gtt-noreloc) [210.746118] Subtest basic-gtt-noreloc: SKIP (0.000s) [210.833918] [042/132] (809s left) gem_mmap_gtt (basic-read-write) [210.893657] Subtest basic-read-write: SKIP (0.000s) [210.952756] [043/132] (809s left) gem_exec_reloc (basic-wc-read-noreloc) [211.021390] Subtest basic-wc-read-noreloc: SKIP (0.000s) [211.085009] [044/132] (809s left) gem_exec_parallel (userptr) [211.150508] Starting subtest: userptr [211.153062] Starting dynamic subtest: rcs0 [212.565319] Dynamic subtest rcs0: SUCCESS (1.415s) [212.576364] Starting dynamic subtest: bcs0 [214.033940] Dynamic subtest bcs0: SUCCESS (1.467s) [214.044952] Starting dynamic subtest: vcs0 [215.892552] Dynamic subtest vcs0: SUCCESS (1.855s) [215.905159] Starting dynamic subtest: vcs1 [217.940583] Dynamic subtest vcs1: SUCCESS (2.046s) [217.952742] Starting dynamic subtest: vecs0 [219.923934] Dynamic subtest vecs0: SUCCESS (1.982s) [219.935761] Starting dynamic subtest: ccs0 [221.394396] Dynamic subtest ccs0: SUCCESS (1.469s) [221.396872] Subtest userptr: SUCCESS (10.245s) [221.605692] [045/132] (798s left) kms_properties (plane-properties-atomic) [221.720871] Starting subtest: plane-properties-atomic [221.722793] Starting dynamic subtest: pipe-A-eDP-1 [222.286721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s) [222.295479] Starting dynamic subtest: pipe-B-eDP-1 [223.604985] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.317s) [223.613639] Starting dynamic subtest: pipe-C-eDP-1 [224.910375] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.303s) [224.919894] Starting dynamic subtest: pipe-D-eDP-1 [226.144731] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s) [226.147091] Subtest plane-properties-atomic: SUCCESS (4.425s) [226.973309] [046/132] (793s left) prime_mmap (test_map_unmap) [227.032038] Starting subtest: test_map_unmap [227.034229] Starting dynamic subtest: test_map_unmap-smem [227.064504] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s) [227.067063] Subtest test_map_unmap: SUCCESS (0.033s) [227.183636] [047/132] (793s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [227.305141] Starting subtest: cursor-tearing-framebuffer-change [227.307421] Starting dynamic subtest: pipe-A-eDP-1 [227.872783] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s) [227.881416] Starting dynamic subtest: pipe-D-eDP-1 [229.069246] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.194s) [229.071386] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.762s) [229.926484] [048/132] (790s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [230.013039] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [230.015158] Starting dynamic subtest: pipe-A-default-mode [231.160180] Dynamic subtest pipe-A-default-mode: SKIP (1.144s) [231.163762] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.145s) [231.350097] [049/132] (789s left) i915_query (test-query-geometry-subslices) [231.410071] Starting subtest: test-query-geometry-subslices [231.412396] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [231.540754] [050/132] (789s left) syncobj_timeline (invalid-query-illegal-handle) [231.605022] Starting subtest: invalid-query-illegal-handle [231.607287] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [231.732365] [051/132] (789s left) kms_hdr (static-toggle) [231.831612] Starting subtest: static-toggle [231.837607] Subtest static-toggle: SKIP (0.000s) [231.926480] [052/132] (788s left) sw_sync (sync_multi_consumer) [231.969292] Starting subtest: sync_multi_consumer [232.397868] Subtest sync_multi_consumer: SUCCESS (0.428s) [232.488359] [053/132] (788s left) kms_psr (fbc-psr-sprite-plane-onoff) [232.589333] Starting subtest: fbc-psr-sprite-plane-onoff [232.591221] Starting dynamic subtest: eDP-1 [232.595181] Dynamic subtest eDP-1: SKIP (0.000s) [232.599126] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s) [232.689094] [054/132] (788s left) gem_userptr_blits (sd-probe) [232.758245] Starting subtest: sd-probe [232.760211] Subtest sd-probe: SUCCESS (0.000s) [232.926554] [055/132] (788s left) gem_eio (wait-immediate) [233.172466] Starting subtest: wait-immediate [233.560392] Subtest wait-immediate: SUCCESS (0.388s) [233.737512] [056/132] (787s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [233.840834] Starting subtest: psr-rgb565-draw-render [240.999090] Subtest psr-rgb565-draw-render: SUCCESS (7.159s) [241.147677] [057/132] (779s left) perf_pmu (event-wait) [241.188504] Starting subtest: event-wait [241.190806] Starting dynamic subtest: rcs0 [241.195307] Dynamic subtest rcs0: SKIP (0.000s) [241.200415] Subtest event-wait: SKIP (0.001s) [241.312310] [058/132] (779s left) gem_exec_schedule (smoketest) [241.499944] Starting subtest: smoketest [241.502751] Starting dynamic subtest: rcs0 [247.041076] Dynamic subtest rcs0: SUCCESS (5.493s) [247.051191] Starting dynamic subtest: bcs0 [252.565010] Dynamic subtest bcs0: SUCCESS (5.522s) [252.575854] Starting dynamic subtest: vcs0 [258.080577] Dynamic subtest vcs0: SUCCESS (5.511s) [258.092473] Starting dynamic subtest: vcs1 [263.590340] Dynamic subtest vcs1: SUCCESS (5.510s) [263.600374] Starting dynamic subtest: vecs0 [269.099790] Dynamic subtest vecs0: SUCCESS (5.505s) [269.115321] Starting dynamic subtest: ccs0 [274.605273] Dynamic subtest ccs0: SUCCESS (5.508s) [274.607462] Subtest smoketest: SUCCESS (33.058s) [274.837892] [059/132] (746s left) gem_userptr_blits (map-fixed-invalidate-busy) [274.905788] Starting subtest: map-fixed-invalidate-busy [274.909997] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [275.077278] [060/132] (746s left) kms_busy (basic) [275.185061] Starting subtest: basic [275.187376] Starting dynamic subtest: flip [275.764661] Dynamic subtest flip: SUCCESS (0.580s) [275.774691] Starting dynamic subtest: modeset [279.217916] Dynamic subtest modeset: SUCCESS (3.451s) [279.220779] Subtest basic: SUCCESS (4.034s) [280.099171] [061/132] (741s left) kms_universal_plane (universal-plane-sanity) [280.194084] Starting subtest: universal-plane-sanity [280.196335] Starting dynamic subtest: pipe-A-eDP-1 [280.807224] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s) [280.816696] Starting dynamic subtest: pipe-B-eDP-1 [281.985854] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.179s) [281.996867] Starting dynamic subtest: pipe-C-eDP-1 [283.193071] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s) [283.204058] Starting dynamic subtest: pipe-D-eDP-1 [284.429920] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s) [284.432223] Subtest universal-plane-sanity: SUCCESS (4.236s) [285.310040] [062/132] (735s left) kms_flip (flip-vs-panning-interruptible) [285.410960] Starting subtest: flip-vs-panning-interruptible [285.413149] Starting dynamic subtest: A-eDP1 [294.097780] Dynamic subtest A-eDP1: SUCCESS (8.685s) [294.109040] Starting dynamic subtest: B-eDP1 [302.819729] Dynamic subtest B-eDP1: SUCCESS (8.720s) [302.830655] Starting dynamic subtest: C-eDP1 [311.533938] Dynamic subtest C-eDP1: SUCCESS (8.713s) [311.543969] Starting dynamic subtest: D-eDP1 [320.266625] Dynamic subtest D-eDP1: SUCCESS (8.731s) [320.271320] Subtest flip-vs-panning-interruptible: SUCCESS (34.859s) [321.469341] [063/132] (699s left) kms_addfb_basic (legacy-format) [321.533957] Starting subtest: legacy-format [321.563986] Subtest legacy-format: SUCCESS (0.026s) [321.737715] [064/132] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [321.839270] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [321.843475] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [321.987340] [065/132] (699s left) gem_exec_flush (basic-uc-set-default) [322.050058] Starting subtest: basic-uc-set-default [327.503889] Subtest basic-uc-set-default: SUCCESS (5.454s) [327.719164] [066/132] (693s left) gem_ctx_exec (basic-invalid-context) [327.776714] Starting subtest: basic-invalid-context [327.784237] Subtest basic-invalid-context: SUCCESS (0.009s) [327.955410] [067/132] (693s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [328.055847] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [332.521482] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.470s) [333.674872] [068/132] (687s left) gem_close (many-handles-one-vma) [333.730437] Starting subtest: many-handles-one-vma [333.752635] Subtest many-handles-one-vma: SUCCESS (0.024s) [333.870606] [069/132] (687s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [333.957898] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [333.960057] Starting dynamic subtest: pipe-A-eDP-1 [333.981541] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [333.992604] Starting dynamic subtest: pipe-B-eDP-1 [334.013235] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [334.022226] Starting dynamic subtest: pipe-C-eDP-1 [334.042874] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [334.051718] Starting dynamic subtest: pipe-D-eDP-1 [334.073215] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [334.077244] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [336.237152] [070/132] (685s left) gem_exec_suspend (basic-s0) [336.308958] Starting subtest: basic-S0 [336.311280] Starting dynamic subtest: smem [356.328882] Dynamic subtest smem: SUCCESS (8.633s) [356.331219] Subtest basic-S0: SUCCESS (8.635s) [356.535732] [071/132] (665s left) syncobj_eventfd (invalid-illegal-handle) [356.611375] Starting subtest: invalid-illegal-handle [356.613608] Subtest invalid-illegal-handle: SUCCESS (0.000s) [356.742311] [072/132] (664s left) gem_exec_reloc (basic-write-read-active) [356.812149] Subtest basic-write-read-active: SKIP (0.000s) [356.899789] [073/132] (664s left) sw_sync (sync_merge_same) [356.936047] Starting subtest: sync_merge_same [356.938350] Subtest sync_merge_same: SUCCESS (0.000s) [357.011355] [074/132] (664s left) kms_prime (basic-crc-vgem) [357.093557] Starting subtest: basic-crc-vgem [357.095776] Starting dynamic subtest: second-to-first [358.083339] Dynamic subtest second-to-first: SUCCESS (1.016s) [358.085264] Subtest basic-crc-vgem: SUCCESS (1.017s) [358.197107] [075/132] (663s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [358.338602] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [364.975170] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.728s) [365.154717] [076/132] (656s left) prime_self_import (basic-llseek-size) [365.198502] Starting subtest: basic-llseek-size [365.216472] Subtest basic-llseek-size: SUCCESS (0.018s) [365.344040] [077/132] (656s left) gem_ctx_sseu (engines) [365.415292] Subtest engines: SKIP (0.000s) [365.487659] [078/132] (656s left) kms_cursor_crc (cursor-onscreen-max-size) [365.787465] Starting subtest: cursor-onscreen-max-size [365.793795] Subtest cursor-onscreen-max-size: SKIP (0.000s) [365.945503] [079/132] (656s left) syncobj_timeline (transfer-timeline-point) [365.989736] Starting subtest: transfer-timeline-point [365.991605] Subtest transfer-timeline-point: SUCCESS (0.000s) [366.145814] [080/132] (655s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [366.197512] Starting subtest: etime-single-wait-all-for-submit-submitted [366.301655] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s) [366.402589] [081/132] (655s left) gem_bad_reloc (negative-reloc) [366.468731] Subtest negative-reloc: SKIP (0.000s) [366.557173] [082/132] (655s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [366.618532] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [366.620744] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [366.756126] [083/132] (655s left) i915_drm_fdinfo (idle) [366.792816] Starting subtest: idle [366.795017] Starting dynamic subtest: rcs0 [367.358176] Dynamic subtest rcs0: SUCCESS (0.569s) [367.371053] Starting dynamic subtest: bcs0 [367.865479] Dynamic subtest bcs0: SUCCESS (0.506s) [367.877900] Starting dynamic subtest: vcs0 [368.370551] Dynamic subtest vcs0: SUCCESS (0.506s) [368.382387] Starting dynamic subtest: vcs1 [368.878860] Dynamic subtest vcs1: SUCCESS (0.505s) [368.889801] Starting dynamic subtest: vecs0 [369.380415] Dynamic subtest vecs0: SUCCESS (0.506s) [369.393216] Starting dynamic subtest: ccs0 [369.886498] Dynamic subtest ccs0: SUCCESS (0.505s) [369.889289] Subtest idle: SUCCESS (3.111s) [369.992221] [084/132] (652s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [370.104392] Starting subtest: fbc-rgb101010-draw-pwrite [375.411358] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.328s) [376.575800] [085/132] (645s left) kms_draw_crc (draw-method-render) [376.683773] Starting subtest: draw-method-render [376.685758] Starting dynamic subtest: xrgb8888-untiled [376.937703] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s) [376.947784] Starting dynamic subtest: rgb565-untiled [377.191665] Dynamic subtest rgb565-untiled: SUCCESS (0.253s) [377.201670] Starting dynamic subtest: xrgb2101010-untiled [377.413516] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s) [377.423609] Starting dynamic subtest: xbgr16161616f-untiled [377.634772] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [377.644891] Starting dynamic subtest: xrgb8888-xtiled [377.756954] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s) [377.766950] Starting dynamic subtest: rgb565-xtiled [377.867803] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s) [377.877381] Starting dynamic subtest: xrgb2101010-xtiled [377.989742] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [377.999780] Starting dynamic subtest: xbgr16161616f-xtiled [378.112177] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s) [378.124667] Starting dynamic subtest: xrgb8888-4tiled [378.244798] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.130s) [378.254597] Starting dynamic subtest: rgb565-4tiled [378.355804] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s) [378.365794] Starting dynamic subtest: xrgb2101010-4tiled [378.478109] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s) [378.488494] Starting dynamic subtest: xbgr16161616f-4tiled [378.610954] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s) [378.615147] Subtest draw-method-render: SUCCESS (1.935s) [378.785902] [086/132] (643s left) gem_exec_balancer (bonded-sync) [378.853586] Starting subtest: bonded-sync [378.857495] Subtest bonded-sync: SKIP (0.000s) [379.184638] [087/132] (643s left) kms_color (ctm-negative) [379.288712] Starting subtest: ctm-negative [379.290663] Starting dynamic subtest: pipe-A-eDP-1 [379.995675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s) [380.005676] Starting dynamic subtest: pipe-B-eDP-1 [381.441411] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.445s) [381.451909] Starting dynamic subtest: pipe-C-eDP-1 [382.816352] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s) [382.826784] Starting dynamic subtest: pipe-D-eDP-1 [384.138525] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s) [384.140833] Subtest ctm-negative: SUCCESS (4.858s) [384.978071] [088/132] (637s left) gem_ctx_engines (execute-oneforall) [385.055355] Starting subtest: execute-oneforall [385.601151] Subtest execute-oneforall: SUCCESS (0.546s) [387.439877] [089/132] (634s left) kms_psr (fbc-pr-sprite-blt) [387.544346] Starting subtest: fbc-pr-sprite-blt [387.548715] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [387.645941] [090/132] (634s left) kms_lease (lease-revoke) [387.730998] Starting subtest: lease-revoke [387.733276] Starting dynamic subtest: pipe-A-eDP-1 [387.764333] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s) [387.774970] Starting dynamic subtest: pipe-B-eDP-1 [387.791670] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s) [387.802442] Starting dynamic subtest: pipe-C-eDP-1 [387.820369] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s) [387.830857] Starting dynamic subtest: pipe-D-eDP-1 [387.853261] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s) [387.855504] Subtest lease-revoke: SUCCESS (0.122s) [388.009584] [091/132] (634s left) kms_plane (plane-position-hole) [388.101006] Starting subtest: plane-position-hole [388.639511] Starting dynamic subtest: pipe-A-plane-1 [389.951043] Dynamic subtest pipe-A-plane-1: SUCCESS (1.309s) [389.962638] Starting dynamic subtest: pipe-A-plane-2 [391.248084] Dynamic subtest pipe-A-plane-2: SUCCESS (1.296s) [391.259392] Starting dynamic subtest: pipe-A-plane-3 [392.499633] Dynamic subtest pipe-A-plane-3: SUCCESS (1.252s) [392.512159] Starting dynamic subtest: pipe-A-plane-4 [393.841384] Dynamic subtest pipe-A-plane-4: SUCCESS (1.342s) [393.854864] Starting dynamic subtest: pipe-A-plane-5 [393.869382] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s) [395.099638] Starting dynamic subtest: pipe-B-plane-1 [396.409697] Dynamic subtest pipe-B-plane-1: SUCCESS (1.317s) [396.420200] Starting dynamic subtest: pipe-B-plane-2 [397.731093] Dynamic subtest pipe-B-plane-2: SUCCESS (1.322s) [397.741702] Starting dynamic subtest: pipe-B-plane-3 [399.082051] Dynamic subtest pipe-B-plane-3: SUCCESS (1.352s) [399.093420] Starting dynamic subtest: pipe-B-plane-4 [400.373976] Dynamic subtest pipe-B-plane-4: SUCCESS (1.291s) [400.385006] Starting dynamic subtest: pipe-B-plane-5 [400.400949] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s) [400.403250] Subtest plane-position-hole: SUCCESS (12.299s) [401.196274] [092/132] (621s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [401.305478] Starting subtest: switch-modeset-ultra-joiner-big-joiner [401.309814] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [401.397807] [093/132] (621s left) syncobj_wait (invalid-wait-illegal-handle) [401.463461] Starting subtest: invalid-wait-illegal-handle [401.465859] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [401.586037] [094/132] (621s left) kms_flip (2x-flip-vs-rmfb-interruptible) [401.683680] Starting subtest: 2x-flip-vs-rmfb-interruptible [401.696561] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s) [401.799492] [095/132] (620s left) kms_cursor_crc (cursor-sliding-128x42) [402.030792] Starting subtest: cursor-sliding-128x42 [402.083380] Subtest cursor-sliding-128x42: SKIP (0.046s) [402.339892] [096/132] (620s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [402.453102] Starting subtest: fbc-1p-primscrn-cur-indfb-move [406.614539] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.163s) [407.803061] [097/132] (614s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [407.900117] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [407.904587] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [408.037365] [098/132] (614s left) i915_drm_fdinfo (virtual-busy-hang-all) [408.079931] Starting subtest: virtual-busy-hang-all [408.084599] Subtest virtual-busy-hang-all: SKIP (0.000s) [408.170698] [099/132] (614s left) kms_chamelium_hpd (common-hpd-after-suspend) [408.555520] Subtest common-hpd-after-suspend: SKIP (0.000s) [409.388576] [100/132] (613s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [409.488193] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [409.490074] Starting dynamic subtest: pipe-A-eDP-1 [410.365619] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.873s) [410.375991] Starting dynamic subtest: pipe-B-eDP-1 [412.017784] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.648s) [412.037870] Starting dynamic subtest: pipe-C-eDP-1 [413.557840] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.538s) [413.572992] Starting dynamic subtest: pipe-D-eDP-1 [415.074930] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.516s) [415.076875] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.581s) [416.267713] [101/132] (606s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [416.383503] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [416.385426] Starting dynamic subtest: pipe-A-eDP-1 [416.406413] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s) [416.417540] Starting dynamic subtest: pipe-B-eDP-1 [416.437824] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s) [416.448109] Starting dynamic subtest: pipe-C-eDP-1 [416.467922] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s) [416.477890] Starting dynamic subtest: pipe-D-eDP-1 [416.498480] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s) [416.500729] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.086s) [418.649653] [102/132] (604s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [418.759622] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [418.763689] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [418.895904] [103/132] (604s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [419.019818] Starting subtest: short-flip-before-cursor-atomic-transitions [419.979874] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.958s) [420.873079] [104/132] (602s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [420.979988] Starting subtest: psr-rgb565-draw-blt [428.019819] Subtest psr-rgb565-draw-blt: SUCCESS (7.045s) [428.205721] [105/132] (594s left) kms_content_protection (atomic-dpms-hdcp14) [428.355104] Starting subtest: atomic-dpms-hdcp14 [428.359579] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [428.524564] [106/132] (594s left) kms_pm_backlight (bad-brightness) [428.626378] Starting subtest: bad-brightness [428.676943] Starting dynamic subtest: eDP-1 [428.988853] Dynamic subtest eDP-1: SUCCESS (0.311s) [428.991134] Subtest bad-brightness: SUCCESS (0.366s) [429.841784] [107/132] (593s left) kms_hdmi_inject (inject-audio) [430.187949] Starting subtest: inject-audio [430.467744] Subtest inject-audio: SUCCESS (0.282s) [431.116687] [108/132] (592s left) kms_psr (fbc-psr-basic) [431.218724] Starting subtest: fbc-psr-basic [431.220663] Starting dynamic subtest: eDP-1 [431.224776] Dynamic subtest eDP-1: SKIP (0.000s) [431.228963] Subtest fbc-psr-basic: SKIP (0.001s) [431.318270] [109/132] (591s left) kms_flip (wf_vblank-ts-check) [431.429819] Starting subtest: wf_vblank-ts-check [431.431983] Starting dynamic subtest: A-eDP1 [440.366228] Dynamic subtest A-eDP1: SUCCESS (8.941s) [440.377572] Starting dynamic subtest: B-eDP1 [449.260375] Dynamic subtest B-eDP1: SUCCESS (8.896s) [449.272754] Starting dynamic subtest: C-eDP1 [458.154854] Dynamic subtest C-eDP1: SUCCESS (8.889s) [458.166366] Starting dynamic subtest: D-eDP1 [467.062758] Dynamic subtest D-eDP1: SUCCESS (8.902s) [467.065080] Subtest wf_vblank-ts-check: SUCCESS (35.637s) [468.275919] [110/132] (555s left) syncobj_timeline (multi-wait-all-available-signaled) [468.345739] Starting subtest: multi-wait-all-available-signaled [468.348123] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s) [468.483096] [111/132] (554s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [468.587727] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [469.212245] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s) [469.444904] [112/132] (553s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [469.546240] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [476.223496] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.678s) [476.416873] [113/132] (547s left) kms_psr2_su (page_flip-p010) [476.479739] Subtest page_flip-P010: SKIP (0.000s) [476.547210] [114/132] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [476.655253] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [476.659644] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [476.789404] [115/132] (546s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [476.902625] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [477.914839] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.012s) [478.095853] [116/132] (545s left) api_intel_allocator (standalone) [478.157021] Starting subtest: standalone [478.173068] Subtest standalone: SUCCESS (0.018s) [478.324901] [117/132] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [478.430707] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [478.434123] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [478.557556] [118/132] (545s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [478.650023] Starting subtest: drrs-dirtyfb-ioctl [478.661172] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s) [478.771291] [119/132] (544s left) gem_exec_reloc (basic-cpu-wc-noreloc) [478.828358] Subtest basic-cpu-wc-noreloc: SKIP (0.000s) [478.918865] [120/132] (544s left) kms_cursor_legacy (cursor-vs-flip-toggle) [479.043808] Starting subtest: cursor-vs-flip-toggle [509.833009] Subtest cursor-vs-flip-toggle: SUCCESS (30.790s) [510.684966] [121/132] (513s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [510.800544] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [511.823772] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.023s) [511.994298] [122/132] (511s left) gem_mmap_gtt (medium-copy-odd) [512.053964] Subtest medium-copy-odd: SKIP (0.000s) [512.117465] [123/132] (511s left) core_getstats (basic) [512.170380] Starting subtest: basic [512.172202] Subtest basic: SUCCESS (0.000s) [512.304198] [124/132] (511s left) gem_ringfill (basic-all) [518.317534] Starting subtest: basic-all [519.487783] Subtest basic-all: SUCCESS (1.171s) [519.667204] [125/132] (504s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [519.738025] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [519.740407] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [519.875733] [126/132] (504s left) kms_pm_rpm (modeset-non-lpsp) [521.513338] Starting subtest: modeset-non-lpsp [522.655668] Subtest modeset-non-lpsp: SKIP (1.145s) [523.034638] [127/132] (501s left) gem_exec_schedule (preempt-engines) [523.118552] Starting subtest: preempt-engines [523.120924] Starting dynamic subtest: rcs0 [525.347961] Dynamic subtest rcs0: SUCCESS (2.236s) [525.361377] Starting dynamic subtest: bcs0 [527.559857] Dynamic subtest bcs0: SUCCESS (2.211s) [527.573141] Starting dynamic subtest: vcs0 [529.808126] Dynamic subtest vcs0: SUCCESS (2.247s) [529.818860] Starting dynamic subtest: vcs1 [532.074824] Dynamic subtest vcs1: SUCCESS (2.265s) [532.088527] Starting dynamic subtest: vecs0 [534.336755] Dynamic subtest vecs0: SUCCESS (2.260s) [534.350284] Starting dynamic subtest: ccs0 [536.608934] Dynamic subtest ccs0: SUCCESS (2.271s) [536.612025] Subtest preempt-engines: SUCCESS (13.500s) [536.938490] [128/132] (487s left) syncobj_timeline (multi-wait-submitted-signaled) [536.997886] Starting subtest: multi-wait-submitted-signaled [537.000113] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [537.122793] [129/132] (487s left) gem_lmem_swapping (verify-random) [537.176226] Subtest verify-random: SKIP (0.000s) [537.222474] [130/132] (486s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [537.334913] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [537.339073] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [537.480482] [131/132] (486s left) gem_softpin (allocator-nopin-reserve) [537.545051] Starting subtest: allocator-nopin-reserve [537.643989] Subtest allocator-nopin-reserve: SUCCESS (0.098s) [537.825011] [132/132] (486s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [537.928525] Starting subtest: fbc-modesetfrombusy [541.718364] Subtest fbc-modesetfrombusy: SUCCESS (3.794s) [542.872765] 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.