[73.277610] Initializing watchdogs [73.277699] /dev/watchdog0 [73.290759] [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] [73.294543] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [73.296604] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [73.300190] [001/129] (960s left) kms_big_fb (4-tiled-8bpp-rotate-270) [73.475127] Starting subtest: 4-tiled-8bpp-rotate-270 [73.506415] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.030s) [73.630697] [002/129] (960s left) sw_sync (sync_busy_fork) [73.665173] Starting subtest: sync_busy_fork [74.677355] Subtest sync_busy_fork: SUCCESS (1.015s) [74.733178] [003/129] (959s left) kms_big_fb (x-tiled-64bpp-rotate-0) [74.827171] Starting subtest: x-tiled-64bpp-rotate-0 [77.100145] Subtest x-tiled-64bpp-rotate-0: SUCCESS (2.277s) [77.614061] [004/129] (956s left) gem_exec_reloc (basic-gtt-read) [77.680745] Subtest basic-gtt-read: SKIP (0.000s) [77.755344] [005/129] (956s left) gem_softpin (allocator-nopin-reserve) [77.820557] Starting subtest: allocator-nopin-reserve [77.932183] Subtest allocator-nopin-reserve: SUCCESS (0.111s) [78.061988] [006/129] (955s left) gem_userptr_blits (stress-mm-invalidate-close) [78.135765] Starting subtest: stress-mm-invalidate-close [80.282286] Subtest stress-mm-invalidate-close: SUCCESS (2.148s) [80.420125] [007/129] (953s left) syncobj_basic (bad-pad-handle-to-fd) [80.472843] Starting subtest: bad-pad-handle-to-fd [80.475250] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [80.562794] [008/129] (953s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [80.668030] Starting subtest: yf-tiled-addfb-size-offset-overflow [80.672279] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [80.766651] [009/129] (953s left) kms_atomic (plane-invalid-params-fence) [80.864700] Starting subtest: plane-invalid-params-fence [80.866858] Starting dynamic subtest: pipe-A-eDP-1 [81.243208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.377s) [81.245587] Subtest plane-invalid-params-fence: SUCCESS (0.377s) [82.053152] [010/129] (952s left) vgem_basic (second-client) [82.136297] Starting subtest: second-client [82.158486] Subtest second-client: SUCCESS (0.022s) [82.211747] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true [82.214378] [011/129] (951s left) kms_color (degamma) [82.309974] Starting subtest: degamma [82.312486] Starting dynamic subtest: pipe-A-eDP-1 [83.023094] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s) [83.031212] Starting dynamic subtest: pipe-B-eDP-1 [84.449434] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.426s) [84.457562] Starting dynamic subtest: pipe-C-eDP-1 [85.821873] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s) [85.831366] Starting dynamic subtest: pipe-D-eDP-1 [87.188824] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.369s) [87.191285] Subtest degamma: SUCCESS (4.879s) [87.967999] [012/129] (946s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [88.096281] Starting subtest: cursor-vs-flip-atomic-transitions [117.814972] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.718s) [118.690419] [013/129] (915s left) gem_exec_params (invalid-bsd2-flag-on-render) [118.750909] Starting subtest: invalid-bsd2-flag-on-render [118.753326] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s) [118.863512] [014/129] (915s left) perf (global-sseu-config) [118.969443] Starting subtest: global-sseu-config [118.974134] Subtest global-sseu-config: SKIP (0.000s) [119.006994] [015/129] (915s left) syncobj_basic (bad-create-flags) [119.064034] Starting subtest: bad-create-flags [119.066263] Subtest bad-create-flags: SUCCESS (0.000s) [119.173114] [016/129] (915s left) gem_lmem_swapping (random-engines) [119.211598] Subtest random-engines: SKIP (0.000s) [119.244765] [017/129] (915s left) kms_big_fb (y-tiled-32bpp-rotate-0) [119.349421] Starting subtest: y-tiled-32bpp-rotate-0 [119.353590] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [119.452171] [018/129] (914s left) gem_exec_flush (basic-wb-rw-default) [119.513421] Starting subtest: basic-wb-rw-default [124.987868] Subtest basic-wb-rw-default: SUCCESS (5.474s) [125.179241] [019/129] (909s left) gem_exec_schedule (u-fairslice-all) [125.256073] Starting subtest: u-fairslice-all [127.333347] Subtest u-fairslice-all: SUCCESS (2.076s) [129.018227] [020/129] (905s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [129.124156] Starting subtest: primary-y-tiled-reflect-x-90 [129.128773] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [129.192911] [021/129] (905s left) kms_content_protection (atomic-dpms) [129.367524] Starting subtest: atomic-dpms [132.722490] Subtest atomic-dpms: SKIP (3.352s) [133.891390] [022/129] (900s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [134.016844] Starting subtest: cursorB-vs-flipA-legacy [134.021383] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s) [134.110671] [023/129] (900s left) gem_ctx_engines (execute-one) [134.187398] Starting subtest: execute-one [136.181517] Subtest execute-one: SUCCESS (1.994s) [136.976832] [024/129] (897s left) kms_psr (psr2-sprite-mmap-gtt) [137.087827] Starting subtest: psr2-sprite-mmap-gtt [137.090210] Starting dynamic subtest: eDP-1 [138.488677] Dynamic subtest eDP-1: SKIP (1.398s) [138.493527] Subtest psr2-sprite-mmap-gtt: SKIP (1.399s) [138.641553] [025/129] (895s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [138.749602] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [143.380634] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (4.635s) [143.530307] [026/129] (891s left) gem_vm_create (invalid-create) [143.589921] Starting subtest: invalid-create [143.592327] Subtest invalid-create: SUCCESS (0.002s) [143.701397] [027/129] (890s left) kms_atomic_interruptible (legacy-cursor) [143.804941] Starting subtest: legacy-cursor [143.807413] Starting dynamic subtest: pipe-A-eDP-1 [151.176462] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.372s) [151.178812] Subtest legacy-cursor: SUCCESS (7.372s) [152.010548] [028/129] (882s left) sysfs_heartbeat_interval (mixed) [152.067875] Starting subtest: mixed [152.070397] Starting dynamic subtest: vecs0 [157.308055] Dynamic subtest vecs0: SUCCESS (5.238s) [157.316144] Starting dynamic subtest: ccs0 [162.520550] Dynamic subtest ccs0: SUCCESS (5.212s) [162.529976] Starting dynamic subtest: vcs0 [167.706937] Dynamic subtest vcs0: SUCCESS (5.185s) [167.716267] Starting dynamic subtest: bcs0 [172.961466] Dynamic subtest bcs0: SUCCESS (5.253s) [172.971087] Starting dynamic subtest: rcs0 [178.209406] Dynamic subtest rcs0: SUCCESS (5.247s) [178.219384] Starting dynamic subtest: vcs1 [183.449451] Dynamic subtest vcs1: SUCCESS (5.239s) [183.452267] Subtest mixed: SUCCESS (31.378s) [183.523248] [029/129] (851s left) gem_eio (in-flight-external) [183.743925] Starting subtest: in-flight-external [185.011311] Subtest in-flight-external: SUCCESS (1.267s) [185.151717] [030/129] (849s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [185.262300] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [185.266493] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [185.343040] [031/129] (849s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [185.442527] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [188.914368] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (3.476s) [189.056543] [032/129] (845s left) prime_vgem (coherency-gtt) [189.135579] Starting subtest: coherency-gtt [189.139404] Subtest coherency-gtt: SKIP (0.000s) [189.256894] [033/129] (845s left) kms_pipe_crc_basic (suspend-read-crc) [189.346556] Starting subtest: suspend-read-crc [189.348382] Starting dynamic subtest: pipe-A-eDP-1 [206.896899] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.582s) [206.906312] Starting dynamic subtest: pipe-B-eDP-1 [224.558156] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.868s) [224.568728] Starting dynamic subtest: pipe-C-eDP-1 [242.513255] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.740s) [242.521510] Starting dynamic subtest: pipe-D-eDP-1 [260.499898] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.704s) [260.502615] Subtest suspend-read-crc: SUCCESS (10.898s) [261.316702] [034/129] (833s left) kms_big_fb (x-tiled-8bpp-rotate-270) [261.428201] Starting subtest: x-tiled-8bpp-rotate-270 [261.451971] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s) [261.585765] [035/129] (833s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [261.653317] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [261.658140] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [261.830053] [036/129] (833s left) i915_pm_rps (thresholds) [261.889746] Starting subtest: thresholds [261.895764] Subtest thresholds: SKIP (0.000s) [261.971325] [037/129] (833s left) gem_exec_create (basic) [262.027234] Starting subtest: basic [262.029846] Starting dynamic subtest: smem [265.451180] Dynamic subtest smem: SUCCESS (3.511s) [265.453936] Subtest basic: SUCCESS (3.512s) [265.626159] [038/129] (829s left) sw_sync (alloc_merge_fence) [265.661615] Starting subtest: alloc_merge_fence [265.663970] Subtest alloc_merge_fence: SUCCESS (0.000s) [265.709778] [039/129] (829s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [265.808800] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [265.811547] Starting dynamic subtest: pipe-A-eDP-1 [282.187827] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.400s) [282.195770] Starting dynamic subtest: pipe-B-eDP-1 [299.076899] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.330s) [299.086851] Starting dynamic subtest: pipe-C-eDP-1 [316.035138] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.315s) [316.043713] Starting dynamic subtest: pipe-D-eDP-1 [333.047112] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.251s) [333.049750] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.298s) [334.211514] [040/129] (819s left) gem_close_race (basic-threads) [334.279091] Starting subtest: basic-threads [335.709683] Subtest basic-threads: SUCCESS (1.477s) [335.890231] [041/129] (818s left) gem_ccs (suspend-resume) [335.958781] Starting subtest: suspend-resume [335.963922] Subtest suspend-resume: SKIP (0.000s) [336.038095] [042/129] (818s left) gem_exec_balancer (indices) [336.100676] Starting subtest: indices [338.602760] Subtest indices: SUCCESS (2.563s) [338.914634] [043/129] (815s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [343.896432] Starting subtest: pr-overlay-plane-move-continuous-sf [343.902327] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [344.726285] [044/129] (809s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [344.826593] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [344.829283] Starting dynamic subtest: A-eDP1 [348.407499] Dynamic subtest A-eDP1: SUCCESS (3.605s) [348.417404] Starting dynamic subtest: B-eDP1 [351.476757] Dynamic subtest B-eDP1: SUCCESS (3.083s) [351.486479] Starting dynamic subtest: C-eDP1 [354.549375] Dynamic subtest C-eDP1: SUCCESS (3.082s) [354.557862] Starting dynamic subtest: D-eDP1 [357.623105] Dynamic subtest D-eDP1: SUCCESS (3.080s) [357.625276] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.858s) [358.415682] [045/129] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [358.529653] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [358.535364] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [358.634010] [046/129] (795s left) kms_big_fb (linear-16bpp-rotate-180) [358.750802] Starting subtest: linear-16bpp-rotate-180 [360.182609] Subtest linear-16bpp-rotate-180: SUCCESS (1.433s) [360.343222] [047/129] (793s left) gem_exec_fence (syncobj-channel) [360.805379] Starting subtest: syncobj-channel [361.831773] Subtest syncobj-channel: SUCCESS (1.024s) [362.729856] [048/129] (791s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [362.842874] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [362.847571] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [362.961525] [049/129] (791s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [363.068737] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [363.074676] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [363.188390] [050/129] (790s left) i915_pciid [363.337513] [051/129] (790s left) gem_madvise (dontneed-before-mmap) [363.376296] Starting subtest: dontneed-before-mmap [363.395655] Subtest dontneed-before-mmap: SUCCESS (0.020s) [363.495764] [052/129] (790s left) gem_pxp (hw-rejects-pxp-buffer) [363.614103] Starting subtest: hw-rejects-pxp-buffer [363.619808] Subtest hw-rejects-pxp-buffer: SKIP (0.000s) [363.730101] [053/129] (790s left) gem_exec_schedule (implicit-boths) [363.810256] Starting subtest: implicit-boths [363.812315] Starting dynamic subtest: rcs0 [363.910408] Dynamic subtest rcs0: SUCCESS (0.108s) [363.922169] Starting dynamic subtest: vcs0 [363.998618] Dynamic subtest vcs0: SUCCESS (0.088s) [364.010583] Starting dynamic subtest: vcs1 [364.076297] Dynamic subtest vcs1: SUCCESS (0.077s) [364.084591] Starting dynamic subtest: vecs0 [364.157734] Dynamic subtest vecs0: SUCCESS (0.080s) [364.169365] Starting dynamic subtest: ccs0 [364.239219] Dynamic subtest ccs0: SUCCESS (0.081s) [364.241680] Subtest implicit-boths: SUCCESS (0.437s) [365.746580] [054/129] (788s left) gem_mmap_gtt (big-copy-xy) [365.805342] Subtest big-copy-XY: SKIP (0.000s) [365.864725] [055/129] (788s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [365.989449] Starting subtest: flip-vs-cursor-crc-legacy [366.597257] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.607s) [367.425233] [056/129] (786s left) kms_addfb_basic (addfb25-4-tiled) [367.525298] Starting subtest: addfb25-4-tiled [367.527621] Subtest addfb25-4-tiled: SUCCESS (0.000s) [367.631322] [057/129] (786s left) gem_exec_schedule (pi-shared-iova) [367.832371] Starting subtest: pi-shared-iova [367.834730] Starting dynamic subtest: rcs0 [367.906552] Dynamic subtest rcs0: SUCCESS (0.076s) [367.918592] Starting dynamic subtest: vcs0 [367.958222] Dynamic subtest vcs0: SUCCESS (0.051s) [367.969516] Starting dynamic subtest: vcs1 [368.009937] Dynamic subtest vcs1: SUCCESS (0.051s) [368.020290] Starting dynamic subtest: vecs0 [368.061031] Dynamic subtest vecs0: SUCCESS (0.051s) [368.073801] Starting dynamic subtest: ccs0 [368.112479] Dynamic subtest ccs0: SUCCESS (0.051s) [368.115275] Subtest pi-shared-iova: SUCCESS (0.284s) [369.785486] [058/129] (784s left) perf_pmu (semaphore-busy) [369.828879] Starting subtest: semaphore-busy [369.831304] Starting dynamic subtest: rcs0 [371.498762] Dynamic subtest rcs0: SUCCESS (1.670s) [371.511176] Starting dynamic subtest: bcs0 [373.135899] Dynamic subtest bcs0: SUCCESS (1.633s) [373.148870] Starting dynamic subtest: vcs0 [377.161649] Dynamic subtest vcs0: SUCCESS (4.029s) [377.173897] Starting dynamic subtest: vcs1 [383.176794] Dynamic subtest vcs1: SUCCESS (6.016s) [383.188792] Starting dynamic subtest: vecs0 [389.128974] Dynamic subtest vecs0: SUCCESS (5.953s) [389.140030] Starting dynamic subtest: ccs0 [392.266517] Dynamic subtest ccs0: SUCCESS (3.137s) [392.269437] Subtest semaphore-busy: SUCCESS (22.450s) [392.376993] [059/129] (762s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [392.475112] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [392.477277] Starting dynamic subtest: pipe-A-default-mode [392.759723] Dynamic subtest pipe-A-default-mode: SKIP (0.280s) [392.765434] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.281s) [393.635014] [060/129] (760s left) gem_ctx_isolation (preservation-s3) [393.707185] Starting subtest: preservation-S3 [393.709738] Starting dynamic subtest: rcs0 [410.081788] Dynamic subtest rcs0: SUCCESS (1.534s) [410.090633] Starting dynamic subtest: bcs0 [425.985152] Dynamic subtest bcs0: SUCCESS (1.434s) [425.995070] Starting dynamic subtest: vcs0 [441.998376] Dynamic subtest vcs0: SUCCESS (3.166s) [442.008395] Starting dynamic subtest: vcs1 [460.076784] Dynamic subtest vcs1: SUCCESS (5.235s) [460.088993] Starting dynamic subtest: vecs0 [478.074437] Dynamic subtest vecs0: SUCCESS (5.113s) [478.086981] Starting dynamic subtest: ccs0 [495.996734] Dynamic subtest ccs0: SUCCESS (3.318s) [495.999067] Subtest preservation-S3: SUCCESS (19.804s) [496.230016] [061/129] (740s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [496.336765] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [496.341068] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [496.412510] [062/129] (740s left) drm_fdinfo (virtual-busy-idle) [496.451462] Starting subtest: virtual-busy-idle [496.455677] Subtest virtual-busy-idle: SKIP (0.000s) [496.510531] [063/129] (740s left) gem_softpin (evict-active) [496.580089] Starting subtest: evict-active [496.585429] Subtest evict-active: SUCCESS (0.006s) [496.717685] [064/129] (740s left) gem_ctx_shared (q-in-order) [496.788645] Starting subtest: Q-in-order [496.791023] Starting dynamic subtest: rcs0 [496.887784] Dynamic subtest rcs0: SUCCESS (0.102s) [496.904654] Starting dynamic subtest: vcs0 [496.985074] Dynamic subtest vcs0: SUCCESS (0.101s) [497.001094] Starting dynamic subtest: vcs1 [497.062936] Dynamic subtest vcs1: SUCCESS (0.078s) [497.079219] Starting dynamic subtest: vecs0 [497.134559] Dynamic subtest vecs0: SUCCESS (0.073s) [497.151082] Starting dynamic subtest: ccs0 [497.204822] Dynamic subtest ccs0: SUCCESS (0.074s) [497.206743] Subtest Q-in-order: SUCCESS (0.432s) [498.719071] [065/129] (738s left) api_intel_bb (object-noreloc-keep-cache-simple) [498.775688] Starting subtest: object-noreloc-keep-cache-simple [498.778068] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s) [498.888630] [066/129] (738s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [498.997714] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [505.452843] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.576s) [505.556759] [067/129] (731s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [505.673171] Starting subtest: psr-farfromfence-mmap-gtt [505.677356] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [505.787617] [068/129] (731s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [505.889988] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [505.894070] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [505.971989] [069/129] (731s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [506.076607] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [506.078730] Starting dynamic subtest: pipe-A-default-mode [508.773326] Dynamic subtest pipe-A-default-mode: SUCCESS (2.718s) [508.775673] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.719s) [509.625431] [070/129] (727s left) kms_psr (fbc-psr2-sprite-render) [509.726663] Starting subtest: fbc-psr2-sprite-render [509.728592] Starting dynamic subtest: eDP-1 [509.732825] Dynamic subtest eDP-1: SKIP (0.000s) [509.737053] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [509.797550] [071/129] (727s left) gen9_exec_parse (bb-start-far) [509.852835] Subtest bb-start-far: SKIP (0.000s) [509.931610] [072/129] (727s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [510.032781] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [510.036830] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [510.130687] [073/129] (727s left) kms_psr (fbc-pr-cursor-plane-onoff) [510.231828] Starting subtest: fbc-pr-cursor-plane-onoff [510.236278] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [510.298364] [074/129] (726s left) kms_cursor_crc (cursor-sliding-max-size) [510.554782] Starting subtest: cursor-sliding-max-size [510.560666] Subtest cursor-sliding-max-size: SKIP (0.000s) [510.693886] [075/129] (726s left) kms_psr (psr2-sprite-plane-move) [510.782567] Starting subtest: psr2-sprite-plane-move [510.784617] Starting dynamic subtest: eDP-1 [512.543897] Dynamic subtest eDP-1: SUCCESS (1.769s) [512.546377] Subtest psr2-sprite-plane-move: SUCCESS (1.770s) [513.369570] [076/129] (723s left) gem_workarounds (basic-read) [513.427200] Starting subtest: basic-read [513.437458] Subtest basic-read: SUCCESS (0.009s) [513.577119] [077/129] (723s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [513.666773] Starting subtest: fbc-dirtyfb-ioctl [513.669043] Starting dynamic subtest: A-eDP-1 [515.268441] Dynamic subtest A-eDP-1: SUCCESS (1.605s) [515.270915] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.606s) [516.090774] [078/129] (721s left) gem_mmap_offset (partial-unmap) [516.146071] Starting subtest: partial-unmap [516.148068] Starting dynamic subtest: smem0 [516.640271] Dynamic subtest smem0: SUCCESS (0.495s) [516.643225] Subtest partial-unmap: SUCCESS (0.496s) [516.768341] [079/129] (720s left) kms_lease (lease-invalid-connector) [516.860697] Starting subtest: lease-invalid-connector [516.863038] Starting dynamic subtest: pipe-A-eDP-1 [516.865399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [516.875129] Starting dynamic subtest: pipe-B-eDP-1 [516.877117] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [516.885767] Starting dynamic subtest: pipe-C-eDP-1 [516.887923] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [516.896271] Starting dynamic subtest: pipe-D-eDP-1 [516.899390] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [516.901343] Subtest lease-invalid-connector: SUCCESS (0.004s) [516.931775] [080/129] (720s left) kms_chamelium_color (ctm-red-to-blue) [517.035650] Subtest ctm-red-to-blue: SKIP (0.000s) [517.075267] [081/129] (720s left) prime_mmap (test_errors) [517.135101] Starting subtest: test_errors [517.137394] Starting dynamic subtest: test_errors-smem [517.236264] Dynamic subtest test_errors-smem: SUCCESS (0.103s) [517.238841] Subtest test_errors: SUCCESS (0.104s) [517.325689] [082/129] (720s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling) [517.434410] Starting subtest: planes-downscale-factor-0-25-unity-scaling [517.436922] Starting dynamic subtest: pipe-A [517.452658] Dynamic subtest pipe-A: SKIP (0.012s) [517.462647] Starting dynamic subtest: pipe-B [517.474681] Dynamic subtest pipe-B: SKIP (0.020s) [517.484045] Starting dynamic subtest: pipe-C [517.493176] Dynamic subtest pipe-C: SKIP (0.020s) [517.502062] Starting dynamic subtest: pipe-D [517.514715] Dynamic subtest pipe-D: SKIP (0.020s) [517.519040] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (0.074s) [517.624525] [083/129] (719s left) prime_busy (hang) [517.686975] Starting subtest: hang [517.689149] Starting dynamic subtest: rcs0 [544.145936] Dynamic subtest rcs0: SUCCESS (26.463s) [544.156374] Starting dynamic subtest: bcs0 [551.302772] Dynamic subtest bcs0: SUCCESS (7.152s) [551.313427] Starting dynamic subtest: vcs0 [558.279202] Dynamic subtest vcs0: SUCCESS (6.976s) [558.289960] Starting dynamic subtest: vcs1 [565.317505] Dynamic subtest vcs1: SUCCESS (7.038s) [565.328579] Starting dynamic subtest: vecs0 [572.286650] Dynamic subtest vecs0: SUCCESS (6.972s) [572.295614] Starting dynamic subtest: ccs0 [586.123311] Dynamic subtest ccs0: SUCCESS (13.835s) [586.125425] Subtest hang: SUCCESS (68.444s) [586.253785] [084/129] (651s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [586.362897] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [590.957804] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.598s) [591.118139] [085/129] (646s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [591.178996] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [591.181291] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [591.289196] [086/129] (646s left) gem_ctx_bad_destroy (invalid-ctx) [591.344437] Starting subtest: invalid-ctx [591.346725] Subtest invalid-ctx: SUCCESS (0.000s) [591.412864] [087/129] (646s left) kms_flip (flip-vs-fences-interruptible) [591.510869] Starting subtest: flip-vs-fences-interruptible [591.515174] Subtest flip-vs-fences-interruptible: SKIP (0.000s) [591.617712] [088/129] (646s left) drm_fdinfo (all-busy-check-all) [591.657194] Starting subtest: all-busy-check-all [591.664732] Subtest all-busy-check-all: SKIP (0.004s) [591.727295] [089/129] (645s left) kms_vrr (flip-dpms) [591.860706] Starting subtest: flip-dpms [591.867143] Subtest flip-dpms: SKIP (0.000s) [591.924855] [090/129] (645s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format) [592.022078] Starting subtest: plane-downscale-factor-0-25-with-pixel-format [592.024234] Starting dynamic subtest: pipe-A [592.038049] Dynamic subtest pipe-A: SKIP (0.011s) [592.047594] Starting dynamic subtest: pipe-B [592.057820] Dynamic subtest pipe-B: SKIP (0.020s) [592.066712] Starting dynamic subtest: pipe-C [592.080056] Dynamic subtest pipe-C: SKIP (0.020s) [592.088871] Starting dynamic subtest: pipe-D [592.124342] Dynamic subtest pipe-D: SKIP (0.043s) [592.127841] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (0.098s) [592.208559] [091/129] (645s left) sysfs_heartbeat_interval (idempotent) [592.263797] Starting subtest: idempotent [592.265804] Starting dynamic subtest: vecs0 [592.267705] Dynamic subtest vecs0: SUCCESS (0.000s) [592.278053] Starting dynamic subtest: ccs0 [592.279768] Dynamic subtest ccs0: SUCCESS (0.001s) [592.287805] Starting dynamic subtest: vcs0 [592.289555] Dynamic subtest vcs0: SUCCESS (0.000s) [592.297555] Starting dynamic subtest: bcs0 [592.299321] Dynamic subtest bcs0: SUCCESS (0.001s) [592.307684] Starting dynamic subtest: rcs0 [592.309235] Dynamic subtest rcs0: SUCCESS (0.000s) [592.316866] Starting dynamic subtest: vcs1 [592.318736] Dynamic subtest vcs1: SUCCESS (0.000s) [592.320471] Subtest idempotent: SUCCESS (0.007s) [592.358336] [092/129] (645s left) gem_wait (invalid-buf) [592.420039] Starting subtest: invalid-buf [592.422179] Subtest invalid-buf: SUCCESS (0.000s) [592.653465] [093/129] (645s left) gem_mmap_gtt (close-race) [592.715333] Subtest close-race: SKIP (0.000s) [592.798061] [094/129] (645s left) kms_joiner (basic-force-ultra-joiner) [592.895207] Starting subtest: basic-force-ultra-joiner [592.899396] Subtest basic-force-ultra-joiner: SKIP (0.000s) [592.955640] [095/129] (644s left) gem_flink_basic (flink-lifetime) [593.014429] Starting subtest: flink-lifetime [593.016570] Subtest flink-lifetime: SUCCESS (0.002s) [593.115973] [096/129] (644s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [594.754569] Starting subtest: modeset-lpsp-stress-no-wait [604.528196] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.773s) [604.600098] [097/129] (633s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [604.997478] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [605.777832] [098/129] (632s left) gem_exec_fence (invalid-fence-array) [606.193815] Starting subtest: invalid-fence-array [606.196201] Subtest invalid-fence-array: SUCCESS (0.002s) [607.718888] [099/129] (630s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [607.820711] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc [607.823090] Starting dynamic subtest: pipe-A-eDP-1 [607.846714] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [607.857742] Starting dynamic subtest: pipe-B-eDP-1 [607.879584] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [607.888450] Starting dynamic subtest: pipe-C-eDP-1 [607.911789] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [607.922522] Starting dynamic subtest: pipe-D-eDP-1 [607.943263] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [607.947504] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [609.955670] [100/129] (628s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [610.061666] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [610.065623] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [610.161529] [101/129] (627s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [610.265231] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [610.269725] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [610.366962] [102/129] (627s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [615.396463] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf [615.401572] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s) [616.251748] [103/129] (621s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [616.346668] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [616.348950] Starting dynamic subtest: pipe-A-eDP-1 [616.358302] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [616.368632] Starting dynamic subtest: pipe-B-eDP-1 [616.377710] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [616.387588] Starting dynamic subtest: pipe-C-eDP-1 [616.398377] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [616.406661] Starting dynamic subtest: pipe-D-eDP-1 [616.415194] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [616.419356] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s) [618.517430] [104/129] (619s left) kms_panel_fitting (legacy) [618.612260] Starting subtest: legacy [618.614592] Starting dynamic subtest: pipe-A-eDP-1 [619.204563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.591s) [619.231096] Starting dynamic subtest: pipe-B-eDP-1 [620.814353] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.590s) [620.842849] Starting dynamic subtest: pipe-C-eDP-1 [622.420763] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.583s) [622.454291] Starting dynamic subtest: pipe-D-eDP-1 [624.051582] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.610s) [624.053976] Subtest legacy: SUCCESS (5.438s) [625.234799] [105/129] (613s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [625.296328] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [625.398915] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.103s) [625.467942] [106/129] (612s left) kms_selftest (drm_plane_helper) [625.504354] Starting subtest: drm_plane_helper [625.512859] Starting dynamic subtest: drm_test_check_plane_state [625.686708] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.171s) [625.695295] Starting dynamic subtest: drm_test_check_invalid_plane_state [625.806923] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.121s) [625.809341] Subtest drm_plane_helper: SUCCESS (0.303s) [626.010773] [107/129] (612s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [626.069945] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [626.174987] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [626.246775] [108/129] (612s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [631.279375] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf [631.283849] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s) [632.141896] [109/129] (606s left) syncobj_wait (reset-signaled) [632.206447] Starting subtest: reset-signaled [632.208761] Subtest reset-signaled: SUCCESS (0.000s) [632.294458] [110/129] (606s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [632.384455] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [632.396232] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s) [632.489247] [111/129] (606s left) syncobj_timeline (invalid-signal-zero-handles) [632.545116] Starting subtest: invalid-signal-zero-handles [632.547076] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [632.653490] [112/129] (605s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [632.747891] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [632.750199] Starting dynamic subtest: pipe-A-eDP-1 [634.083134] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.332s) [634.370498] Starting dynamic subtest: pipe-B-eDP-1 [635.411820] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s) [635.680178] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.928s) [636.506457] [113/129] (602s left) gem_userptr_blits (nohangcheck) [636.573193] Starting subtest: nohangcheck [636.825776] Subtest nohangcheck: SUCCESS (0.249s) [636.968948] [114/129] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [637.064185] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [637.068613] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [637.154246] [115/129] (601s left) gem_exercise_blt (fast-copy) [637.214926] Starting subtest: fast-copy [637.217350] Starting dynamic subtest: linear-smem-smem [637.239346] Dynamic subtest linear-smem-smem: SUCCESS (0.024s) [637.251280] Starting dynamic subtest: xmajor-smem-smem [637.258532] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s) [637.269106] Starting dynamic subtest: tile4-smem-smem [637.279971] Dynamic subtest tile4-smem-smem: SUCCESS (0.020s) [637.288756] Starting dynamic subtest: tile64-smem-smem [637.297708] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s) [637.300035] Subtest fast-copy: SUCCESS (0.083s) [637.417633] [116/129] (601s left) kms_cursor_crc (cursor-onscreen-64x21) [637.585684] Starting subtest: cursor-onscreen-64x21 [637.624157] Subtest cursor-onscreen-64x21: SKIP (0.036s) [637.835983] [117/129] (600s left) gem_exec_balancer (bonded-chain) [637.906886] Starting subtest: bonded-chain [644.740080] Subtest bonded-chain: SUCCESS (6.831s) [645.596715] [118/129] (593s left) kms_pm_backlight (bad-brightness) [645.698597] Starting subtest: bad-brightness [645.758051] Starting dynamic subtest: eDP-1 [646.071065] Dynamic subtest eDP-1: SUCCESS (0.312s) [646.073615] Subtest bad-brightness: SUCCESS (0.375s) [646.930108] [119/129] (591s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc) [647.037756] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc [650.091294] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (3.058s) [650.202110] [120/129] (588s left) kms_psr (pr-cursor-render) [650.297646] Starting subtest: pr-cursor-render [650.301761] Subtest pr-cursor-render: SKIP (0.000s) [650.361956] [121/129] (588s left) kms_flip (plain-flip-interruptible) [650.455270] Starting subtest: plain-flip-interruptible [650.457363] Starting dynamic subtest: A-eDP1 [652.156478] Dynamic subtest A-eDP1: SUCCESS (1.701s) [652.165730] Starting dynamic subtest: B-eDP1 [653.885176] Dynamic subtest B-eDP1: SUCCESS (1.727s) [653.896834] Starting dynamic subtest: C-eDP1 [655.498828] Dynamic subtest C-eDP1: SUCCESS (1.612s) [655.510039] Starting dynamic subtest: D-eDP1 [657.121899] Dynamic subtest D-eDP1: SUCCESS (1.622s) [657.124238] Subtest plain-flip-interruptible: SUCCESS (6.672s) [658.280416] [122/129] (580s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [658.378640] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [658.380817] Starting dynamic subtest: pipe-A-eDP-1 [658.441072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [658.451634] Starting dynamic subtest: pipe-B-eDP-1 [658.490390] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.048s) [658.500094] Starting dynamic subtest: pipe-C-eDP-1 [658.538949] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.048s) [658.549097] Starting dynamic subtest: pipe-D-eDP-1 [658.591431] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.052s) [658.593764] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.213s) [660.732022] [123/129] (578s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [660.833725] Starting subtest: fbcpsr-rgb101010-draw-render [665.526976] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.697s) [665.665826] [124/129] (573s left) api_intel_allocator (reopen) [665.727201] Starting subtest: reopen [665.732674] Subtest reopen: SUCCESS (0.006s) [665.858838] [125/129] (573s left) kms_dp_link_training (uhbr-sst) [665.956682] Starting subtest: uhbr-sst [665.965824] Subtest uhbr-sst: SKIP (0.000s) [666.025630] [126/129] (572s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [666.115830] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [666.118185] Starting dynamic subtest: pipe-A-eDP-1 [666.860227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s) [666.871633] Starting dynamic subtest: pipe-B-eDP-1 [668.613602] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.753s) [668.622363] Starting dynamic subtest: pipe-C-eDP-1 [670.432405] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.818s) [670.442852] Starting dynamic subtest: pipe-D-eDP-1 [672.263568] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.830s) [672.265859] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.140s) [673.385491] [127/129] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [673.497650] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [673.501919] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [673.596224] [128/129] (565s left) kms_vblank (ts-continuation-idle-hang) [673.699993] Starting subtest: ts-continuation-idle-hang [673.702324] Starting dynamic subtest: pipe-A-eDP-1 [700.399529] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.699s) [700.419624] Starting dynamic subtest: pipe-D-eDP-1 [725.364914] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.967s) [725.367308] Subtest ts-continuation-idle-hang: SUCCESS (51.671s) [726.215162] [129/129] (512s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [726.276043] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [726.382190] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s) [726.455129] Closing watchdogs Done.