[61.093182] Initializing watchdogs [61.093229] /dev/watchdog0 [61.108536] [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] [61.113267] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.116268] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.118172] [001/133] (960s left) kms_pm_dc (dc9-dpms) [62.229066] Starting subtest: dc9-dpms [63.641275] Subtest dc9-dpms: SUCCESS (1.416s) [63.719250] [002/133] (957s left) kms_getfb (getfb-handle-closed) [63.803201] Starting subtest: getfb-handle-closed [63.804222] Subtest getfb-handle-closed: SUCCESS (0.001s) [63.904462] [003/133] (957s left) kms_big_fb (x-tiled-8bpp-rotate-90) [63.998708] Starting subtest: x-tiled-8bpp-rotate-90 [64.034686] Subtest x-tiled-8bpp-rotate-90: SKIP (0.036s) [64.128368] [004/133] (957s left) gem_lmem_swapping (heavy-random) [64.170140] Subtest heavy-random: SKIP (0.000s) [64.200531] [005/133] (957s left) perf_pmu (most-busy-idle-check-all) [64.234385] Starting subtest: most-busy-idle-check-all [64.235396] Starting dynamic subtest: rcs0 [65.319047] Dynamic subtest rcs0: SUCCESS (1.079s) [65.327938] Starting dynamic subtest: bcs0 [67.301515] Dynamic subtest bcs0: SUCCESS (1.985s) [67.310606] Starting dynamic subtest: vcs0 [69.349490] Dynamic subtest vcs0: SUCCESS (2.049s) [69.358301] Starting dynamic subtest: vcs1 [71.333089] Dynamic subtest vcs1: SUCCESS (1.985s) [71.341763] Starting dynamic subtest: vecs0 [73.317633] Dynamic subtest vecs0: SUCCESS (1.985s) [73.325793] Starting dynamic subtest: ccs0 [75.300876] Dynamic subtest ccs0: SUCCESS (1.984s) [75.302328] Subtest most-busy-idle-check-all: SUCCESS (11.074s) [75.406353] [006/133] (946s left) gem_mmap_gtt (fault-concurrent) [75.459732] Subtest fault-concurrent: SKIP (0.000s) [75.514285] [007/133] (946s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [75.607415] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [76.675261] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.069s) [76.803706] [008/133] (945s left) i915_suspend (basic-s3-without-i915) [76.838444] Starting subtest: basic-s3-without-i915 [80.070115] Subtest basic-s3-without-i915: SKIP (3.224s) [81.609937] [009/133] (940s left) gem_exec_reloc (basic-wc-read-noreloc) [81.670500] Subtest basic-wc-read-noreloc: SKIP (0.000s) [81.743916] [010/133] (940s left) vgem_basic (dmabuf-export) [81.806035] Starting subtest: dmabuf-export [81.822769] Subtest dmabuf-export: SUCCESS (0.017s) [81.914961] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true [81.916852] [011/133] (940s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [81.959853] Starting subtest: single-wait-all-for-submit-available-submitted [81.960700] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [82.052947] [012/133] (939s left) kms_psr (fbc-psr2-cursor-blt) [82.142117] Starting subtest: fbc-psr2-cursor-blt [82.143066] Starting dynamic subtest: eDP-1 [82.144892] Dynamic subtest eDP-1: SKIP (0.000s) [82.146640] Subtest fbc-psr2-cursor-blt: SKIP (0.000s) [82.207724] [013/133] (939s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [82.305699] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [82.307614] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [82.401653] [014/133] (939s left) gen9_exec_parse (bb-large) [82.450159] Subtest bb-large: SKIP (0.000s) [82.521256] [015/133] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [82.617626] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [90.027774] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.411s) [90.172191] [016/133] (931s left) kms_cursor_crc (cursor-onscreen-256x256) [90.403978] Starting subtest: cursor-onscreen-256x256 [90.409801] Starting dynamic subtest: pipe-A-eDP-1 [92.537559] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.131s) [92.571513] Starting dynamic subtest: pipe-D-eDP-1 [95.323904] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s) [95.324821] Subtest cursor-onscreen-256x256: SUCCESS (4.919s) [96.194999] [017/133] (925s left) gem_pread (bench) [96.244858] Subtest bench: SKIP (0.000s) [96.295296] [018/133] (925s left) kms_plane_multiple (tiling-4) [96.389461] Starting subtest: tiling-4 [96.390470] Starting dynamic subtest: pipe-A-eDP-1 [100.065096] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.668s) [100.073600] Starting dynamic subtest: pipe-B-eDP-1 [104.494186] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.436s) [104.501404] Starting dynamic subtest: pipe-C-eDP-1 [108.826334] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.331s) [108.834853] Starting dynamic subtest: pipe-D-eDP-1 [113.153339] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.327s) [113.154308] Subtest tiling-4: SUCCESS (16.765s) [113.976776] [019/133] (908s left) kms_plane (pixel-format-x-tiled-modifier) [114.085487] Starting subtest: pixel-format-x-tiled-modifier [114.112600] Starting dynamic subtest: pipe-A-plane-0 [114.779300] Dynamic subtest pipe-A-plane-0: SUCCESS (0.667s) [114.789703] Starting dynamic subtest: pipe-A-plane-3 [115.201390] Dynamic subtest pipe-A-plane-3: SUCCESS (0.422s) [115.208702] Starting dynamic subtest: pipe-A-plane-5 [115.210575] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [116.361259] Starting dynamic subtest: pipe-B-plane-0 [116.984947] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s) [116.993931] Starting dynamic subtest: pipe-B-plane-3 [117.373598] Dynamic subtest pipe-B-plane-3: SUCCESS (0.388s) [117.382720] Starting dynamic subtest: pipe-B-plane-5 [117.384391] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [117.687304] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.603s) [118.526132] [020/133] (903s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [118.637245] Starting subtest: basic-flip-after-cursor-legacy [119.557115] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.919s) [120.391882] [021/133] (901s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [120.520652] Starting subtest: flip-vs-cursor-atomic-transitions [128.523634] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (8.010s) [129.382201] [022/133] (892s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [129.464858] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [136.985883] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.521s) [137.114697] [023/133] (885s left) gem_vm_create (invalid-destroy) [137.167942] Starting subtest: invalid-destroy [137.170148] Subtest invalid-destroy: SUCCESS (0.002s) [137.265480] [024/133] (885s left) core_getclient (basic) [137.309905] Starting subtest: basic [137.310936] Subtest basic: SUCCESS (0.000s) [137.403500] [025/133] (885s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [137.463499] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [137.568915] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s) [137.640686] [026/133] (884s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [137.746469] Starting subtest: fbc-rgb565-draw-pwrite [142.448517] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.710s) [143.599056] [027/133] (878s left) i915_pciid [143.716653] [028/133] (878s left) kms_psr (fbc-psr-primary-mmap-cpu) [143.800493] Starting subtest: fbc-psr-primary-mmap-cpu [143.801386] Starting dynamic subtest: eDP-1 [143.803049] Dynamic subtest eDP-1: SKIP (0.000s) [143.804784] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s) [143.884335] [029/133] (878s left) kms_big_fb (linear-32bpp-rotate-270) [143.974056] Starting subtest: linear-32bpp-rotate-270 [143.995045] Subtest linear-32bpp-rotate-270: SKIP (0.019s) [144.090297] [030/133] (878s left) gem_mmap_offset (partial-remap) [144.143694] Starting subtest: partial-remap [144.144651] Starting dynamic subtest: smem0 [144.149420] Dynamic subtest smem0: SUCCESS (0.004s) [144.150230] Subtest partial-remap: SUCCESS (0.004s) [144.261546] [031/133] (878s left) gem_exec_reloc (basic-gtt-read-noreloc) [144.318857] Subtest basic-gtt-read-noreloc: SKIP (0.000s) [144.387052] [032/133] (878s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [144.477418] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [144.478466] Starting dynamic subtest: pipe-A-eDP-1 [144.502583] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.025s) [144.511068] Starting dynamic subtest: pipe-B-eDP-1 [144.525440] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s) [144.535135] Starting dynamic subtest: pipe-C-eDP-1 [144.548845] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s) [144.557441] Starting dynamic subtest: pipe-D-eDP-1 [144.572398] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s) [144.573382] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.096s) [146.866649] [033/133] (875s left) gem_ctx_shared (q-out-order) [146.927821] Starting subtest: Q-out-order [146.928817] Starting dynamic subtest: rcs0 [147.031499] Dynamic subtest rcs0: SUCCESS (0.103s) [147.041796] Starting dynamic subtest: vcs0 [147.118482] Dynamic subtest vcs0: SUCCESS (0.085s) [147.135066] Starting dynamic subtest: vcs1 [147.196728] Dynamic subtest vcs1: SUCCESS (0.078s) [147.213985] Starting dynamic subtest: vecs0 [147.270105] Dynamic subtest vecs0: SUCCESS (0.073s) [147.286797] Starting dynamic subtest: ccs0 [147.353191] Dynamic subtest ccs0: SUCCESS (0.082s) [147.354455] Subtest Q-out-order: SUCCESS (0.426s) [148.401163] [034/133] (874s left) gem_tiled_wb [148.504047] [035/133] (874s left) gem_exec_capture (capture) [148.566655] Starting subtest: capture [148.567694] Starting dynamic subtest: rcs0-smem [149.411859] Dynamic subtest rcs0-smem: SUCCESS (0.844s) [149.419135] Starting dynamic subtest: bcs0-smem [150.240349] Dynamic subtest bcs0-smem: SUCCESS (0.829s) [150.247764] Starting dynamic subtest: vcs0-smem [151.073526] Dynamic subtest vcs0-smem: SUCCESS (0.832s) [151.080666] Starting dynamic subtest: vcs1-smem [152.400076] Dynamic subtest vcs1-smem: SUCCESS (1.325s) [152.407056] Starting dynamic subtest: vecs0-smem [153.244469] Dynamic subtest vecs0-smem: FAIL (0.824s) [153.251404] Starting dynamic subtest: ccs0-smem [154.551715] Dynamic subtest ccs0-smem: SUCCESS (1.325s) [154.552698] Subtest capture: FAIL (5.983s) [154.668548] [036/133] (868s left) fbdev (unaligned-write) [154.712202] Starting subtest: unaligned-write [154.814790] Subtest unaligned-write: SUCCESS (0.101s) [154.872969] [037/133] (867s left) gem_ctx_bad_destroy (double-destroy) [154.913521] Starting subtest: double-destroy [154.914562] Subtest double-destroy: SUCCESS (0.000s) [154.972462] [038/133] (867s left) gem_ctx_persistence (legacy-engines-mixed-process) [155.029960] Starting subtest: legacy-engines-mixed-process [155.031071] Starting dynamic subtest: render [156.320497] Dynamic subtest render: SUCCESS (1.290s) [156.330792] Starting dynamic subtest: bsd1 [158.313512] Dynamic subtest bsd1: SUCCESS (1.991s) [158.324472] Starting dynamic subtest: bsd2 [160.286653] Dynamic subtest bsd2: SUCCESS (1.970s) [160.297337] Starting dynamic subtest: blt [162.345813] Dynamic subtest blt: SUCCESS (2.056s) [162.357505] Starting dynamic subtest: vebox [164.324871] Dynamic subtest vebox: SUCCESS (1.977s) [164.325914] Subtest legacy-engines-mixed-process: SUCCESS (9.294s) [164.405850] [039/133] (858s left) kms_lease (atomic-implicit-crtc) [164.498438] Starting subtest: atomic-implicit-crtc [164.499385] Starting dynamic subtest: pipe-A-eDP-1 [164.503956] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [164.513923] Starting dynamic subtest: pipe-B-eDP-1 [164.518286] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [164.526077] Starting dynamic subtest: pipe-C-eDP-1 [164.530289] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s) [164.537708] Starting dynamic subtest: pipe-D-eDP-1 [164.541569] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s) [164.542375] Subtest atomic-implicit-crtc: SUCCESS (0.035s) [164.657471] [040/133] (858s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [164.750485] Starting subtest: fbcpsr-indfb-scaledprimary [170.549099] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.799s) [170.666930] [041/133] (852s left) kms_async_flips (crc) [170.756267] Starting subtest: crc [171.141984] Starting dynamic subtest: pipe-A-eDP-1 [174.021519] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.879s) [174.398796] Starting dynamic subtest: pipe-B-eDP-1 [177.352027] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.961s) [177.736595] Starting dynamic subtest: pipe-C-eDP-1 [180.665915] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.936s) [181.043506] Starting dynamic subtest: pipe-D-eDP-1 [183.902081] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.865s) [183.903138] Subtest crc: SUCCESS (13.145s) [185.053625] [042/133] (837s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [185.150738] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [185.152567] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [185.252323] [043/133] (837s left) kms_draw_crc (draw-method-render) [185.339336] Starting subtest: draw-method-render [185.340196] Starting dynamic subtest: xrgb8888-untiled [185.617164] Dynamic subtest xrgb8888-untiled: SUCCESS (0.278s) [185.625673] Starting dynamic subtest: rgb565-untiled [185.928944] Dynamic subtest rgb565-untiled: SUCCESS (0.310s) [185.943526] Starting dynamic subtest: xrgb2101010-untiled [186.162043] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.231s) [186.171396] Starting dynamic subtest: xbgr16161616f-untiled [186.406701] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.242s) [186.416120] Starting dynamic subtest: xrgb8888-xtiled [186.528657] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.120s) [186.537061] Starting dynamic subtest: rgb565-xtiled [186.639510] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s) [186.650546] Starting dynamic subtest: xrgb2101010-xtiled [186.761891] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [186.769721] Starting dynamic subtest: xbgr16161616f-xtiled [186.895283] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s) [186.903654] Starting dynamic subtest: xrgb8888-4tiled [187.017371] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s) [187.025301] Starting dynamic subtest: rgb565-4tiled [187.128576] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s) [187.136182] Starting dynamic subtest: xrgb2101010-4tiled [187.250866] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s) [187.259128] Starting dynamic subtest: xbgr16161616f-4tiled [187.384380] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s) [187.385578] Subtest draw-method-render: SUCCESS (2.045s) [187.497441] [044/133] (835s left) gem_ctx_exec (basic-close-race) [187.557832] Starting subtest: basic-close-race [193.613787] Subtest basic-close-race: SUCCESS (6.010s) [193.697017] [045/133] (829s left) kms_pm_rpm (fences-dpms) [195.417788] Starting subtest: fences-dpms [195.420529] Subtest fences-dpms: SKIP (0.000s) [195.997376] [046/133] (827s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [196.066972] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [196.141209] [047/133] (827s left) gem_eio (wait-wedge-10ms) [196.364379] Starting subtest: wait-wedge-10ms [197.413123] Subtest wait-wedge-10ms: SUCCESS (1.050s) [197.534941] [048/133] (825s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [197.620410] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [197.632271] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s) [197.707571] [049/133] (825s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [197.768730] Starting subtest: yf-tiled-to-vebox-yf-tiled [197.770540] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [197.946182] [050/133] (825s left) syncobj_timeline (invalid-signal-illegal-point) [197.998074] Starting subtest: invalid-signal-illegal-point [197.998830] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [198.085517] [051/133] (825s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [198.169773] Starting subtest: 2x-flip-vs-absolute-wf_vblank [198.181084] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.012s) [198.270032] [052/133] (825s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [198.357562] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [202.483300] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.126s) [203.614485] [053/133] (819s left) gem_userptr_blits (map-fixed-invalidate) [203.677120] Starting subtest: map-fixed-invalidate [203.679010] Subtest map-fixed-invalidate: SKIP (0.000s) [203.794342] [054/133] (819s left) kms_properties (get_properties-sanity-atomic) [203.874203] Starting subtest: get_properties-sanity-atomic [203.876422] Subtest get_properties-sanity-atomic: SUCCESS (0.003s) [203.946517] [055/133] (819s left) kms_sequence (queue-busy) [204.025491] Starting subtest: queue-busy [204.026450] Starting dynamic subtest: pipe-A-eDP-1 [205.961529] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s) [205.969429] Starting dynamic subtest: pipe-B-eDP-1 [208.587268] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.625s) [208.601535] Starting dynamic subtest: pipe-C-eDP-1 [211.212819] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.623s) [211.226846] Starting dynamic subtest: pipe-D-eDP-1 [213.836279] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s) [213.837142] Subtest queue-busy: SUCCESS (9.810s) [214.727268] [056/133] (808s left) gem_render_copy_redux (normal) [214.777019] Starting subtest: normal [215.068967] Subtest normal: SUCCESS (0.292s) [215.186137] [057/133] (808s left) kms_dp_aux_dev (basic) [215.242437] Starting subtest: basic [215.466264] Subtest basic: SUCCESS (0.225s) [215.533974] [058/133] (808s left) syncobj_basic (test-valid-cycle) [215.586264] Starting subtest: test-valid-cycle [215.587129] Subtest test-valid-cycle: SUCCESS (0.000s) [215.693647] [059/133] (807s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [215.748329] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [215.865387] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s) [215.928589] [060/133] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [216.020068] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [223.461060] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.441s) [223.569247] [061/133] (800s left) kms_vrr (max-min) [223.665349] Starting subtest: max-min [223.667756] Subtest max-min: SKIP (0.000s) [223.734050] [062/133] (799s left) gem_exec_fence (syncobj-invalid-flags) [224.177218] Starting subtest: syncobj-invalid-flags [224.178284] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [225.381560] [063/133] (798s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [225.425813] Starting subtest: etime-multi-wait-for-submit-submitted [225.529046] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s) [225.600480] [064/133] (798s left) kms_psr (psr2-primary-blt) [225.679698] Starting subtest: psr2-primary-blt [225.680659] Starting dynamic subtest: eDP-1 [227.432427] Dynamic subtest eDP-1: SUCCESS (1.751s) [227.433395] Subtest psr2-primary-blt: SUCCESS (1.752s) [228.311808] [065/133] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [228.416211] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [228.417835] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [228.509121] [066/133] (795s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [228.556138] Starting subtest: invalid-multi-wait-unsubmitted-submitted [228.556995] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [228.648271] [067/133] (795s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [228.743308] Starting subtest: psr-rgb101010-draw-mmap-cpu [235.864137] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.121s) [235.963030] [068/133] (787s left) gem_exec_schedule (preempt) [236.016462] Starting subtest: preempt [236.017326] Starting dynamic subtest: rcs0 [236.041505] Dynamic subtest rcs0: SUCCESS (0.026s) [236.049552] Starting dynamic subtest: bcs0 [236.062902] Dynamic subtest bcs0: SUCCESS (0.021s) [236.070780] Starting dynamic subtest: vcs0 [236.083168] Dynamic subtest vcs0: SUCCESS (0.020s) [236.092924] Starting dynamic subtest: vcs1 [236.103159] Dynamic subtest vcs1: SUCCESS (0.020s) [236.110923] Starting dynamic subtest: vecs0 [236.124441] Dynamic subtest vecs0: SUCCESS (0.021s) [236.132396] Starting dynamic subtest: ccs0 [236.145347] Dynamic subtest ccs0: SUCCESS (0.020s) [236.146308] Subtest preempt: SUCCESS (0.131s) [237.406945] [069/133] (786s left) kms_prop_blob (blob-prop-core) [237.449229] Starting subtest: blob-prop-core [237.450473] Subtest blob-prop-core: SUCCESS (0.000s) [237.545197] [070/133] (786s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [237.635121] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [237.636892] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [237.733680] [071/133] (786s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [237.828708] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [237.830569] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [237.917859] [072/133] (786s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [238.010035] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [238.011770] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [238.095646] [073/133] (785s left) gem_exec_schedule (thriceslice) [238.159421] Starting subtest: thriceslice [238.160347] Starting dynamic subtest: rcs0 [238.188932] Dynamic subtest rcs0: SUCCESS (0.030s) [238.202276] Starting dynamic subtest: bcs0 [238.240171] Dynamic subtest bcs0: SUCCESS (0.050s) [238.252485] Starting dynamic subtest: vcs0 [238.293355] Dynamic subtest vcs0: SUCCESS (0.050s) [238.304475] Starting dynamic subtest: vcs1 [238.326893] Dynamic subtest vcs1: SUCCESS (0.032s) [238.340049] Starting dynamic subtest: vecs0 [238.361152] Dynamic subtest vecs0: SUCCESS (0.032s) [238.375531] Starting dynamic subtest: ccs0 [238.393230] Dynamic subtest ccs0: SUCCESS (0.031s) [238.394691] Subtest thriceslice: SUCCESS (0.235s) [239.366778] [074/133] (784s left) kms_addfb_basic (unused-pitches) [239.424485] Starting subtest: unused-pitches [239.425348] Subtest unused-pitches: SUCCESS (0.000s) [239.558909] [075/133] (784s left) gem_ppgtt (blt-vs-render-ctxn) [239.621353] Starting subtest: blt-vs-render-ctxN [272.627723] Subtest blt-vs-render-ctxN: SUCCESS (32.994s) [272.755483] [076/133] (751s left) kms_flip (2x-flip-vs-dpms-on-nop) [272.897980] Starting subtest: 2x-flip-vs-dpms-on-nop [272.908792] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s) [272.984855] [077/133] (751s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [273.083349] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [273.084244] Starting dynamic subtest: pipe-A-eDP-1 [290.123942] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.724s) [290.133101] Starting dynamic subtest: pipe-B-eDP-1 [308.089405] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.833s) [308.098892] Starting dynamic subtest: pipe-C-eDP-1 [326.085781] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.744s) [326.095238] Starting dynamic subtest: pipe-D-eDP-1 [344.069197] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.752s) [344.070179] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (11.058s) [350.388989] [078/133] (678s left) gem_madvise (dontneed-before-exec) [350.426936] Starting subtest: dontneed-before-exec [350.449540] Subtest dontneed-before-exec: SKIP (0.021s) [350.503481] [079/133] (678s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [350.593411] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [350.594309] Starting dynamic subtest: pipe-A-eDP-1 [350.732343] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s) [350.743851] Starting dynamic subtest: pipe-B-eDP-1 [350.751644] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [350.761047] Starting dynamic subtest: pipe-C-eDP-1 [350.768566] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [350.777907] Starting dynamic subtest: pipe-D-eDP-1 [350.785301] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [350.786151] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s) [352.957969] [080/133] (676s left) gem_spin_batch (resubmit-all) [353.011094] Starting subtest: resubmit-all [353.012190] Starting dynamic subtest: rcs0 [353.022154] Dynamic subtest rcs0: SUCCESS (0.011s) [353.034191] Starting dynamic subtest: bcs0 [353.035329] Dynamic subtest bcs0: SUCCESS (0.002s) [353.044422] Starting dynamic subtest: vcs0 [353.045632] Dynamic subtest vcs0: SUCCESS (0.003s) [353.054568] Starting dynamic subtest: vcs1 [353.055506] Dynamic subtest vcs1: SUCCESS (0.002s) [353.064391] Starting dynamic subtest: vecs0 [353.065336] Dynamic subtest vecs0: SUCCESS (0.002s) [353.074142] Starting dynamic subtest: ccs0 [353.075192] Dynamic subtest ccs0: SUCCESS (0.002s) [353.076149] Subtest resubmit-all: SUCCESS (0.026s) [354.302595] [081/133] (675s left) kms_chamelium_audio (dp-audio-edid) [354.696121] Subtest dp-audio-edid: SKIP (0.000s) [355.461574] [082/133] (674s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [355.551965] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [360.177720] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.644s) [361.372194] [083/133] (668s left) gem_exec_balancer (bonded-true-hang) [361.645151] Starting subtest: bonded-true-hang [361.647013] Subtest bonded-true-hang: SKIP (0.000s) [361.734102] [084/133] (667s left) kms_psr (fbc-pr-cursor-blt) [361.820503] Starting subtest: fbc-pr-cursor-blt [361.822112] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [361.904015] [085/133] (667s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [362.021142] Starting subtest: cursorA-vs-flipB-toggle [362.022903] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [362.167907] [086/133] (667s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [362.229194] Starting subtest: yf-tiled-ccs-to-yf-tiled [362.231626] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s) [362.411526] [087/133] (667s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [362.510369] Starting subtest: multiplane-rotation-cropping-bottom [379.882088] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.393s) [379.982594] [088/133] (649s left) kms_joiner (basic-big-joiner) [380.074676] Starting subtest: basic-big-joiner [380.076502] Subtest basic-big-joiner: SKIP (0.000s) [380.155515] [089/133] (649s left) sysfs_heartbeat_interval (idempotent) [380.210481] Starting subtest: idempotent [380.211541] Starting dynamic subtest: vecs0 [380.212424] Dynamic subtest vecs0: SUCCESS (0.001s) [380.222940] Starting dynamic subtest: ccs0 [380.223720] Dynamic subtest ccs0: SUCCESS (0.001s) [380.232712] Starting dynamic subtest: vcs0 [380.233456] Dynamic subtest vcs0: SUCCESS (0.001s) [380.242929] Starting dynamic subtest: bcs0 [380.243779] Dynamic subtest bcs0: SUCCESS (0.001s) [380.253315] Starting dynamic subtest: rcs0 [380.254109] Dynamic subtest rcs0: SUCCESS (0.001s) [380.262827] Starting dynamic subtest: vcs1 [380.263666] Dynamic subtest vcs1: SUCCESS (0.001s) [380.264519] Subtest idempotent: SUCCESS (0.009s) [380.318405] [090/133] (649s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [380.409535] Starting subtest: compare-crc-sanitycheck-nv12 [380.410395] Starting dynamic subtest: pipe-A-eDP-1 [381.120449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s) [381.130047] Starting dynamic subtest: pipe-B-eDP-1 [382.436210] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.314s) [382.445590] Starting dynamic subtest: pipe-C-eDP-1 [383.667747] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.229s) [383.677356] Starting dynamic subtest: pipe-D-eDP-1 [384.957911] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.289s) [384.958785] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.548s) [385.764252] [091/133] (644s left) kms_plane_scaling (invalid-num-scalers) [385.850763] Starting subtest: invalid-num-scalers [385.851726] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [385.870265] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s) [385.879991] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [385.903159] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s) [385.913979] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [385.937814] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s) [385.947226] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [385.970557] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s) [385.971417] Subtest invalid-num-scalers: SUCCESS (0.121s) [386.063166] [092/133] (643s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [386.152242] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [393.001699] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.838s) [393.112368] [093/133] (636s left) kms_cursor_crc (cursor-rapid-movement-32x10) [393.266326] Starting subtest: cursor-rapid-movement-32x10 [393.311782] Subtest cursor-rapid-movement-32x10: SKIP (0.044s) [393.597032] [094/133] (636s left) prime_vgem (shrink) [393.673842] Starting subtest: shrink [393.702189] Subtest shrink: SUCCESS (0.028s) [393.799431] [095/133] (636s left) gem_ctx_param (invalid-set-ringsize) [393.846350] Starting subtest: invalid-set-ringsize [393.847308] Subtest invalid-set-ringsize: SUCCESS (0.000s) [393.918670] [096/133] (636s left) gem_exec_store (pages) [393.975640] Starting subtest: pages [393.976564] Starting dynamic subtest: rcs0 [394.053023] Dynamic subtest rcs0: SUCCESS (0.077s) [394.064373] Starting dynamic subtest: bcs0 [394.121662] Dynamic subtest bcs0: SUCCESS (0.068s) [394.133752] Starting dynamic subtest: vcs0 [394.191092] Dynamic subtest vcs0: SUCCESS (0.068s) [394.202892] Starting dynamic subtest: vcs1 [394.257907] Dynamic subtest vcs1: SUCCESS (0.063s) [394.269870] Starting dynamic subtest: vecs0 [394.326884] Dynamic subtest vecs0: SUCCESS (0.071s) [394.338433] Starting dynamic subtest: ccs0 [394.390853] Dynamic subtest ccs0: SUCCESS (0.063s) [394.392063] Subtest pages: SUCCESS (0.415s) [394.573013] [097/133] (635s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [394.661540] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [394.663345] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [394.753316] [098/133] (635s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [394.839795] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [394.841616] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s) [394.909162] [099/133] (635s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [394.978045] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [394.979215] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s) [395.049981] [100/133] (635s left) api_intel_bb (blit-reloc-purge-cache) [395.102474] Starting subtest: blit-reloc-purge-cache [395.104227] Subtest blit-reloc-purge-cache: SKIP (0.000s) [395.216676] [101/133] (635s left) kms_color (deep-color) [395.299549] Starting subtest: deep-color [396.372223] Starting dynamic subtest: pipe-A-eDP-1-gamma [397.088349] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.716s) [397.097793] Starting dynamic subtest: pipe-A-eDP-1-degamma [398.587660] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.498s) [398.596949] Starting dynamic subtest: pipe-A-eDP-1-ctm [400.005792] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.418s) [400.784888] Starting dynamic subtest: pipe-B-eDP-1-gamma [401.474205] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.709s) [401.483582] Starting dynamic subtest: pipe-B-eDP-1-degamma [402.981867] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.505s) [402.993266] Starting dynamic subtest: pipe-B-eDP-1-ctm [404.395471] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.415s) [405.160496] Starting dynamic subtest: pipe-C-eDP-1-gamma [405.842315] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.691s) [405.851336] Starting dynamic subtest: pipe-C-eDP-1-degamma [407.231119] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.389s) [407.240548] Starting dynamic subtest: pipe-C-eDP-1-ctm [408.666334] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.434s) [409.458180] Starting dynamic subtest: pipe-D-eDP-1-gamma [410.153636] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.704s) [410.162975] Starting dynamic subtest: pipe-D-eDP-1-degamma [411.529823] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.376s) [411.539605] Starting dynamic subtest: pipe-D-eDP-1-ctm [412.964874] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.435s) [412.965798] Subtest deep-color: SUCCESS (17.670s) [413.827649] [102/133] (616s left) kms_flip (plain-flip-fb-recreate) [413.920159] Starting subtest: plain-flip-fb-recreate [413.922118] Starting dynamic subtest: A-eDP1 [422.824191] Dynamic subtest A-eDP1: SUCCESS (8.906s) [422.836008] Starting dynamic subtest: B-eDP1 [431.748758] Dynamic subtest B-eDP1: SUCCESS (8.925s) [431.762046] Starting dynamic subtest: C-eDP1 [440.567643] Dynamic subtest C-eDP1: SUCCESS (8.820s) [440.578712] Starting dynamic subtest: D-eDP1 [449.391872] Dynamic subtest D-eDP1: SUCCESS (8.821s) [449.395549] Subtest plain-flip-fb-recreate: SUCCESS (35.485s) [450.577760] [103/133] (579s left) perf (unprivileged-single-ctx-counters) [450.714541] Starting subtest: unprivileged-single-ctx-counters [450.716087] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [450.753137] [104/133] (579s left) i915_pm_rpm (reg-read-ioctl) [452.493608] Starting subtest: reg-read-ioctl [454.775998] Subtest reg-read-ioctl: SUCCESS (2.293s) [455.147446] [105/133] (575s left) kms_vblank (ts-continuation-dpms-suspend) [455.235495] Starting subtest: ts-continuation-dpms-suspend [455.236342] Starting dynamic subtest: pipe-A-eDP-1 [472.475175] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.257s) [472.486991] Starting dynamic subtest: pipe-D-eDP-1 [490.484821] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.851s) [490.485766] Subtest ts-continuation-dpms-suspend: SUCCESS (5.112s) [496.314336] [106/133] (539s left) kms_chamelium_edid (hdmi-edid-change-during-suspend) [496.703825] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s) [497.522369] [107/133] (538s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [497.627468] Starting subtest: yf-tiled-8bpp-rotate-270 [497.629230] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [497.721716] [108/133] (537s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [497.812015] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [497.813633] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [497.898635] [109/133] (537s left) gem_render_linear_blits (basic) [497.951657] Starting subtest: basic [497.971828] Subtest basic: SUCCESS (0.020s) [498.049746] [110/133] (537s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [498.422688] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [499.203323] [111/133] (536s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [499.291120] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [499.291920] Starting dynamic subtest: pipe-A [499.355353] Dynamic subtest pipe-A: SUCCESS (0.065s) [499.367985] Starting dynamic subtest: pipe-B [500.471929] Dynamic subtest pipe-B: SUCCESS (1.121s) [500.483555] Starting dynamic subtest: pipe-C [501.567076] Dynamic subtest pipe-C: SUCCESS (1.101s) [501.576491] Starting dynamic subtest: pipe-D [502.688085] Dynamic subtest pipe-D: SUCCESS (1.125s) [502.688934] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.417s) [503.832078] [112/133] (531s left) drm_read (short-buffer-wakeup) [503.981636] Starting subtest: short-buffer-wakeup [536.174641] Subtest short-buffer-wakeup: SUCCESS (32.215s) [536.342694] [113/133] (499s left) kms_hdr (bpc-switch) [536.430232] Starting subtest: bpc-switch [536.445326] Starting dynamic subtest: pipe-A-eDP-1 [539.951097] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.505s) [539.951983] Subtest bpc-switch: SUCCESS (3.521s) [540.062015] [114/133] (495s left) kms_psr (fbc-psr-suspend) [540.159911] Starting subtest: fbc-psr-suspend [540.160727] Starting dynamic subtest: eDP-1 [540.162422] Dynamic subtest eDP-1: SKIP (0.000s) [540.164007] Subtest fbc-psr-suspend: SKIP (0.001s) [540.231973] [115/133] (495s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [540.286775] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [540.350690] [116/133] (495s left) i915_drm_fdinfo (memory-info-active) [540.381356] Starting subtest: memory-info-active [540.382294] Starting dynamic subtest: smem0 [543.096884] Dynamic subtest smem0: SUCCESS (2.715s) [543.098385] Subtest memory-info-active: SUCCESS (2.716s) [543.170973] [117/133] (492s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [543.269677] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [544.349188] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.079s) [544.467243] [118/133] (491s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [544.555890] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [544.557563] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [544.658758] [119/133] (491s left) gem_mmap_wc (copy) [544.721962] Subtest copy: SKIP (0.000s) [544.780015] [120/133] (491s left) kms_content_protection (dp-mst-lic-type-1) [544.923949] Starting subtest: dp-mst-lic-type-1 [544.925639] Subtest dp-mst-lic-type-1: SKIP (0.000s) [545.041408] [121/133] (491s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [545.134348] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [545.135222] Starting dynamic subtest: pipe-A-eDP-1 [545.573616] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.429s) [545.583718] Starting dynamic subtest: pipe-B-eDP-1 [547.059294] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s) [547.069509] Starting dynamic subtest: pipe-C-eDP-1 [548.404873] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.344s) [548.414740] Starting dynamic subtest: pipe-D-eDP-1 [549.751681] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s) [549.752547] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.609s) [550.941054] [122/133] (485s left) perf_pmu (interrupts) [550.985999] Starting subtest: interrupts [552.080680] Subtest interrupts: SUCCESS (1.084s) [552.197766] [123/133] (483s left) gem_mmap_wc (invalid-flags) [552.237814] Subtest invalid-flags: SKIP (0.000s) [552.294757] [124/133] (483s left) kms_cursor_edge_walk (64x64-top-bottom) [552.379262] Starting subtest: 64x64-top-bottom [552.380176] Starting dynamic subtest: pipe-A-eDP-1 [555.816707] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.438s) [555.827347] Starting dynamic subtest: pipe-D-eDP-1 [558.954833] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.137s) [558.955724] Subtest 64x64-top-bottom: SUCCESS (6.578s) [559.751761] [125/133] (476s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [559.838136] Starting subtest: modeset-transition-nonblocking-fencing [559.838954] Starting dynamic subtest: 1x-outputs [570.700188] Dynamic subtest 1x-outputs: SUCCESS (10.864s) [570.701825] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.866s) [571.558888] [126/133] (464s left) prime_udl [571.632404] [127/133] (464s left) kms_frontbuffer_tracking (psr-1p-rte) [571.728300] Starting subtest: psr-1p-rte [577.155308] Subtest psr-1p-rte: SUCCESS (5.431s) [577.276468] [128/133] (459s left) gem_partial_pwrite_pread (write-snoop) [577.344344] Subtest write-snoop: SKIP (0.000s) [577.442055] [129/133] (458s left) gem_mmap_gtt (basic-small-copy) [577.501019] Subtest basic-small-copy: SKIP (0.000s) [577.573792] [130/133] (458s left) gem_exec_await (wide-contexts) [577.778375] Starting subtest: wide-contexts [601.143947] Subtest wide-contexts: SUCCESS (23.362s) [601.342007] [131/133] (435s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [601.477689] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area [601.478687] Starting dynamic subtest: pipe-A-eDP-1 [601.578557] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [601.590040] Starting dynamic subtest: pipe-B-eDP-1 [602.750815] Dynamic subtest pipe-B-eDP-1: SKIP (1.170s) [602.752711] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.273s) [603.930073] [132/133] (432s left) gem_exec_schedule (implicit-boths) [604.003358] Starting subtest: implicit-boths [604.004349] Starting dynamic subtest: rcs0 [604.114817] Dynamic subtest rcs0: SUCCESS (0.110s) [604.126204] Starting dynamic subtest: vcs0 [604.207199] Dynamic subtest vcs0: SUCCESS (0.091s) [604.218697] Starting dynamic subtest: vcs1 [604.292096] Dynamic subtest vcs1: SUCCESS (0.084s) [604.315207] Starting dynamic subtest: vecs0 [604.378792] Dynamic subtest vecs0: SUCCESS (0.086s) [604.391825] Starting dynamic subtest: ccs0 [604.461812] Dynamic subtest ccs0: SUCCESS (0.082s) [604.463878] Subtest implicit-boths: SUCCESS (0.458s) [605.474982] [133/133] (431s left) prime_mmap_coherency (write) [605.521186] Starting subtest: write [610.946535] Subtest write: SUCCESS (5.378s) [611.032297] Closing watchdogs results: parsing output: 0/ for test: kms_pm_dc results: parsing output: 1/ for test: kms_getfb results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: gem_lmem_swapping results: parsing output: 4/ for test: perf_pmu results: parsing output: 5/ for test: gem_mmap_gtt results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: i915_suspend results: parsing output: 8/ for test: gem_exec_reloc results: parsing output: 9/ for test: vgem_basic results: parsing output: 10/ for test: syncobj_timeline results: parsing output: 11/ for test: kms_psr results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: gen9_exec_parse results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_cursor_crc results: parsing output: 16/ for test: gem_pread results: parsing output: 17/ for test: kms_plane_multiple results: parsing output: 18/ for test: kms_plane results: parsing output: 19/ for test: kms_cursor_legacy results: parsing output: 20/ for test: kms_cursor_legacy results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_vm_create results: parsing output: 23/ for test: core_getclient results: parsing output: 24/ for test: syncobj_timeline results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: i915_pciid results: parsing output: 27/ for test: kms_psr results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: gem_mmap_offset results: parsing output: 30/ for test: gem_exec_reloc results: parsing output: 31/ for test: kms_ccs results: parsing output: 32/ for test: gem_ctx_shared results: parsing output: 33/ for test: gem_tiled_wb results: parsing output: 34/ for test: gem_exec_capture results: parsing output: 35/ for test: fbdev results: parsing output: 36/ for test: gem_ctx_bad_destroy results: parsing output: 37/ for test: gem_ctx_persistence results: parsing output: 38/ for test: kms_lease results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_async_flips results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: kms_draw_crc results: parsing output: 43/ for test: gem_ctx_exec results: parsing output: 44/ for test: kms_pm_rpm results: parsing output: 45/ for test: gem_exec_reloc results: parsing output: 46/ for test: gem_eio results: parsing output: 47/ for test: kms_flip results: parsing output: 48/ for test: gem_render_copy results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: kms_flip results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_userptr_blits results: parsing output: 53/ for test: kms_properties results: parsing output: 54/ for test: kms_sequence results: parsing output: 55/ for test: gem_render_copy_redux results: parsing output: 56/ for test: kms_dp_aux_dev results: parsing output: 57/ for test: syncobj_basic results: parsing output: 58/ for test: syncobj_wait results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_vrr results: parsing output: 61/ for test: gem_exec_fence results: parsing output: 62/ for test: syncobj_timeline results: parsing output: 63/ for test: kms_psr results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: syncobj_wait results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: gem_exec_schedule results: parsing output: 68/ for test: kms_prop_blob results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_exec_schedule results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: gem_ppgtt results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: gem_madvise results: parsing output: 78/ for test: kms_ccs results: parsing output: 79/ for test: gem_spin_batch results: parsing output: 80/ for test: kms_chamelium_audio results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: gem_exec_balancer results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: kms_cursor_legacy results: parsing output: 85/ for test: gem_render_copy results: parsing output: 86/ for test: kms_rotation_crc results: parsing output: 87/ for test: kms_joiner results: parsing output: 88/ for test: sysfs_heartbeat_interval results: parsing output: 89/ for test: kms_pipe_crc_basic results: parsing output: 90/ for test: kms_plane_scaling results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_cursor_crc results: parsing output: 93/ for test: prime_vgem results: parsing output: 94/ for test: gem_ctx_param results: parsing output: 95/ for test: gem_exec_store results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_flip_scaled_crc results: parsing output: 98/ for test: syncobj_timeline results: parsing output: 99/ for test: api_intel_bb results: parsing output: 100/ for test: kms_color results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: perf results: parsing output: 103/ for test: i915_pm_rpm results: parsing output: 104/ for test: kms_vblank results: parsing output: 105/ for test: kms_chamelium_edid results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: gem_render_linear_blits results: parsing output: 109/ for test: kms_chamelium_hpd results: parsing output: 110/ for test: kms_plane_scaling results: parsing output: 111/ for test: drm_read results: parsing output: 112/ for test: kms_hdr results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: gem_mmap_gtt results: parsing output: 115/ for test: i915_drm_fdinfo results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_mmap_wc results: parsing output: 119/ for test: kms_content_protection results: parsing output: 120/ for test: kms_ccs results: parsing output: 121/ for test: perf_pmu results: parsing output: 122/ for test: gem_mmap_wc results: parsing output: 123/ for test: kms_cursor_edge_walk results: parsing output: 124/ for test: kms_atomic_transition results: parsing output: 125/ for test: prime_udl results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: gem_partial_pwrite_pread results: parsing output: 128/ for test: gem_mmap_gtt results: parsing output: 129/ for test: gem_exec_await results: parsing output: 130/ for test: kms_psr2_sf results: parsing output: 131/ for test: gem_exec_schedule results: parsing output: 132/ for test: prime_mmap_coherency Done.