[61.873071] Initializing watchdogs [61.873137] /dev/watchdog0 [61.892940] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [61.904462] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [61.908581] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.910992] [001/131] (960s left) kms_hdr (static-toggle-suspend) [62.104169] Starting subtest: static-toggle-suspend [62.649981] Starting dynamic subtest: pipe-A-DP-3 [83.338149] Dynamic subtest pipe-A-DP-3: SUCCESS (5.067s) [83.339315] Subtest static-toggle-suspend: SUCCESS (5.611s) [83.706889] [002/131] (938s left) kms_cursor_crc (cursor-tearing-position-change) [83.942350] Starting subtest: cursor-tearing-position-change [83.944438] Starting dynamic subtest: pipe-A-DP-3 [84.412301] Dynamic subtest pipe-A-DP-3: SUCCESS (0.467s) [84.433765] Starting dynamic subtest: pipe-D-DP-3 [84.854012] Dynamic subtest pipe-D-DP-3: SUCCESS (0.438s) [84.854926] Subtest cursor-tearing-position-change: SUCCESS (0.911s) [85.615325] [003/131] (936s left) kms_joiner (basic-ultra-joiner) [85.816191] Starting subtest: basic-ultra-joiner [85.817956] Subtest basic-ultra-joiner: SKIP (0.000s) [85.960169] [004/131] (936s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [86.139335] Starting subtest: 2x-flip-vs-cursor-atomic [86.141079] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s) [86.296120] [005/131] (936s left) gem_exec_schedule (semaphore-noskip) [86.388354] Starting subtest: semaphore-noskip [87.140507] Subtest semaphore-noskip: SUCCESS (0.753s) [87.547321] [006/131] (935s left) kms_universal_plane (universal-plane-functional) [87.730356] Starting subtest: universal-plane-functional [87.732254] Starting dynamic subtest: pipe-A-DP-3 [90.065141] Dynamic subtest pipe-A-DP-3: SUCCESS (2.333s) [90.078411] Starting dynamic subtest: pipe-B-DP-3 [92.295375] Dynamic subtest pipe-B-DP-3: SUCCESS (2.229s) [92.305715] Starting dynamic subtest: pipe-C-DP-3 [94.478634] Dynamic subtest pipe-C-DP-3: SUCCESS (2.182s) [94.492585] Starting dynamic subtest: pipe-D-DP-3 [96.669381] Dynamic subtest pipe-D-DP-3: SUCCESS (2.188s) [96.670412] Subtest universal-plane-functional: SUCCESS (8.938s) [96.995774] [007/131] (925s left) gem_ctx_sseu (invalid-args) [97.078720] Subtest invalid-args: SKIP (0.000s) [97.154809] [008/131] (925s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [97.225161] Starting subtest: invalid-multi-wait-all-unsubmitted [97.226293] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [97.385363] [009/131] (925s left) sw_sync (sync_expired_merge) [97.428467] Starting subtest: sync_expired_merge [98.502563] Subtest sync_expired_merge: SUCCESS (1.074s) [98.612765] [010/131] (924s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [98.803734] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [98.805454] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [98.996127] [011/131] (924s left) kms_flip (flip-vs-panning) [99.175185] Starting subtest: flip-vs-panning [99.179134] Starting dynamic subtest: A-DP3 [107.059085] Dynamic subtest A-DP3: SUCCESS (7.880s) [107.071433] Starting dynamic subtest: B-DP3 [114.847094] Dynamic subtest B-DP3: SUCCESS (7.787s) [114.861401] Starting dynamic subtest: C-DP3 [122.630944] Dynamic subtest C-DP3: SUCCESS (7.782s) [122.661948] Starting dynamic subtest: D-DP3 [130.429509] Dynamic subtest D-DP3: SUCCESS (7.796s) [130.434437] Subtest flip-vs-panning: SUCCESS (31.262s) [130.790792] [012/131] (892s left) i915_pm_rpm (debugfs-forcewake-user) [132.626421] Starting subtest: debugfs-forcewake-user [143.345873] Subtest debugfs-forcewake-user: SUCCESS (10.722s) [143.700946] [013/131] (879s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [143.883822] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [143.885460] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [144.087101] [014/131] (879s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [144.278628] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [144.280353] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [144.469903] [015/131] (878s left) prime_mmap (test_invalid_sync_flags) [144.539133] Starting subtest: test_invalid_sync_flags [144.540086] Starting dynamic subtest: test_invalid_sync_flags-smem [144.540992] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s) [144.551797] Starting dynamic subtest: test_invalid_sync_flags-lmem0 [144.553051] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s) [144.554153] Subtest test_invalid_sync_flags: SUCCESS (0.001s) [144.734212] [016/131] (878s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [144.810680] Starting subtest: y-tiled-to-vebox-yf-tiled [144.812806] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [145.104054] [017/131] (878s left) gem_ctx_persistence (heartbeat-hang) [145.179435] Starting subtest: heartbeat-hang [145.181354] Subtest heartbeat-hang: SKIP (0.000s) [145.383905] [018/131] (878s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling) [145.559921] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling [145.560793] Starting dynamic subtest: pipe-A-valid-mode [151.333730] Dynamic subtest pipe-A-valid-mode: SUCCESS (5.771s) [151.335096] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SUCCESS (5.773s) [151.602134] [019/131] (872s left) kms_plane (planar-pixel-format-settings) [151.788692] Starting subtest: planar-pixel-format-settings [151.845441] Subtest planar-pixel-format-settings: SUCCESS (0.056s) [152.044057] [020/131] (871s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [152.225804] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [152.227446] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [152.432119] [021/131] (871s left) kms_content_protection (uevent) [152.691361] Starting subtest: uevent [152.715583] Starting dynamic subtest: pipe-A-DP-3 [186.862482] Dynamic subtest pipe-A-DP-3: FAIL (34.099s) [186.924626] Subtest uevent: FAIL (34.232s) [187.256892] [022/131] (836s left) kms_atomic (atomic-invalid-params) [187.442223] Starting subtest: atomic-invalid-params [187.443151] Starting dynamic subtest: pipe-A-DP-3 [188.017672] Dynamic subtest pipe-A-DP-3: SUCCESS (0.575s) [188.018704] Subtest atomic-invalid-params: SUCCESS (0.576s) [188.326342] [023/131] (835s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [188.510683] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [188.512377] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [188.707022] [024/131] (835s left) kms_psr (fbc-psr2-primary-page-flip) [188.890623] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s) [188.950991] [025/131] (835s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [189.139045] Starting subtest: y-tiled-addfb-size-offset-overflow [189.140748] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [189.341454] [026/131] (834s left) prime_mmap (test_forked_cpu_write) [189.411661] Starting subtest: test_forked_cpu_write [189.412610] Starting dynamic subtest: test_forked_cpu_write-smem [189.420711] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s) [189.431666] Starting dynamic subtest: test_forked_cpu_write-lmem0 [189.432772] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.008s) [189.433780] Subtest test_forked_cpu_write: SUCCESS (0.019s) [189.634453] [027/131] (834s left) kms_prime (basic-crc-hybrid) [189.810580] Subtest basic-crc-hybrid: SKIP (0.000s) [190.057552] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true [190.059424] [028/131] (834s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [190.250762] Starting subtest: fbc-2p-primscrn-spr-indfb-move [190.252480] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [190.460172] [029/131] (834s left) kms_cursor_crc (cursor-rapid-movement-256x85) [190.896827] Starting subtest: cursor-rapid-movement-256x85 [190.901363] Starting dynamic subtest: pipe-A-DP-3 [191.371538] Dynamic subtest pipe-A-DP-3: SUCCESS (0.470s) [191.422252] Starting dynamic subtest: pipe-D-DP-3 [191.819573] Dynamic subtest pipe-D-DP-3: SUCCESS (0.407s) [191.820540] Subtest cursor-rapid-movement-256x85: SUCCESS (0.922s) [192.210593] [030/131] (832s left) gem_exec_flush (basic-wb-prw-default) [192.312665] Subtest basic-wb-prw-default: SKIP (0.000s) [192.399106] [031/131] (832s left) gem_exec_reloc (basic-cpu-noreloc) [192.484654] Subtest basic-cpu-noreloc: SKIP (0.000s) [192.593506] [032/131] (832s left) gem_exec_balancer (full-pulse) [192.688098] Starting subtest: full-pulse [194.864470] Subtest full-pulse: SUCCESS (2.176s) [195.321949] [033/131] (829s left) i915_drm_fdinfo (most-busy-check-all) [195.392326] Starting subtest: most-busy-check-all [195.393252] Starting dynamic subtest: rcs0 [195.421073] Dynamic subtest rcs0: SKIP (0.028s) [195.433046] Starting dynamic subtest: bcs0 [195.435353] Dynamic subtest bcs0: SKIP (0.000s) [195.446925] Starting dynamic subtest: vcs0 [195.449280] Dynamic subtest vcs0: SKIP (0.000s) [195.460771] Starting dynamic subtest: vcs1 [195.462808] Dynamic subtest vcs1: SKIP (0.000s) [195.474276] Starting dynamic subtest: vecs0 [195.476322] Dynamic subtest vecs0: SKIP (0.000s) [195.487397] Starting dynamic subtest: vecs1 [195.489373] Dynamic subtest vecs1: SKIP (0.000s) [195.500646] Starting dynamic subtest: ccs0 [195.503536] Dynamic subtest ccs0: SKIP (0.000s) [195.506077] Subtest most-busy-check-all: SKIP (0.034s) [195.553074] [034/131] (829s left) kms_psr (psr-primary-blt) [195.779725] Subtest psr-primary-blt: SKIP (0.000s) [195.849298] [035/131] (829s left) syncobj_timeline (etime-multi-wait-all-submitted) [195.931441] Starting subtest: etime-multi-wait-all-submitted [196.040643] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s) [196.191691] [036/131] (828s left) gem_render_copy_redux (flink) [196.278553] Starting subtest: flink [199.493454] Subtest flink: SUCCESS (3.215s) [199.734979] [037/131] (825s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [199.930252] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [199.982083] [038/131] (825s left) gem_lmem_swapping (massive-random) [202.764485] Starting subtest: massive-random [202.765427] Starting dynamic subtest: lmem0 [208.868671] Dynamic subtest lmem0: SUCCESS (6.103s) [208.869584] Subtest massive-random: SUCCESS (6.104s) [210.094834] [FACT gem_lmem_swapping (massive-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [210.095807] [FACT gem_lmem_swapping (massive-random)] deleted: kernel.kmod_is_loaded.i915: true [210.097557] [039/131] (815s left) kms_cursor_legacy (single-move) [211.858368] Starting subtest: single-move [211.859331] Starting dynamic subtest: pipe-A [217.239802] Dynamic subtest pipe-A: SUCCESS (5.381s) [217.250685] Starting dynamic subtest: pipe-B [222.619987] Dynamic subtest pipe-B: SUCCESS (5.379s) [222.630550] Starting dynamic subtest: pipe-C [227.999972] Dynamic subtest pipe-C: SUCCESS (5.379s) [228.010482] Starting dynamic subtest: pipe-D [233.379729] Dynamic subtest pipe-D: SUCCESS (5.379s) [233.390565] Starting dynamic subtest: all-pipes [238.759858] Dynamic subtest all-pipes: SUCCESS (5.379s) [238.760718] Subtest single-move: SUCCESS (26.901s) [238.951738] [FACT kms_cursor_legacy (single-move)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [238.954558] [FACT kms_cursor_legacy (single-move)] new: kernel.kmod_is_loaded.i915: true [238.956997] [040/131] (786s left) kms_chamelium_edid (dp-mode-timings) [239.234459] Subtest dp-mode-timings: SKIP (0.000s) [239.392705] [041/131] (785s left) kms_chamelium_hpd (hdmi-hpd-fast) [239.661608] Subtest hdmi-hpd-fast: SKIP (0.000s) [239.813184] [042/131] (785s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [239.999549] Starting subtest: short-flip-after-cursor-atomic-transitions [241.061893] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.063s) [241.418909] [043/131] (784s left) gem_exec_params (invalid-bsd-ring) [241.506572] Starting subtest: invalid-bsd-ring [241.507461] Subtest invalid-bsd-ring: SUCCESS (0.000s) [241.718639] [044/131] (783s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [241.915239] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [241.917048] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [242.104700] [045/131] (783s left) kms_panel_fitting (atomic-fastset) [242.292143] Starting subtest: atomic-fastset [242.293817] Subtest atomic-fastset: SKIP (0.000s) [242.488534] [046/131] (783s left) dumb_buffer (invalid-bpp) [242.565707] Starting subtest: invalid-bpp [242.566613] Subtest invalid-bpp: SUCCESS (0.000s) [242.762135] [047/131] (783s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [242.958311] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [242.959903] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [243.169819] [048/131] (782s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [243.366474] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [243.368049] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [243.569579] [049/131] (782s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [243.754777] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [243.757175] Starting dynamic subtest: pipe-A-DP-3 [243.765695] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [243.776694] Starting dynamic subtest: pipe-B-DP-3 [243.785265] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [243.796064] Starting dynamic subtest: pipe-C-DP-3 [243.804197] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [243.815089] Starting dynamic subtest: pipe-D-DP-3 [243.825722] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [243.827738] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.006s) [244.250423] [050/131] (781s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [244.441010] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [244.442648] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [244.649973] [051/131] (781s left) gem_ctx_create (basic-files) [244.745571] Starting subtest: basic-files [246.755821] Subtest basic-files: SUCCESS (2.010s) [247.265103] [052/131] (778s left) gem_linear_blits (basic) [247.768687] Starting subtest: basic [247.805500] Subtest basic: SUCCESS (0.037s) [248.067088] [053/131] (778s left) kms_frontbuffer_tracking (fbc-tiling-4) [248.319407] Starting subtest: fbc-tiling-4 [250.981305] Subtest fbc-tiling-4: SUCCESS (2.662s) [251.247138] [054/131] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [251.441279] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [251.443106] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [251.648029] [055/131] (774s left) gem_exec_params (invalid-flag) [251.733410] Starting subtest: invalid-flag [251.734335] Subtest invalid-flag: SUCCESS (0.000s) [251.953420] [056/131] (774s left) kms_properties (connector-properties-atomic) [252.144443] Starting subtest: connector-properties-atomic [252.145371] Starting dynamic subtest: pipe-A-DP-3 [253.689841] Dynamic subtest pipe-A-DP-3: SUCCESS (1.544s) [253.706835] Starting dynamic subtest: pipe-None-DP-1 [253.708761] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s) [253.722678] Starting dynamic subtest: pipe-None-DP-2 [253.724820] Dynamic subtest pipe-None-DP-2: SUCCESS (0.002s) [253.736769] Starting dynamic subtest: pipe-None-HDMI-A-1 [253.738977] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.002s) [253.750387] Starting dynamic subtest: pipe-None-HDMI-A-2 [253.752164] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.002s) [253.763748] Starting dynamic subtest: pipe-None-DP-4 [253.765622] Dynamic subtest pipe-None-DP-4: SUCCESS (0.002s) [253.777416] Starting dynamic subtest: pipe-None-HDMI-A-3 [253.779177] Dynamic subtest pipe-None-HDMI-A-3: SUCCESS (0.002s) [253.780142] Subtest connector-properties-atomic: SUCCESS (1.568s) [254.062019] [057/131] (772s left) api_intel_bb (purge-bb) [254.142725] Starting subtest: purge-bb [254.173135] Subtest purge-bb: SUCCESS (0.031s) [254.361907] [058/131] (772s left) gem_tiled_blits (normal) [254.449718] Subtest normal: SKIP (0.000s) [254.522527] [059/131] (772s left) syncobj_wait (multi-wait-for-submit-submitted) [254.609688] Starting subtest: multi-wait-for-submit-submitted [254.711480] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s) [254.904873] [060/131] (772s left) kms_addfb_basic (bad-pitch-0) [254.982787] Starting subtest: bad-pitch-0 [254.983701] Subtest bad-pitch-0: SUCCESS (0.000s) [255.274522] [061/131] (771s left) gem_userptr_blits (unsync-unmap-cycles) [255.364128] Subtest unsync-unmap-cycles: SKIP (0.000s) [255.595840] [062/131] (771s left) gem_eio (suspend) [255.916008] Starting subtest: suspend [270.122432] Subtest suspend: SUCCESS (14.208s) [270.401527] [063/131] (756s left) kms_psr (pr-cursor-plane-move) [270.596718] Subtest pr-cursor-plane-move: SKIP (0.000s) [270.659794] [064/131] (756s left) kms_scaling_modes (scaling-mode-full) [270.854651] Starting subtest: scaling-mode-full [270.859974] Subtest scaling-mode-full: SKIP (0.001s) [271.012700] [065/131] (756s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [271.204469] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [271.206321] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [271.405899] [066/131] (756s left) perf (short-reads) [271.825129] Starting subtest: short-reads [271.848616] Subtest short-reads: SUCCESS (0.023s) [271.912547] [067/131] (755s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [272.111624] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [272.174785] [068/131] (755s left) api_intel_allocator (open-vm) [272.264716] Starting subtest: open-vm [272.291390] Subtest open-vm: SUCCESS (0.028s) [272.515915] [069/131] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [272.707583] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [272.709230] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [272.916064] [070/131] (754s left) gem_exec_params (invalid-fence-in-submit) [272.998386] Starting subtest: invalid-fence-in-submit [273.002070] Subtest invalid-fence-in-submit: SUCCESS (0.003s) [273.217055] [071/131] (754s left) gem_exec_schedule (pi-common) [273.426466] Starting subtest: pi-common [273.427440] Starting dynamic subtest: rcs0 [273.460667] Dynamic subtest rcs0: SUCCESS (0.034s) [273.475668] Starting dynamic subtest: bcs0 [273.492701] Dynamic subtest bcs0: SUCCESS (0.031s) [273.508708] Starting dynamic subtest: vcs0 [273.526399] Dynamic subtest vcs0: SUCCESS (0.033s) [273.541619] Starting dynamic subtest: vcs1 [273.557622] Dynamic subtest vcs1: SUCCESS (0.030s) [273.572916] Starting dynamic subtest: vecs0 [273.587448] Dynamic subtest vecs0: SUCCESS (0.029s) [273.602769] Starting dynamic subtest: vecs1 [273.616892] Dynamic subtest vecs1: SUCCESS (0.028s) [273.632299] Starting dynamic subtest: ccs0 [273.650484] Dynamic subtest ccs0: SUCCESS (0.032s) [273.651615] Subtest pi-common: SUCCESS (0.225s) [273.985670] [072/131] (753s left) gem_wait (busy) [274.079719] Starting subtest: busy [274.080659] Starting dynamic subtest: all-engines [274.657683] Dynamic subtest all-engines: SUCCESS (0.577s) [274.672293] Starting dynamic subtest: rcs0 [275.198271] Dynamic subtest rcs0: SUCCESS (0.539s) [275.211408] Starting dynamic subtest: bcs0 [275.738364] Dynamic subtest bcs0: SUCCESS (0.538s) [275.759226] Starting dynamic subtest: vcs0 [276.284029] Dynamic subtest vcs0: SUCCESS (0.542s) [276.298667] Starting dynamic subtest: vcs1 [276.823099] Dynamic subtest vcs1: SUCCESS (0.538s) [276.836436] Starting dynamic subtest: vecs0 [277.362396] Dynamic subtest vecs0: SUCCESS (0.538s) [277.376440] Starting dynamic subtest: vecs1 [277.901307] Dynamic subtest vecs1: SUCCESS (0.538s) [277.914333] Starting dynamic subtest: ccs0 [278.440436] Dynamic subtest ccs0: SUCCESS (0.538s) [278.441443] Subtest busy: SUCCESS (4.361s) [278.765686] [073/131] (749s left) gem_caching (reads) [278.851728] Starting subtest: reads [281.964634] Subtest reads: SUCCESS (3.113s) [282.177493] [074/131] (745s left) gem_ccs (suspend-resume) [282.262981] Starting subtest: suspend-resume [282.265361] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0 [300.419979] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (4.110s) [300.433783] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0 [318.514547] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.739s) [318.531764] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0 [336.401202] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (3.605s) [336.416323] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0 [354.492251] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.707s) [354.507164] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0 [372.439688] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (3.667s) [372.453284] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0 [390.533330] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.745s) [390.548367] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0 [408.366434] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (3.569s) [408.381524] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0 [426.473839] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.647s) [426.474755] Subtest suspend-resume: SUCCESS (29.799s) [426.692096] [075/131] (601s left) kms_plane_alpha_blend (constant-alpha-min) [426.882613] Starting subtest: constant-alpha-min [427.140280] Starting dynamic subtest: pipe-A-DP-3 [427.858203] Dynamic subtest pipe-A-DP-3: SUCCESS (0.717s) [427.873255] Starting dynamic subtest: pipe-D-DP-3 [428.607478] Dynamic subtest pipe-D-DP-3: SUCCESS (0.746s) [428.608575] Subtest constant-alpha-min: SUCCESS (1.725s) [428.960505] [076/131] (599s left) syncobj_timeline (reset-during-wait-for-submit) [429.044591] Starting subtest: reset-during-wait-for-submit [429.148895] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [429.303382] [077/131] (598s left) kms_chamelium_audio (dp-audio) [429.586971] Subtest dp-audio: SKIP (0.000s) [429.750337] [078/131] (598s left) gem_exec_reloc (basic-wc) [429.848689] Subtest basic-wc: SKIP (0.000s) [429.966982] [079/131] (598s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [430.164722] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [430.166582] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [430.376044] [080/131] (598s left) kms_big_fb (4-tiled-addfb) [430.574201] Starting subtest: 4-tiled-addfb [430.575138] Subtest 4-tiled-addfb: SUCCESS (0.001s) [430.790791] [081/131] (597s left) fbdev (eof) [430.856161] Starting subtest: eof [430.857153] Subtest eof: SUCCESS (0.000s) [431.041970] [082/131] (597s left) gem_flink_race (flink_name) [431.090285] Starting subtest: flink_name [436.493054] Subtest flink_name: SUCCESS (5.402s) [436.732553] [083/131] (592s left) gem_eio (wait-wedge-1us) [437.041132] Starting subtest: wait-wedge-1us [437.939624] Subtest wait-wedge-1us: SUCCESS (0.898s) [438.218486] [084/131] (590s left) syncobj_wait (single-wait-all-submitted) [438.299110] Starting subtest: single-wait-all-submitted [438.408640] Subtest single-wait-all-submitted: SUCCESS (0.107s) [438.594995] [085/131] (590s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [438.791307] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [440.075332] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.283s) [440.251860] [086/131] (588s left) kms_feature_discovery (display-1x) [440.448469] Starting subtest: display-1x [440.449415] Subtest display-1x: SUCCESS (0.000s) [440.611226] [087/131] (588s left) i915_pm_freq_api (freq-reset-multiple) [440.697338] Starting subtest: freq-reset-multiple [440.698290] Starting dynamic subtest: gt0 [462.370524] Dynamic subtest gt0: SUCCESS (21.665s) [462.371641] Subtest freq-reset-multiple: SUCCESS (21.667s) [462.513325] [088/131] (566s left) kms_flip (2x-wf_vblank-ts-check) [462.698498] Starting subtest: 2x-wf_vblank-ts-check [462.713730] Subtest 2x-wf_vblank-ts-check: SKIP (0.014s) [462.893511] [089/131] (566s left) kms_pm_backlight (brightness-with-dpms) [463.083493] Subtest brightness-with-dpms: SKIP (0.000s) [463.147255] [090/131] (566s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [463.348534] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [464.098070] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.749s) [464.385561] [091/131] (565s left) gem_userptr_blits (map-fixed-invalidate) [464.476386] Starting subtest: map-fixed-invalidate [464.478256] Subtest map-fixed-invalidate: SKIP (0.000s) [464.702446] [092/131] (564s left) kms_psr (fbc-pr-dpms) [464.893606] Subtest fbc-pr-dpms: SKIP (0.000s) [464.990109] [093/131] (564s left) gem_pxp (create-regular-buffer) [467.600731] Starting subtest: create-regular-buffer [467.602964] Subtest create-regular-buffer: SKIP (0.000s) [467.751027] [094/131] (561s left) gem_softpin (allocator-nopin-reserve) [467.834165] Starting subtest: allocator-nopin-reserve [468.081206] Subtest allocator-nopin-reserve: SUCCESS (0.247s) [468.306504] [095/131] (561s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [468.498432] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [468.500204] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [468.704314] [096/131] (561s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [468.896570] Starting subtest: psr-1p-pri-indfb-multidraw [468.898302] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s) [469.102032] [097/131] (560s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic) [469.286981] Starting subtest: async-flip-with-page-flip-events-linear-atomic [469.519760] Starting dynamic subtest: pipe-A-DP-3 [471.798539] Dynamic subtest pipe-A-DP-3: SUCCESS (2.277s) [472.020337] Starting dynamic subtest: pipe-B-DP-3 [474.110448] Dynamic subtest pipe-B-DP-3: SUCCESS (2.103s) [474.303841] Starting dynamic subtest: pipe-C-DP-3 [476.395821] Dynamic subtest pipe-C-DP-3: SUCCESS (2.105s) [476.624870] Starting dynamic subtest: pipe-D-DP-3 [478.707234] Dynamic subtest pipe-D-DP-3: SUCCESS (2.094s) [478.713284] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (9.419s) [479.263787] [098/131] (550s left) kms_psr (psr2-cursor-render) [479.452280] Subtest psr2-cursor-render: SKIP (0.000s) [479.526059] [099/131] (550s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [479.715579] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [479.716546] Starting dynamic subtest: pipe-A-DP-3 [479.725766] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [479.739707] Starting dynamic subtest: pipe-B-DP-3 [479.748363] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [479.761952] Starting dynamic subtest: pipe-C-DP-3 [479.770917] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [479.784755] Starting dynamic subtest: pipe-D-DP-3 [479.795665] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [479.797669] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.007s) [480.206788] [100/131] (549s left) gem_exec_balancer (waits) [480.298679] Starting subtest: waits [493.178523] Subtest waits: SUCCESS (12.876s) [493.623075] [101/131] (536s left) kms_cursor_crc (cursor-onscreen-max-size) [494.130416] Starting subtest: cursor-onscreen-max-size [494.133268] Subtest cursor-onscreen-max-size: SKIP (0.000s) [494.390513] [102/131] (535s left) prime_busy (hang-wait) [494.479513] Starting subtest: hang-wait [494.481786] Starting dynamic subtest: rcs0 [520.543290] Dynamic subtest rcs0: SUCCESS (26.053s) [520.556969] Starting dynamic subtest: bcs0 [527.640417] Dynamic subtest bcs0: SUCCESS (7.095s) [527.654289] Starting dynamic subtest: vcs0 [534.682707] Dynamic subtest vcs0: SUCCESS (7.038s) [534.696555] Starting dynamic subtest: vcs1 [541.662889] Dynamic subtest vcs1: SUCCESS (6.977s) [541.677129] Starting dynamic subtest: vecs0 [548.625643] Dynamic subtest vecs0: SUCCESS (6.960s) [548.639826] Starting dynamic subtest: vecs1 [555.668384] Dynamic subtest vecs1: SUCCESS (7.039s) [555.682792] Starting dynamic subtest: ccs0 [569.516120] Dynamic subtest ccs0: SUCCESS (13.844s) [569.517103] Subtest hang-wait: SUCCESS (75.017s) [569.700366] [103/131] (460s left) kms_vrr (lobf) [569.888471] Starting subtest: lobf [569.890278] Subtest lobf: SKIP (0.000s) [570.063600] [104/131] (460s left) gem_media_vme [570.233074] [105/131] (460s left) perf (invalid-remove-userspace-config) [570.492712] Starting subtest: invalid-remove-userspace-config [570.502650] Subtest invalid-remove-userspace-config: SUCCESS (0.010s) [570.565096] [106/131] (459s left) kms_color (ctm-red-to-blue) [570.752092] Starting subtest: ctm-red-to-blue [570.753091] Starting dynamic subtest: pipe-A-DP-3 [571.467900] Dynamic subtest pipe-A-DP-3: SUCCESS (0.712s) [571.496734] Starting dynamic subtest: pipe-B-DP-3 [572.085644] Dynamic subtest pipe-B-DP-3: SUCCESS (0.616s) [572.108344] Starting dynamic subtest: pipe-C-DP-3 [572.686118] Dynamic subtest pipe-C-DP-3: SUCCESS (0.598s) [572.708608] Starting dynamic subtest: pipe-D-DP-3 [573.287087] Dynamic subtest pipe-D-DP-3: SUCCESS (0.600s) [573.288033] Subtest ctm-red-to-blue: SUCCESS (2.535s) [573.600134] [107/131] (457s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [573.786633] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [573.787549] Starting dynamic subtest: pipe-A-valid-mode [574.173555] Dynamic subtest pipe-A-valid-mode: SKIP (0.385s) [574.175549] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.387s) [574.469630] [108/131] (456s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [574.550209] Starting subtest: etime-multi-wait-all-available-unsubmitted [574.655449] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s) [574.852573] [109/131] (455s left) syncobj_timeline (invalid-transfer-non-existent-point) [574.934505] Starting subtest: invalid-transfer-non-existent-point [574.935425] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [575.114481] [110/131] (455s left) i915_power (sanity) [575.191093] Starting subtest: sanity [579.253208] Subtest sanity: SUCCESS (4.060s) [579.465479] [111/131] (451s left) prime_vgem (basic-gtt) [579.570361] Starting subtest: basic-gtt [579.572558] Subtest basic-gtt: SKIP (0.000s) [579.765757] [112/131] (451s left) perf (disabled-read-error) [580.006825] Starting subtest: disabled-read-error [580.038625] Subtest disabled-read-error: SUCCESS (0.032s) [580.099488] [113/131] (451s left) gem_exec_schedule (u-submit-late-slice) [580.194180] Starting subtest: u-submit-late-slice [580.195032] Starting dynamic subtest: rcs0 [580.273553] Dynamic subtest rcs0: SUCCESS (0.079s) [580.289500] Starting dynamic subtest: bcs0 [580.325098] Dynamic subtest bcs0: SUCCESS (0.050s) [580.340792] Starting dynamic subtest: vcs0 [580.375520] Dynamic subtest vcs0: SUCCESS (0.049s) [580.391523] Starting dynamic subtest: vcs1 [580.424699] Dynamic subtest vcs1: SUCCESS (0.048s) [580.440927] Starting dynamic subtest: vecs0 [580.475405] Dynamic subtest vecs0: SUCCESS (0.050s) [580.491668] Starting dynamic subtest: vecs1 [580.522599] Dynamic subtest vecs1: SUCCESS (0.046s) [580.538584] Starting dynamic subtest: ccs0 [580.574342] Dynamic subtest ccs0: SUCCESS (0.050s) [580.575297] Subtest u-submit-late-slice: SUCCESS (0.381s) [581.058346] [114/131] (450s left) gen9_exec_parse (secure-batches) [581.150536] Subtest secure-batches: SKIP (0.000s) [581.253324] [115/131] (450s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [581.333575] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [581.334490] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [581.552523] [116/131] (449s left) kms_plane_scaling (planes-downscale-factor-0-75) [581.739744] Starting subtest: planes-downscale-factor-0-75 [581.740645] Starting dynamic subtest: pipe-A [581.830881] Dynamic subtest pipe-A: SUCCESS (0.091s) [581.853443] Starting dynamic subtest: pipe-B [582.044366] Dynamic subtest pipe-B: SUCCESS (0.212s) [582.067557] Starting dynamic subtest: pipe-C [582.274514] Dynamic subtest pipe-C: SUCCESS (0.228s) [582.293819] Starting dynamic subtest: pipe-D [582.471357] Dynamic subtest pipe-D: SUCCESS (0.195s) [582.472442] Subtest planes-downscale-factor-0-75: SUCCESS (0.732s) [582.825463] [117/131] (448s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [583.017731] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [583.020296] Starting dynamic subtest: pipe-A-DP-3 [583.023880] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [583.038192] Starting dynamic subtest: pipe-B-DP-3 [583.041794] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [583.055679] Starting dynamic subtest: pipe-C-DP-3 [583.059284] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [583.073063] Starting dynamic subtest: pipe-D-DP-3 [583.077257] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [583.079125] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.008s) [583.532274] [118/131] (447s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [583.728419] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [583.730196] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [583.929774] [119/131] (447s left) syncobj_basic (bad-destroy) [584.006496] Starting subtest: bad-destroy [584.007482] Subtest bad-destroy: SUCCESS (0.000s) [584.197661] [120/131] (447s left) perf_pmu (busy-accuracy-50) [584.270560] Starting subtest: busy-accuracy-50 [584.271476] Starting dynamic subtest: rcs0 [585.830670] Dynamic subtest rcs0: SUCCESS (1.560s) [585.845255] Starting dynamic subtest: bcs0 [587.389814] Dynamic subtest bcs0: SUCCESS (1.557s) [587.404306] Starting dynamic subtest: vcs0 [588.945510] Dynamic subtest vcs0: SUCCESS (1.554s) [588.959803] Starting dynamic subtest: vcs1 [590.499276] Dynamic subtest vcs1: SUCCESS (1.552s) [590.513809] Starting dynamic subtest: vecs0 [592.054623] Dynamic subtest vecs0: SUCCESS (1.554s) [592.069104] Starting dynamic subtest: vecs1 [593.610066] Dynamic subtest vecs1: SUCCESS (1.554s) [593.624610] Starting dynamic subtest: ccs0 [595.165152] Dynamic subtest ccs0: SUCCESS (1.553s) [595.166070] Subtest busy-accuracy-50: SUCCESS (10.893s) [595.394130] [121/131] (436s left) perf_pmu (all-busy-check-all) [595.465614] Starting subtest: all-busy-check-all [596.063541] Subtest all-busy-check-all: SUCCESS (0.597s) [596.252785] [122/131] (435s left) gem_exec_fence (syncobj-timeline-invalid-flags) [596.942983] Starting subtest: syncobj-timeline-invalid-flags [596.945035] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s) [597.254210] [123/131] (434s left) kms_lease (lease-get) [597.442561] Starting subtest: lease-get [597.443467] Starting dynamic subtest: pipe-A-DP-3 [597.445801] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s) [597.460374] Starting dynamic subtest: pipe-B-DP-3 [597.461292] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s) [597.475301] Starting dynamic subtest: pipe-C-DP-3 [597.476394] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s) [597.490363] Starting dynamic subtest: pipe-D-DP-3 [597.491627] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s) [597.492730] Subtest lease-get: SUCCESS (0.015s) [597.632861] [124/131] (434s left) kms_pm_rpm (legacy-planes-dpms) [600.050268] Starting subtest: legacy-planes-dpms [600.052223] Starting dynamic subtest: plane-63 [602.604164] Dynamic subtest plane-63: SUCCESS (2.555s) [602.657270] Starting dynamic subtest: plane-93 [605.182345] Dynamic subtest plane-93: SUCCESS (2.574s) [605.233438] Starting dynamic subtest: plane-123 [607.858247] Dynamic subtest plane-123: SUCCESS (2.670s) [607.907288] Starting dynamic subtest: plane-133 [610.538882] Dynamic subtest plane-133: SUCCESS (2.674s) [610.540753] Subtest legacy-planes-dpms: SUCCESS (10.491s) [610.966257] [125/131] (421s left) gem_pxp (hw-rejects-pxp-buffer) [613.571432] Starting subtest: hw-rejects-pxp-buffer [613.572555] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s) [613.739917] [126/131] (418s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [613.938653] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [615.135492] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.196s) [615.378541] [127/131] (416s left) syncobj_timeline (wait-delayed-signal) [615.455584] Starting subtest: wait-delayed-signal [615.558912] Subtest wait-delayed-signal: SUCCESS (0.102s) [615.715713] [128/131] (416s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [615.906631] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [615.907543] Starting dynamic subtest: pipe-A-DP-3 [615.929592] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [615.943728] Starting dynamic subtest: pipe-B-DP-3 [615.966097] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [615.980673] Starting dynamic subtest: pipe-C-DP-3 [616.008203] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [616.022757] Starting dynamic subtest: pipe-D-DP-3 [616.049688] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [616.051979] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.015s) [616.386002] [129/131] (416s left) gem_mmap_gtt (fault-concurrent-y) [616.468457] Subtest fault-concurrent-Y: SKIP (0.000s) [616.541843] [130/131] (415s left) gem_ctx_isolation (preservation-s3) [616.636366] Starting subtest: preservation-S3 [616.637332] Starting dynamic subtest: rcs0 [636.482564] Dynamic subtest rcs0: SUCCESS (4.217s) [636.499733] Starting dynamic subtest: bcs0 [656.525268] Dynamic subtest bcs0: SUCCESS (3.975s) [656.541196] Starting dynamic subtest: vcs0 [675.697347] Dynamic subtest vcs0: SUCCESS (3.926s) [675.712971] Starting dynamic subtest: vcs1 [694.918472] Dynamic subtest vcs1: SUCCESS (3.882s) [694.935152] Starting dynamic subtest: vecs0 [714.131577] Dynamic subtest vecs0: SUCCESS (3.936s) [714.147623] Starting dynamic subtest: vecs1 [734.114324] Dynamic subtest vecs1: SUCCESS (3.888s) [734.129004] Starting dynamic subtest: ccs0 [753.351385] Dynamic subtest ccs0: SUCCESS (3.962s) [753.352397] Subtest preservation-S3: SUCCESS (27.795s) [753.758973] [131/131] (278s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [753.954450] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [753.956095] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [754.156637] Closing watchdogs results: parsing output: 0/ for test: kms_hdr results: parsing output: 1/ for test: kms_cursor_crc results: parsing output: 2/ for test: kms_joiner results: parsing output: 3/ for test: kms_cursor_legacy results: parsing output: 4/ for test: gem_exec_schedule results: parsing output: 5/ for test: kms_universal_plane results: parsing output: 6/ for test: gem_ctx_sseu results: parsing output: 7/ for test: syncobj_timeline results: parsing output: 8/ for test: sw_sync results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_flip results: parsing output: 11/ for test: i915_pm_rpm results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: prime_mmap results: parsing output: 15/ for test: gem_render_copy results: parsing output: 16/ for test: gem_ctx_persistence results: parsing output: 17/ for test: kms_flip_scaled_crc results: parsing output: 18/ for test: kms_plane results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_content_protection results: parsing output: 21/ for test: kms_atomic results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: prime_mmap results: parsing output: 26/ for test: kms_prime results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_cursor_crc results: parsing output: 29/ for test: gem_exec_flush results: parsing output: 30/ for test: gem_exec_reloc results: parsing output: 31/ for test: gem_exec_balancer results: parsing output: 32/ for test: i915_drm_fdinfo results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: syncobj_timeline results: parsing output: 35/ for test: gem_render_copy_redux results: parsing output: 36/ for test: kms_psr2_sf results: parsing output: 37/ for test: gem_lmem_swapping results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: kms_chamelium_edid results: parsing output: 40/ for test: kms_chamelium_hpd results: parsing output: 41/ for test: kms_cursor_legacy results: parsing output: 42/ for test: gem_exec_params results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_panel_fitting results: parsing output: 45/ for test: dumb_buffer results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_ctx_create results: parsing output: 51/ for test: gem_linear_blits results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_exec_params results: parsing output: 55/ for test: kms_properties results: parsing output: 56/ for test: api_intel_bb results: parsing output: 57/ for test: gem_tiled_blits results: parsing output: 58/ for test: syncobj_wait results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: gem_userptr_blits results: parsing output: 61/ for test: gem_eio results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_scaling_modes results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: perf results: parsing output: 66/ for test: kms_psr2_sf results: parsing output: 67/ for test: api_intel_allocator results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: gem_exec_params results: parsing output: 70/ for test: gem_exec_schedule results: parsing output: 71/ for test: gem_wait results: parsing output: 72/ for test: gem_caching results: parsing output: 73/ for test: gem_ccs results: parsing output: 74/ for test: kms_plane_alpha_blend results: parsing output: 75/ for test: syncobj_timeline results: parsing output: 76/ for test: kms_chamelium_audio results: parsing output: 77/ for test: gem_exec_reloc results: parsing output: 78/ for test: kms_big_fb results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: fbdev results: parsing output: 81/ for test: gem_flink_race results: parsing output: 82/ for test: gem_eio results: parsing output: 83/ for test: syncobj_wait results: parsing output: 84/ for test: kms_big_fb results: parsing output: 85/ for test: kms_feature_discovery results: parsing output: 86/ for test: i915_pm_freq_api results: parsing output: 87/ for test: kms_flip results: parsing output: 88/ for test: kms_pm_backlight results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: gem_userptr_blits results: parsing output: 91/ for test: kms_psr results: parsing output: 92/ for test: gem_pxp results: parsing output: 93/ for test: gem_softpin results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_async_flips results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: gem_exec_balancer results: parsing output: 100/ for test: kms_cursor_crc results: parsing output: 101/ for test: prime_busy results: parsing output: 102/ for test: kms_vrr results: parsing output: 103/ for test: gem_media_vme results: parsing output: 104/ for test: perf results: parsing output: 105/ for test: kms_color results: parsing output: 106/ for test: kms_flip_scaled_crc results: parsing output: 107/ for test: syncobj_timeline results: parsing output: 108/ for test: syncobj_timeline results: parsing output: 109/ for test: i915_power results: parsing output: 110/ for test: prime_vgem results: parsing output: 111/ for test: perf results: parsing output: 112/ for test: gem_exec_schedule results: parsing output: 113/ for test: gen9_exec_parse results: parsing output: 114/ for test: syncobj_wait results: parsing output: 115/ for test: kms_plane_scaling results: parsing output: 116/ for test: kms_ccs results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: syncobj_basic results: parsing output: 119/ for test: perf_pmu results: parsing output: 120/ for test: perf_pmu results: parsing output: 121/ for test: gem_exec_fence results: parsing output: 122/ for test: kms_lease results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: gem_pxp results: parsing output: 125/ for test: kms_big_fb results: parsing output: 126/ for test: syncobj_timeline results: parsing output: 127/ for test: kms_ccs results: parsing output: 128/ for test: gem_mmap_gtt results: parsing output: 129/ for test: gem_ctx_isolation results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.