[64.073591] Initializing watchdogs [64.073656] /dev/watchdog0 [64.093858] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [64.104854] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [64.109289] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [64.111394] [001/132] (960s left) syncobj_timeline (wait-for-submit-snapshot) [64.192457] Starting subtest: wait-for-submit-snapshot [64.276466] Subtest wait-for-submit-snapshot: SUCCESS (0.083s) [64.436473] [002/132] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [65.939980] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [65.940836] Starting dynamic subtest: pipe-A-HDMI-A-3 [65.961958] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s) [65.969493] Starting dynamic subtest: pipe-B-HDMI-A-3 [65.991411] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s) [65.998756] Starting dynamic subtest: pipe-C-HDMI-A-3 [66.022789] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s) [66.029945] Starting dynamic subtest: pipe-D-HDMI-A-3 [66.052208] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s) [66.053974] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.012s) [66.225790] [003/132] (958s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt) [67.740022] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt [70.001506] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.262s) [70.256333] [004/132] (954s left) kms_big_fb (linear-8bpp-rotate-270) [71.781414] Starting subtest: linear-8bpp-rotate-270 [71.835305] Subtest linear-8bpp-rotate-270: SKIP (0.053s) [72.064839] [005/132] (952s left) kms_busy (extended-modeset-hang-newfb) [73.575131] Starting subtest: extended-modeset-hang-newfb [73.577237] Starting dynamic subtest: pipe-A [89.177135] Dynamic subtest pipe-A: SUCCESS (15.600s) [89.186184] Starting dynamic subtest: pipe-D [104.704186] Dynamic subtest pipe-D: SUCCESS (15.525s) [104.705146] Subtest extended-modeset-hang-newfb: SUCCESS (31.130s) [104.960128] [006/132] (920s left) perf (oa-exponents) [105.365814] Starting subtest: oa-exponents [105.366592] Starting dynamic subtest: 0-rcs0 [107.559178] Dynamic subtest 0-rcs0: SUCCESS (2.193s) [107.560118] Subtest oa-exponents: SUCCESS (2.193s) [107.612165] [007/132] (917s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [109.123683] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [110.438270] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.314s) [110.667069] [008/132] (914s left) kms_pipe_crc_basic (suspend-read-crc) [112.166952] Starting subtest: suspend-read-crc [112.167880] Starting dynamic subtest: pipe-A-HDMI-A-3 [132.827590] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.968s) [132.838240] Starting dynamic subtest: pipe-B-HDMI-A-3 [153.802193] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (4.369s) [153.813205] Starting dynamic subtest: pipe-C-HDMI-A-3 [174.728223] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (4.316s) [174.739687] Starting dynamic subtest: pipe-D-HDMI-A-3 [195.783775] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.294s) [195.784743] Subtest suspend-read-crc: SUCCESS (17.953s) [200.068296] [009/132] (829s left) perf_pmu (interrupts-sync) [200.133068] Starting subtest: interrupts-sync [201.286770] Subtest interrupts-sync: SUCCESS (1.153s) [201.460114] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true [201.462304] [010/132] (827s left) gem_exec_reloc (basic-gtt-active) [201.560412] Subtest basic-gtt-active: SKIP (0.000s) [201.643944] [011/132] (827s left) kms_flip (modeset-vs-vblank-race) [203.154709] Starting subtest: modeset-vs-vblank-race [203.158942] Starting dynamic subtest: A-HDMI-A3 [206.295274] Dynamic subtest A-HDMI-A3: SUCCESS (3.136s) [206.309614] Starting dynamic subtest: B-HDMI-A3 [209.327767] Dynamic subtest B-HDMI-A3: SUCCESS (3.031s) [209.340899] Starting dynamic subtest: C-HDMI-A3 [212.333993] Dynamic subtest C-HDMI-A3: SUCCESS (3.005s) [212.355414] Starting dynamic subtest: D-HDMI-A3 [215.393038] Dynamic subtest D-HDMI-A3: SUCCESS (3.057s) [215.394067] Subtest modeset-vs-vblank-race: SUCCESS (12.241s) [215.673611] [012/132] (813s left) gem_sync (basic-each) [215.777704] Starting subtest: basic-each [217.982697] Subtest basic-each: SUCCESS (2.205s) [218.274942] [013/132] (811s left) gem_ctx_persistence (legacy-engines-mixed) [218.363874] Starting subtest: legacy-engines-mixed [218.365002] Starting dynamic subtest: render [218.477762] Dynamic subtest render: SUCCESS (0.114s) [218.494647] Starting dynamic subtest: bsd1 [218.530960] Dynamic subtest bsd1: SUCCESS (0.051s) [218.546063] Starting dynamic subtest: bsd2 [218.599975] Dynamic subtest bsd2: SUCCESS (0.066s) [218.613960] Starting dynamic subtest: blt [218.660026] Dynamic subtest blt: SUCCESS (0.057s) [218.684134] Starting dynamic subtest: vebox [218.726486] Dynamic subtest vebox: SUCCESS (0.063s) [218.731361] Subtest legacy-engines-mixed: SUCCESS (0.365s) [218.955254] [014/132] (810s left) kms_plane (plane-panning-bottom-right) [220.467746] Starting subtest: plane-panning-bottom-right [220.468741] Starting dynamic subtest: pipe-A [221.119046] Dynamic subtest pipe-A: SUCCESS (0.651s) [221.131152] Starting dynamic subtest: pipe-B [221.620015] Dynamic subtest pipe-B: SUCCESS (0.499s) [221.620910] Subtest plane-panning-bottom-right: SUCCESS (1.154s) [221.866895] [015/132] (807s left) prime_vgem (wait) [221.963848] Starting subtest: wait [221.964792] Starting dynamic subtest: rcs0 [222.025973] Dynamic subtest rcs0: SUCCESS (0.062s) [222.038349] Starting dynamic subtest: bcs0 [222.083075] Dynamic subtest bcs0: SUCCESS (0.056s) [222.099144] Starting dynamic subtest: vcs0 [222.125676] Dynamic subtest vcs0: SUCCESS (0.041s) [222.145081] Starting dynamic subtest: vcs1 [222.165785] Dynamic subtest vcs1: SUCCESS (0.038s) [222.185190] Starting dynamic subtest: vecs0 [222.206806] Dynamic subtest vecs0: SUCCESS (0.039s) [222.226263] Starting dynamic subtest: vecs1 [222.248006] Dynamic subtest vecs1: SUCCESS (0.039s) [222.267407] Starting dynamic subtest: ccs0 [222.288956] Dynamic subtest ccs0: SUCCESS (0.039s) [222.290010] Subtest wait: SUCCESS (0.326s) [222.501597] [016/132] (807s left) i915_query (query-topology-matches-eu-total) [222.578470] Starting subtest: query-topology-matches-eu-total [222.579391] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [222.754548] [017/132] (807s left) syncobj_timeline (reset-signaled) [222.841301] Starting subtest: reset-signaled [222.842181] Subtest reset-signaled: SUCCESS (0.000s) [222.998865] [018/132] (806s left) syncobj_timeline (multi-wait-all-available-signaled) [223.077109] Starting subtest: multi-wait-all-available-signaled [223.078001] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s) [223.288836] [019/132] (806s left) kms_cursor_crc (cursor-random-256x256) [225.034789] Starting subtest: cursor-random-256x256 [225.039970] Starting dynamic subtest: pipe-A-HDMI-A-3 [229.599960] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.560s) [229.635693] Starting dynamic subtest: pipe-D-HDMI-A-3 [234.057664] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.432s) [234.058588] Subtest cursor-random-256x256: SUCCESS (9.022s) [234.436252] [020/132] (795s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [234.520525] Starting subtest: mixed-tiled-to-y-tiled-ccs [234.522870] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [234.810550] [021/132] (795s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [236.330689] Starting subtest: primary-y-tiled-reflect-x-180 [236.429176] Subtest primary-y-tiled-reflect-x-180: SKIP (0.098s) [236.650752] [022/132] (793s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [236.746655] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [236.749065] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [237.024423] [023/132] (793s left) gem_exec_schedule (reorder-wide) [237.233094] Subtest reorder-wide: SKIP (0.000s) [237.522160] [024/132] (792s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [239.037678] Starting subtest: fbc-indfb-scaledprimary [240.629432] Subtest fbc-indfb-scaledprimary: SUCCESS (1.592s) [240.868992] [025/132] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [242.383799] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [242.385553] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [242.625194] [026/132] (788s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [244.144759] Starting subtest: crc-primary-suspend-yf-tiled-ccs [244.145731] Starting dynamic subtest: pipe-A-HDMI-A-3 [244.149455] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [244.160964] Starting dynamic subtest: pipe-B-HDMI-A-3 [244.164595] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [244.175761] Starting dynamic subtest: pipe-C-HDMI-A-3 [244.179425] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [244.190266] Starting dynamic subtest: pipe-D-HDMI-A-3 [244.193691] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [244.195528] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.008s) [244.472812] [027/132] (786s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [245.993462] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [246.056055] [028/132] (784s left) kms_cursor_crc (cursor-random-64x21) [247.733818] Starting subtest: cursor-random-64x21 [247.738832] Starting dynamic subtest: pipe-A-HDMI-A-3 [251.972043] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.232s) [252.016889] Starting dynamic subtest: pipe-D-HDMI-A-3 [256.271229] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.265s) [256.272071] Subtest cursor-random-64x21: SUCCESS (8.538s) [256.735274] [029/132] (774s left) prime_mmap (test_dup) [256.814392] Starting subtest: test_dup [256.815253] Starting dynamic subtest: test_dup-smem [256.860573] Dynamic subtest test_dup-smem: SUCCESS (0.046s) [256.873157] Starting dynamic subtest: test_dup-lmem0 [257.050906] Dynamic subtest test_dup-lmem0: SUCCESS (0.189s) [257.051901] Subtest test_dup: SUCCESS (0.237s) [257.223482] [030/132] (773s left) gem_exec_schedule (u-submit-late-slice) [257.320023] Starting subtest: u-submit-late-slice [257.320989] Starting dynamic subtest: rcs0 [257.399335] Dynamic subtest rcs0: SUCCESS (0.079s) [257.412377] Starting dynamic subtest: bcs0 [257.455955] Dynamic subtest bcs0: SUCCESS (0.055s) [257.469053] Starting dynamic subtest: vcs0 [257.503137] Dynamic subtest vcs0: SUCCESS (0.046s) [257.516147] Starting dynamic subtest: vcs1 [257.551221] Dynamic subtest vcs1: SUCCESS (0.047s) [257.564307] Starting dynamic subtest: vecs0 [257.599141] Dynamic subtest vecs0: SUCCESS (0.047s) [257.612038] Starting dynamic subtest: vecs1 [257.647914] Dynamic subtest vecs1: SUCCESS (0.048s) [257.660707] Starting dynamic subtest: ccs0 [257.696414] Dynamic subtest ccs0: SUCCESS (0.047s) [257.697475] Subtest u-submit-late-slice: SUCCESS (0.377s) [258.216662] [031/132] (772s left) syncobj_timeline (etime-multi-wait-all-submitted) [258.296942] Starting subtest: etime-multi-wait-all-submitted [258.400985] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s) [258.570753] [032/132] (772s left) fbdev (write) [258.636026] Starting subtest: write [259.964086] Subtest write: SUCCESS (1.328s) [260.087962] [033/132] (771s left) syncobj_wait (invalid-signal-zero-handles) [260.166003] Starting subtest: invalid-signal-zero-handles [260.166998] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [260.361564] [034/132] (770s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [261.879608] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [261.881420] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [262.110722] [035/132] (769s left) gem_exec_balancer (sliced) [262.201928] Starting subtest: sliced [262.203900] Subtest sliced: SKIP (0.000s) [262.654434] [036/132] (768s left) gem_ccs (large-ctrl-surf-copy) [262.747933] Starting subtest: large-ctrl-surf-copy [263.393236] Subtest large-ctrl-surf-copy: SUCCESS (0.645s) [263.580986] [037/132] (767s left) gem_fenced_exec_thrash (2-spare-fences) [263.676378] Subtest 2-spare-fences: SKIP (0.000s) [263.766697] [038/132] (767s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [265.281753] Starting subtest: basic-busy-flip-before-cursor-varying-size [265.283594] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [265.442563] [039/132] (766s left) kms_big_fb (4-tiled-8bpp-rotate-0) [267.000917] Starting subtest: 4-tiled-8bpp-rotate-0 [268.602700] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.601s) [268.830570] [040/132] (762s left) gem_mmap_wc (copy) [268.923840] Subtest copy: SKIP (0.000s) [269.036575] [041/132] (762s left) kms_cursor_legacy (cursor-vs-flip-toggle) [270.550696] Starting subtest: cursor-vs-flip-toggle [303.743531] Subtest cursor-vs-flip-toggle: SUCCESS (33.192s) [303.993210] [042/132] (727s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [305.517486] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [305.519347] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [305.743163] [043/132] (726s left) kms_addfb_basic (unused-handle) [305.839511] Starting subtest: unused-handle [305.840476] Subtest unused-handle: SUCCESS (0.000s) [307.499686] [044/132] (724s left) gem_ctx_shared (q-smoketest-all) [307.600322] Starting subtest: Q-smoketest-all [339.904403] Subtest Q-smoketest-all: SUCCESS (32.296s) [340.262330] [045/132] (691s left) kms_flip (2x-flip-vs-expired-vblank) [341.784532] Starting subtest: 2x-flip-vs-expired-vblank [341.796523] Subtest 2x-flip-vs-expired-vblank: SKIP (0.013s) [341.967457] [046/132] (690s left) kms_force_connector_basic (force-edid) [342.130381] Starting subtest: force-edid [342.152294] Subtest force-edid: SUCCESS (0.022s) [343.860567] [047/132] (688s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [345.412593] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [346.691848] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.279s) [346.922593] [048/132] (685s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [348.440744] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [348.441709] Starting dynamic subtest: pipe-A [348.523908] Dynamic subtest pipe-A: SUCCESS (0.084s) [348.538477] Starting dynamic subtest: pipe-B [348.651399] Dynamic subtest pipe-B: SUCCESS (0.126s) [348.668968] Starting dynamic subtest: pipe-C [348.793680] Dynamic subtest pipe-C: SUCCESS (0.141s) [348.807281] Starting dynamic subtest: pipe-D [348.918718] Dynamic subtest pipe-D: SUCCESS (0.124s) [348.919676] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.480s) [349.196478] [049/132] (683s left) kms_chamelium_audio (hdmi-audio) [350.752052] Subtest hdmi-audio: SKIP (0.000s) [350.858355] [050/132] (681s left) gem_set_tiling_vs_gtt [351.018302] [051/132] (681s left) gem_lmem_swapping (massive) [355.686414] Starting subtest: massive [355.687366] Starting dynamic subtest: lmem0 [366.064761] Dynamic subtest lmem0: SUCCESS (10.377s) [366.065791] Subtest massive: SUCCESS (10.379s) [367.532483] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [367.533484] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true [367.535374] [052/132] (665s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [372.525686] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [372.527437] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [372.757077] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [372.760365] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true [372.763582] [053/132] (660s left) prime_busy (after) [372.863090] Starting subtest: after [372.868159] Starting dynamic subtest: rcs0 [372.924173] Dynamic subtest rcs0: SUCCESS (0.056s) [372.937259] Starting dynamic subtest: bcs0 [372.986085] Dynamic subtest bcs0: SUCCESS (0.061s) [373.006694] Starting dynamic subtest: vcs0 [373.028012] Dynamic subtest vcs0: SUCCESS (0.040s) [373.044606] Starting dynamic subtest: vcs1 [373.067405] Dynamic subtest vcs1: SUCCESS (0.037s) [373.079224] Starting dynamic subtest: vecs0 [373.105927] Dynamic subtest vecs0: SUCCESS (0.037s) [373.118076] Starting dynamic subtest: vecs1 [373.146335] Dynamic subtest vecs1: SUCCESS (0.039s) [373.162810] Starting dynamic subtest: ccs0 [373.189303] Dynamic subtest ccs0: SUCCESS (0.041s) [373.307838] Subtest after: SUCCESS (0.437s) [373.535465] [054/132] (659s left) syncobj_wait (invalid-signal-illegal-handle) [373.615025] Starting subtest: invalid-signal-illegal-handle [373.616128] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [373.857785] [055/132] (659s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [375.373731] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [375.374662] Starting dynamic subtest: pipe-A-valid-mode [375.422839] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s) [375.424599] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.049s) [375.641316] [056/132] (657s left) gem_gtt_cpu_tlb [375.800463] [057/132] (657s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [377.316648] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [377.318483] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [377.550557] [058/132] (655s left) gen9_exec_parse (batch-zero-length) [377.634931] Subtest batch-zero-length: SKIP (0.000s) [377.716428] [059/132] (655s left) gem_softpin (evict-snoop-interruptible) [377.824032] Starting subtest: evict-snoop-interruptible [377.825982] Subtest evict-snoop-interruptible: SKIP (0.000s) [378.026110] [060/132] (655s left) dmabuf_sync_file (export-basic) [378.086511] Starting subtest: export-basic [378.087488] Subtest export-basic: SUCCESS (0.001s) [378.206871] [061/132] (655s left) kms_dither (fb-8bpc-vs-panel-6bpc) [379.721740] Starting subtest: fb-8bpc-vs-panel-6bpc [379.724480] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.001s) [379.911563] [062/132] (653s left) syncobj_timeline (host-signal-ordered) [380.016986] Starting subtest: host-signal-ordered [380.018052] Subtest host-signal-ordered: SUCCESS (0.000s) [380.210401] [063/132] (653s left) kms_chamelium_hpd (common-hpd-after-suspend) [381.761936] Subtest common-hpd-after-suspend: SKIP (0.000s) [381.858598] [064/132] (651s left) kms_flip (2x-flip-vs-fences) [383.371522] Starting subtest: 2x-flip-vs-fences [383.373208] Subtest 2x-flip-vs-fences: SKIP (0.000s) [383.575067] [065/132] (650s left) perf (mi-rpc) [384.000822] Starting subtest: mi-rpc [384.002579] Subtest mi-rpc: SKIP (0.000s) [384.058622] [066/132] (649s left) sw_sync (sync_random_merge) [384.107969] Starting subtest: sync_random_merge [384.172684] Subtest sync_random_merge: SUCCESS (0.065s) [384.283862] [067/132] (649s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite) [385.801475] Starting subtest: psr-rgb101010-draw-pwrite [385.803330] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s) [386.044486] [068/132] (648s left) kms_getfb (getfb2-handle-closed) [387.558795] Starting subtest: getfb2-handle-closed [387.559706] Subtest getfb2-handle-closed: SUCCESS (0.000s) [387.792448] [069/132] (646s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt) [389.311512] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt [389.313467] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [389.540230] [070/132] (644s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [389.623375] Starting subtest: invalid-smem-bo-on-discrete [389.624250] Subtest invalid-smem-bo-on-discrete: SUCCESS (0.000s) [391.290373] [071/132] (643s left) perf (gen12-invalid-class-instance) [391.565700] Starting subtest: gen12-invalid-class-instance [391.586113] Subtest gen12-invalid-class-instance: SUCCESS (0.021s) [391.642109] [072/132] (642s left) gem_exec_schedule (implicit-read-write) [391.738917] Starting subtest: implicit-read-write [391.739838] Starting dynamic subtest: rcs0 [392.052101] Dynamic subtest rcs0: SUCCESS (0.301s) [392.063143] Starting dynamic subtest: bcs0 [392.253756] Dynamic subtest bcs0: SUCCESS (0.206s) [392.264969] Starting dynamic subtest: vcs0 [392.478028] Dynamic subtest vcs0: SUCCESS (0.222s) [392.488920] Starting dynamic subtest: vcs1 [392.694592] Dynamic subtest vcs1: SUCCESS (0.217s) [392.705488] Starting dynamic subtest: vecs0 [392.912136] Dynamic subtest vecs0: SUCCESS (0.216s) [392.923337] Starting dynamic subtest: vecs1 [393.128588] Dynamic subtest vecs1: SUCCESS (0.221s) [393.139733] Starting dynamic subtest: ccs0 [393.346852] Dynamic subtest ccs0: SUCCESS (0.217s) [393.347655] Subtest implicit-read-write: SUCCESS (1.608s) [393.856355] [073/132] (640s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [395.370468] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [395.575366] [074/132] (639s left) kms_atomic (plane-cursor-legacy) [397.095757] Starting subtest: plane-cursor-legacy [397.096690] Starting dynamic subtest: pipe-A-HDMI-A-3 [397.566515] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.470s) [397.567495] Subtest plane-cursor-legacy: SUCCESS (0.472s) [397.817446] [075/132] (637s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [399.327636] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [399.328612] Starting dynamic subtest: pipe-A-HDMI-A-3 [399.337736] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [399.349110] Starting dynamic subtest: pipe-B-HDMI-A-3 [399.357833] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [399.369043] Starting dynamic subtest: pipe-C-HDMI-A-3 [399.386625] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [399.397618] Starting dynamic subtest: pipe-D-HDMI-A-3 [399.407674] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [399.409708] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s) [399.651351] [076/132] (635s left) gem_exec_balancer (bonded-pair) [399.744068] Starting subtest: bonded-pair [399.746031] Subtest bonded-pair: SKIP (0.000s) [400.201792] [077/132] (634s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [401.718709] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [401.720573] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [401.954580] [078/132] (633s left) gem_ctx_exec (basic-invalid-context) [402.036810] Starting subtest: basic-invalid-context [402.042386] Subtest basic-invalid-context: SUCCESS (0.006s) [402.232702] [079/132] (633s left) kms_content_protection (lic-type-0-hdcp14) [403.826023] Starting subtest: lic-type-0-hdcp14 [403.834409] Subtest lic-type-0-hdcp14: SKIP (0.006s) [404.069721] [080/132] (631s left) gem_eio (wait-immediate) [404.356534] Starting subtest: wait-immediate [404.962022] Subtest wait-immediate: SUCCESS (0.606s) [406.573138] [081/132] (628s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [408.104852] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [408.117098] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.013s) [408.282318] [082/132] (627s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [409.808757] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [409.809706] Starting dynamic subtest: pipe-A-valid-mode [411.551699] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.742s) [411.552674] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.744s) [411.800485] [083/132] (623s left) kms_psr (psr2-basic) [413.311811] Subtest psr2-basic: SKIP (0.000s) [413.371515] [084/132] (622s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [414.881589] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [414.882512] Starting dynamic subtest: pipe-A-HDMI-A-3 [414.891349] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [414.903347] Starting dynamic subtest: pipe-B-HDMI-A-3 [414.912072] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [414.923835] Starting dynamic subtest: pipe-C-HDMI-A-3 [414.932394] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [414.944038] Starting dynamic subtest: pipe-D-HDMI-A-3 [414.953884] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [414.955977] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.010s) [415.175021] [085/132] (620s left) kms_vblank (query-forked-busy) [416.686701] Starting subtest: query-forked-busy [416.687643] Starting dynamic subtest: pipe-A-HDMI-A-3 [419.160764] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.470s) [419.207620] Starting dynamic subtest: pipe-D-HDMI-A-3 [421.612955] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.443s) [421.617073] Subtest query-forked-busy: SUCCESS (4.929s) [421.901094] [086/132] (613s left) kms_pm_dc (dc9-dpms) [424.421452] Starting subtest: dc9-dpms [424.767258] Subtest dc9-dpms: SUCCESS (0.345s) [425.603362] [087/132] (610s left) gem_userptr_blits (set-cache-level) [425.707478] Starting subtest: set-cache-level [425.708482] Subtest set-cache-level: SUCCESS (0.000s) [425.940953] [088/132] (610s left) gem_exec_fence (keep-in-fence) [426.143099] Starting subtest: keep-in-fence [426.144031] Starting dynamic subtest: rcs0 [426.250050] Dynamic subtest rcs0: SUCCESS (0.106s) [426.267011] Starting dynamic subtest: bcs0 [426.306754] Dynamic subtest bcs0: SUCCESS (0.055s) [426.322810] Starting dynamic subtest: vcs0 [426.360934] Dynamic subtest vcs0: SUCCESS (0.053s) [426.382715] Starting dynamic subtest: vcs1 [426.417211] Dynamic subtest vcs1: SUCCESS (0.054s) [426.449312] Starting dynamic subtest: vecs0 [426.481934] Dynamic subtest vecs0: SUCCESS (0.062s) [426.506701] Starting dynamic subtest: vecs1 [426.539145] Dynamic subtest vecs1: SUCCESS (0.055s) [426.570805] Starting dynamic subtest: ccs0 [426.774819] Dynamic subtest ccs0: SUCCESS (0.232s) [426.780070] Subtest keep-in-fence: SUCCESS (0.633s) [427.498425] [089/132] (608s left) kms_pm_rpm (modeset-pc8-residency-stress) [431.746999] Starting subtest: modeset-pc8-residency-stress [431.749196] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [432.735320] [090/132] (603s left) kms_psr (fbc-psr2-sprite-plane-move) [434.252784] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s) [434.313296] [091/132] (601s left) gem_exec_create (forked) [434.407938] Starting subtest: forked [434.408897] Starting dynamic subtest: smem [454.537437] Dynamic subtest smem: SUCCESS (20.128s) [454.557976] Starting dynamic subtest: lmem0 [474.715356] Dynamic subtest lmem0: SUCCESS (20.176s) [474.716353] Subtest forked: SUCCESS (40.307s) [474.988904] [092/132] (561s left) kms_psr (pr-cursor-mmap-cpu) [476.504434] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [476.565560] [093/132] (559s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [478.084531] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [478.086329] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [478.305971] [094/132] (558s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [479.824543] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [479.882418] [095/132] (556s left) gem_exec_reloc (basic-wc-read) [479.973738] Subtest basic-wc-read: SKIP (0.000s) [480.070119] [096/132] (556s left) kms_psr (psr-cursor-plane-move) [481.585302] Subtest psr-cursor-plane-move: SKIP (0.000s) [481.649635] [097/132] (554s left) kms_flip (basic-plain-flip) [483.172795] Starting subtest: basic-plain-flip [483.178459] Starting dynamic subtest: A-HDMI-A3 [483.949334] Dynamic subtest A-HDMI-A3: SUCCESS (0.771s) [483.964434] Starting dynamic subtest: B-HDMI-A3 [484.630517] Dynamic subtest B-HDMI-A3: SUCCESS (0.679s) [484.645919] Starting dynamic subtest: C-HDMI-A3 [485.313454] Dynamic subtest C-HDMI-A3: SUCCESS (0.681s) [485.327452] Starting dynamic subtest: D-HDMI-A3 [486.013252] Dynamic subtest D-HDMI-A3: SUCCESS (0.698s) [486.018359] Subtest basic-plain-flip: SUCCESS (2.843s) [486.317103] [098/132] (550s left) kms_flip (plain-flip-fb-recreate) [487.831582] Starting subtest: plain-flip-fb-recreate [487.836591] Starting dynamic subtest: A-HDMI-A3 [495.871650] Dynamic subtest A-HDMI-A3: SUCCESS (8.035s) [495.895304] Starting dynamic subtest: B-HDMI-A3 [503.836931] Dynamic subtest B-HDMI-A3: SUCCESS (7.963s) [503.853129] Starting dynamic subtest: C-HDMI-A3 [511.803874] Dynamic subtest C-HDMI-A3: SUCCESS (7.965s) [511.821285] Starting dynamic subtest: D-HDMI-A3 [519.769911] Dynamic subtest D-HDMI-A3: SUCCESS (7.964s) [519.770890] Subtest plain-flip-fb-recreate: SUCCESS (31.940s) [520.054553] [099/132] (516s left) i915_suspend (debugfs-reader) [520.148882] Starting subtest: debugfs-reader [541.499401] Subtest debugfs-reader: SUCCESS (5.815s) [550.822654] [100/132] (495s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [552.347441] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [552.349302] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [552.580214] [101/132] (493s left) gem_exec_nop (basic-sequential) [552.671433] Starting subtest: basic-sequential [557.123572] Subtest basic-sequential: SUCCESS (4.451s) [557.448931] [102/132] (488s left) gem_pxp (create-regular-buffer) [560.058496] Starting subtest: create-regular-buffer [560.060566] Subtest create-regular-buffer: SKIP (0.000s) [560.199245] [103/132] (486s left) syncobj_basic (test-valid-cycle) [560.282603] Starting subtest: test-valid-cycle [560.283497] Subtest test-valid-cycle: SUCCESS (0.000s) [560.482786] [104/132] (485s left) gem_exec_suspend (basic-s3-devices) [560.572424] Starting subtest: basic-S3-devices [560.573377] Starting dynamic subtest: smem [570.596414] Dynamic subtest smem: SUCCESS (10.023s) [570.608879] Starting dynamic subtest: lmem0 [580.408413] Dynamic subtest lmem0: SUCCESS (9.811s) [580.409572] Subtest basic-S3-devices: SUCCESS (19.836s) [586.769679] [105/132] (465s left) template (a) [586.850301] Starting subtest: A [586.851212] Subtest A: SUCCESS (0.000s) [587.044742] [106/132] (465s left) gem_mmap_gtt (bad-object) [587.122173] Subtest bad-object: SKIP (0.000s) [587.193924] [107/132] (465s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [588.715156] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [588.716972] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [588.957030] [108/132] (463s left) api_intel_bb (intel-bb-blit-y) [589.037610] Starting subtest: intel-bb-blit-y [590.045038] Subtest intel-bb-blit-y: SUCCESS (1.008s) [590.245649] [109/132] (462s left) kms_selftest (drm_format_helper) [590.297351] Starting subtest: drm_format_helper [590.332060] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [590.427078] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.095s) [590.440821] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [590.504336] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.075s) [590.544497] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [590.582335] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.075s) [590.615715] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [590.675860] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.090s) [590.717978] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [590.768873] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.089s) [590.808287] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [590.839725] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.068s) [590.860362] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [590.938970] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.082s) [590.977167] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [591.009998] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.083s) [591.026191] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [591.084553] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.073s) [591.124594] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [591.173784] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.085s) [591.206532] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [591.275412] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.101s) [591.289199] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [591.375688] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.098s) [591.418763] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [591.457527] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.078s) [591.480456] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [591.539889] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.077s) [591.581787] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [591.626207] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.085s) [591.663888] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [591.706453] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.077s) [591.750162] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [591.800197] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.090s) [591.801436] Subtest drm_format_helper: SUCCESS (1.502s) [592.046300] [110/132] (460s left) gem_mmap_offset (oob-read) [592.124618] Starting subtest: oob-read [592.125525] Subtest oob-read: SUCCESS (0.000s) [592.296361] [111/132] (460s left) gem_spin_batch (resubmit-all) [592.386402] Starting subtest: resubmit-all [592.387269] Starting dynamic subtest: rcs0 [592.422300] Dynamic subtest rcs0: SUCCESS (0.035s) [592.436540] Starting dynamic subtest: bcs0 [592.437437] Dynamic subtest bcs0: SUCCESS (0.003s) [592.450102] Starting dynamic subtest: vcs0 [592.451185] Dynamic subtest vcs0: SUCCESS (0.003s) [592.463479] Starting dynamic subtest: vcs1 [592.464521] Dynamic subtest vcs1: SUCCESS (0.003s) [592.476355] Starting dynamic subtest: vecs0 [592.477556] Dynamic subtest vecs0: SUCCESS (0.003s) [592.489291] Starting dynamic subtest: vecs1 [592.490361] Dynamic subtest vecs1: SUCCESS (0.003s) [592.502105] Starting dynamic subtest: ccs0 [592.503182] Dynamic subtest ccs0: SUCCESS (0.003s) [592.504301] Subtest resubmit-all: SUCCESS (0.060s) [592.761188] [112/132] (460s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [594.273184] Starting subtest: cursorB-vs-flipA-toggle [594.276306] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s) [594.445218] [113/132] (458s left) gen9_exec_parse (valid-registers) [594.556613] Subtest valid-registers: SKIP (0.000s) [594.692773] [114/132] (458s left) kms_pipe_crc_basic (disable-crc-after-crtc) [596.205136] Starting subtest: disable-crc-after-crtc [596.206006] Starting dynamic subtest: pipe-A-HDMI-A-3 [596.816605] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.610s) [596.833338] Starting dynamic subtest: pipe-B-HDMI-A-3 [597.241643] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.423s) [597.256071] Starting dynamic subtest: pipe-C-HDMI-A-3 [597.687467] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.444s) [597.702597] Starting dynamic subtest: pipe-D-HDMI-A-3 [598.139792] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.450s) [598.140735] Subtest disable-crc-after-crtc: SUCCESS (1.935s) [598.392406] [115/132] (454s left) gem_exec_fence (syncobj-unused-fence) [598.916189] Starting subtest: syncobj-unused-fence [598.945207] Subtest syncobj-unused-fence: SUCCESS (0.029s) [599.439795] [116/132] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [600.955952] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [600.957751] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [601.166365] [117/132] (452s left) gem_set_tiling_vs_pwrite [601.325287] [118/132] (452s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [602.846220] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [602.847974] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [603.067781] [119/132] (450s left) vgem_basic (busy-fence) [603.129267] Starting subtest: busy-fence [603.130350] Subtest busy-fence: SUCCESS (0.000s) [603.277172] [120/132] (450s left) i915_pm_rpm (debugfs-read) [607.229642] Starting subtest: debugfs-read [608.255594] Subtest debugfs-read: SUCCESS (1.027s) [609.289807] [121/132] (444s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [610.818218] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [613.885255] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.067s) [614.099958] [122/132] (439s left) perf_pmu (busy-start) [614.170527] Starting subtest: busy-start [614.171494] Starting dynamic subtest: rcs0 [616.753534] Dynamic subtest rcs0: SUCCESS (2.581s) [616.770079] Starting dynamic subtest: bcs0 [619.304468] Dynamic subtest bcs0: SUCCESS (2.546s) [619.320743] Starting dynamic subtest: vcs0 [621.855313] Dynamic subtest vcs0: SUCCESS (2.546s) [621.871683] Starting dynamic subtest: vcs1 [624.406991] Dynamic subtest vcs1: SUCCESS (2.547s) [624.423448] Starting dynamic subtest: vecs0 [626.957595] Dynamic subtest vecs0: SUCCESS (2.546s) [626.974169] Starting dynamic subtest: vecs1 [629.509597] Dynamic subtest vecs1: SUCCESS (2.547s) [629.525974] Starting dynamic subtest: ccs0 [632.060706] Dynamic subtest ccs0: SUCCESS (2.546s) [632.065364] Subtest busy-start: SUCCESS (17.891s) [632.236006] [123/132] (421s left) kms_addfb_basic (size-max) [633.747375] Starting subtest: size-max [633.748385] Subtest size-max: SUCCESS (0.000s) [633.981385] [124/132] (420s left) kms_psr (fbc-pr-primary-blt) [635.493533] Subtest fbc-pr-primary-blt: SKIP (0.000s) [635.550494] [125/132] (418s left) kms_color_pipeline (plane-ctm3x4) [637.065202] Starting subtest: plane-ctm3x4 [637.087409] Starting dynamic subtest: pipe-A-HDMI-A-3 [637.436266] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.350s) [637.586613] Starting dynamic subtest: pipe-B-HDMI-A-3 [637.906884] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.332s) [638.052328] Starting dynamic subtest: pipe-C-HDMI-A-3 [638.372588] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.332s) [638.492172] Starting dynamic subtest: pipe-D-HDMI-A-3 [638.812851] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.332s) [638.885940] Subtest plane-ctm3x4: SUCCESS (1.822s) [639.153262] [126/132] (415s left) kms_chamelium_hpd (vga-hpd-without-ddc) [640.717023] Subtest vga-hpd-without-ddc: SKIP (0.000s) [640.819749] [127/132] (413s left) api_intel_allocator (standalone) [640.905945] Starting subtest: standalone [640.950928] Subtest standalone: SUCCESS (0.046s) [641.177171] [128/132] (413s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [642.693938] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [642.695629] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [642.928293] [129/132] (411s left) kms_big_fb (y-tiled-addfb) [644.451286] Starting subtest: y-tiled-addfb [644.453201] Subtest y-tiled-addfb: SKIP (0.000s) [644.680422] [130/132] (409s left) kms_prime (basic-crc-vgem) [646.200026] Subtest basic-crc-vgem: SKIP (0.000s) [646.399483] [131/132] (408s left) i915_hangman (engine-error-state-capture) [646.495195] Starting subtest: engine-error-state-capture [646.496198] Starting dynamic subtest: rcs0 [648.781384] Dynamic subtest rcs0: SUCCESS (2.286s) [648.795813] Starting dynamic subtest: bcs0 [652.760473] Dynamic subtest bcs0: SUCCESS (3.978s) [652.776489] Starting dynamic subtest: vcs0 [656.803457] Dynamic subtest vcs0: SUCCESS (4.041s) [656.823620] Starting dynamic subtest: vcs1 [660.737890] Dynamic subtest vcs1: SUCCESS (3.933s) [660.751645] Starting dynamic subtest: vecs0 [664.770536] Dynamic subtest vecs0: SUCCESS (4.031s) [664.784932] Starting dynamic subtest: vecs1 [668.738363] Dynamic subtest vecs1: SUCCESS (3.967s) [668.752564] Starting dynamic subtest: ccs0 [672.793283] Dynamic subtest ccs0: SUCCESS (4.054s) [672.794214] Subtest engine-error-state-capture: SUCCESS (26.298s) [672.968749] [132/132] (381s left) kms_invalid_mode (bad-vsync-end) [674.484255] Starting subtest: bad-vsync-end [674.485185] Starting dynamic subtest: pipe-A-HDMI-A-3 [674.524182] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.038s) [674.537432] Starting dynamic subtest: pipe-B-HDMI-A-3 [674.538600] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s) [674.551629] Starting dynamic subtest: pipe-C-HDMI-A-3 [674.552727] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s) [674.565382] Starting dynamic subtest: pipe-D-HDMI-A-3 [674.566278] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s) [674.567221] Subtest bad-vsync-end: SUCCESS (0.048s) [674.767619] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_ccs results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: kms_busy results: parsing output: 5/ for test: perf results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: kms_pipe_crc_basic results: parsing output: 8/ for test: perf_pmu results: parsing output: 9/ for test: gem_exec_reloc results: parsing output: 10/ for test: kms_flip results: parsing output: 11/ for test: gem_sync results: parsing output: 12/ for test: gem_ctx_persistence results: parsing output: 13/ for test: kms_plane results: parsing output: 14/ for test: prime_vgem results: parsing output: 15/ for test: i915_query results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: syncobj_timeline results: parsing output: 18/ for test: kms_cursor_crc results: parsing output: 19/ for test: gem_render_copy results: parsing output: 20/ for test: kms_rotation_crc results: parsing output: 21/ for test: gem_render_copy results: parsing output: 22/ for test: gem_exec_schedule results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_ccs results: parsing output: 26/ for test: kms_psr2_sf results: parsing output: 27/ for test: kms_cursor_crc results: parsing output: 28/ for test: prime_mmap results: parsing output: 29/ for test: gem_exec_schedule results: parsing output: 30/ for test: syncobj_timeline results: parsing output: 31/ for test: fbdev results: parsing output: 32/ for test: syncobj_wait results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: gem_exec_balancer results: parsing output: 35/ for test: gem_ccs results: parsing output: 36/ for test: gem_fenced_exec_thrash results: parsing output: 37/ for test: kms_cursor_legacy results: parsing output: 38/ for test: kms_big_fb results: parsing output: 39/ for test: gem_mmap_wc results: parsing output: 40/ for test: kms_cursor_legacy results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: kms_addfb_basic results: parsing output: 43/ for test: gem_ctx_shared results: parsing output: 44/ for test: kms_flip results: parsing output: 45/ for test: kms_force_connector_basic results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: kms_plane_scaling results: parsing output: 48/ for test: kms_chamelium_audio results: parsing output: 49/ for test: gem_set_tiling_vs_gtt results: parsing output: 50/ for test: gem_lmem_swapping results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: prime_busy results: parsing output: 53/ for test: syncobj_wait results: parsing output: 54/ for test: kms_flip_scaled_crc results: parsing output: 55/ for test: gem_gtt_cpu_tlb results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gen9_exec_parse results: parsing output: 58/ for test: gem_softpin results: parsing output: 59/ for test: dmabuf_sync_file results: parsing output: 60/ for test: kms_dither results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: kms_chamelium_hpd results: parsing output: 63/ for test: kms_flip results: parsing output: 64/ for test: perf results: parsing output: 65/ for test: sw_sync results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_getfb results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: perf results: parsing output: 71/ for test: gem_exec_schedule results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_atomic results: parsing output: 74/ for test: kms_ccs results: parsing output: 75/ for test: gem_exec_balancer results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_ctx_exec results: parsing output: 78/ for test: kms_content_protection results: parsing output: 79/ for test: gem_eio results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: kms_flip_scaled_crc results: parsing output: 82/ for test: kms_psr results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: kms_vblank results: parsing output: 85/ for test: kms_pm_dc results: parsing output: 86/ for test: gem_userptr_blits results: parsing output: 87/ for test: gem_exec_fence results: parsing output: 88/ for test: kms_pm_rpm results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: gem_exec_create results: parsing output: 91/ for test: kms_psr results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_psr2_sf results: parsing output: 94/ for test: gem_exec_reloc results: parsing output: 95/ for test: kms_psr results: parsing output: 96/ for test: kms_flip results: parsing output: 97/ for test: kms_flip results: parsing output: 98/ for test: i915_suspend results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_exec_nop results: parsing output: 101/ for test: gem_pxp results: parsing output: 102/ for test: syncobj_basic results: parsing output: 103/ for test: gem_exec_suspend results: parsing output: 104/ for test: template results: parsing output: 105/ for test: gem_mmap_gtt results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: api_intel_bb results: parsing output: 108/ for test: kms_selftest results: parsing output: 109/ for test: gem_mmap_offset results: parsing output: 110/ for test: gem_spin_batch results: parsing output: 111/ for test: kms_cursor_legacy results: parsing output: 112/ for test: gen9_exec_parse results: parsing output: 113/ for test: kms_pipe_crc_basic results: parsing output: 114/ for test: gem_exec_fence results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: gem_set_tiling_vs_pwrite results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: vgem_basic results: parsing output: 119/ for test: i915_pm_rpm results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: perf_pmu results: parsing output: 122/ for test: kms_addfb_basic results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: kms_color_pipeline results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: api_intel_allocator results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_big_fb results: parsing output: 129/ for test: kms_prime results: parsing output: 130/ for test: i915_hangman results: parsing output: 131/ for test: kms_invalid_mode Done.