[57.611294] Initializing watchdogs [57.611358] /dev/watchdog0 [57.629443] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [57.639310] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [57.643654] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.646159] [001/131] (960s left) api_intel_allocator (reloc-allocator) [57.722053] Starting subtest: reloc-allocator [57.722996] Starting dynamic subtest: basic [57.746776] Dynamic subtest basic: SUCCESS (0.025s) [57.753994] Starting dynamic subtest: parallel-one [57.754855] Dynamic subtest parallel-one: SUCCESS (0.004s) [57.761686] Starting dynamic subtest: print [57.762539] Dynamic subtest print: SUCCESS (0.000s) [57.769673] Starting dynamic subtest: reuse [57.770612] Dynamic subtest reuse: SUCCESS (0.000s) [57.777782] Starting dynamic subtest: fork-reopen-allocator [57.778867] Dynamic subtest fork-reopen-allocator: SUCCESS (0.018s) [57.779968] Subtest reloc-allocator: SUCCESS (0.048s) [57.940273] [002/131] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [58.145918] Starting subtest: psr-rgb565-draw-mmap-gtt [58.147597] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [58.288581] [003/131] (960s left) kms_psr (pr-primary-page-flip) [58.489367] Subtest pr-primary-page-flip: SKIP (0.000s) [58.547713] [004/131] (959s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [58.741632] Starting subtest: cursorB-vs-flipB-atomic [58.744301] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [58.821377] [005/131] (959s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [59.024523] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s) [59.063580] [006/131] (959s left) gem_ctx_isolation (preservation) [59.151549] Starting subtest: preservation [59.152471] Starting dynamic subtest: rcs0 [59.531833] Dynamic subtest rcs0: SUCCESS (0.380s) [59.539235] Starting dynamic subtest: bcs0 [59.942594] Dynamic subtest bcs0: SUCCESS (0.410s) [59.950069] Starting dynamic subtest: vcs0 [60.385813] Dynamic subtest vcs0: SUCCESS (0.443s) [60.393135] Starting dynamic subtest: vcs1 [60.803549] Dynamic subtest vcs1: SUCCESS (0.418s) [60.811228] Starting dynamic subtest: vecs0 [61.208454] Dynamic subtest vecs0: SUCCESS (0.404s) [61.215553] Starting dynamic subtest: vecs1 [61.615220] Dynamic subtest vecs1: SUCCESS (0.407s) [61.622383] Starting dynamic subtest: ccs0 [62.026951] Dynamic subtest ccs0: SUCCESS (0.412s) [62.027936] Subtest preservation: SUCCESS (2.875s) [62.320610] [007/131] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [62.531122] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [62.532847] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [62.661830] [008/131] (955s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [62.862182] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [62.863162] Starting dynamic subtest: pipe-A-DP-3 [62.871814] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [62.879029] Starting dynamic subtest: pipe-B-DP-3 [62.892445] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [62.899900] Starting dynamic subtest: pipe-C-DP-3 [62.908322] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [62.915772] Starting dynamic subtest: pipe-D-DP-3 [62.926358] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [62.928383] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [63.299489] [009/131] (955s left) kms_big_fb (x-tiled-32bpp-rotate-0) [63.514439] Starting subtest: x-tiled-32bpp-rotate-0 [65.186538] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.672s) [65.430365] [010/131] (953s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [65.636695] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [65.638424] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [65.808911] [011/131] (953s left) gem_tiled_wc [65.938500] [012/131] (952s left) gem_set_tiling_vs_gtt [66.073395] [013/131] (952s left) gem_lmem_swapping (smem-oom) [69.611164] Starting subtest: smem-oom [69.613296] Starting dynamic subtest: lmem0 [85.213890] Dynamic subtest lmem0: CRASH (15.446s) [85.215107] Subtest smem-oom: SUCCESS (15.447s) [103.509990] Dynamic subtest lmem0: CRASH (33.749s) [103.511013] Subtest smem-oom: SUCCESS (33.751s) [121.775154] Dynamic subtest lmem0: CRASH (52.016s) [121.776201] Subtest smem-oom: SUCCESS (52.019s) [139.627623] Dynamic subtest lmem0: CRASH (69.871s) [139.628618] Subtest smem-oom: SUCCESS (69.873s) [160.972171] Dynamic subtest lmem0: CRASH (91.215s) [160.973203] Subtest smem-oom: SUCCESS (91.217s) [180.650318] Dynamic subtest lmem0: CRASH (110.893s) [180.651314] Subtest smem-oom: SUCCESS (110.895s) [202.015493] Dynamic subtest lmem0: CRASH (132.240s) [202.016598] Subtest smem-oom: SUCCESS (132.243s) [219.168326] Dynamic subtest lmem0: CRASH (149.403s) [219.169309] Subtest smem-oom: SUCCESS (149.405s) [237.831262] Dynamic subtest lmem0: CRASH (168.075s) [237.832256] Subtest smem-oom: SUCCESS (168.078s) [250.134934] Per-test timeout exceeded. Killing the current test with SIGQUIT. [257.378110] Closing watchdogs [257.387169] Initializing watchdogs [257.387212] /dev/watchdog0 [257.410913] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [257.420793] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [257.423301] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [257.427418] [014/131] (761s left) prime_vgem (basic-blt) [257.651942] Starting subtest: basic-blt [257.706687] Subtest basic-blt: SUCCESS (0.055s) [257.894223] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true [257.896330] [015/131] (761s left) kms_vrr (max-min) [258.115180] Starting subtest: max-min [258.117963] Subtest max-min: SKIP (0.000s) [258.221869] [016/131] (760s left) kms_flip (wf_vblank-ts-check-interruptible) [258.439192] Starting subtest: wf_vblank-ts-check-interruptible [258.443498] Starting dynamic subtest: A-DP3 [266.562549] Dynamic subtest A-DP3: SUCCESS (8.119s) [266.574281] Starting dynamic subtest: B-DP3 [274.602365] Dynamic subtest B-DP3: SUCCESS (8.039s) [274.613158] Starting dynamic subtest: C-DP3 [282.623343] Dynamic subtest C-DP3: SUCCESS (8.021s) [282.633578] Starting dynamic subtest: D-DP3 [290.636298] Dynamic subtest D-DP3: SUCCESS (8.013s) [290.638162] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.199s) [290.930827] [017/131] (728s left) kms_psr (psr-sprite-mmap-cpu) [291.142540] Subtest psr-sprite-mmap-cpu: SKIP (0.000s) [291.196916] [018/131] (728s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [291.416584] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [292.663799] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.240s) [292.804613] [019/131] (726s left) gen9_exec_parse (allowed-all) [292.892504] Subtest allowed-all: SKIP (0.000s) [292.963584] [020/131] (726s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [293.178930] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [293.180714] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [293.304116] [021/131] (726s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [293.535161] Starting subtest: extended-modeset-hang-oldfb-with-reset [293.536028] Starting dynamic subtest: pipe-A [304.106263] Dynamic subtest pipe-A: SUCCESS (10.570s) [304.124350] Starting dynamic subtest: pipe-D [314.755121] Dynamic subtest pipe-D: SUCCESS (10.644s) [314.756414] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.221s) [315.047670] [022/131] (704s left) gem_render_copy (linear) [315.140456] Starting subtest: linear [315.141436] Starting dynamic subtest: smem [315.242883] Dynamic subtest smem: SUCCESS (0.102s) [315.253900] Starting dynamic subtest: lmem0 [315.492762] Dynamic subtest lmem0: SUCCESS (0.249s) [315.493859] Subtest linear: SUCCESS (0.352s) [315.727394] [023/131] (703s left) gem_exec_reloc (basic-write-cpu-active) [315.814744] Subtest basic-write-cpu-active: SKIP (0.000s) [315.884839] [024/131] (703s left) i915_hangman (gt-engine-error) [315.979170] Starting subtest: gt-engine-error [315.980130] Starting dynamic subtest: rcs0 [316.821954] Dynamic subtest rcs0: SUCCESS (0.843s) [316.836289] Starting dynamic subtest: bcs0 [317.560398] Dynamic subtest bcs0: SUCCESS (0.738s) [317.571460] Starting dynamic subtest: vcs0 [318.327558] Dynamic subtest vcs0: SUCCESS (0.767s) [318.340683] Starting dynamic subtest: vcs1 [319.061386] Dynamic subtest vcs1: SUCCESS (0.733s) [319.072515] Starting dynamic subtest: vecs0 [319.863367] Dynamic subtest vecs0: SUCCESS (0.802s) [319.874602] Starting dynamic subtest: vecs1 [320.616560] Dynamic subtest vecs1: SUCCESS (0.753s) [320.628878] Starting dynamic subtest: ccs0 [321.437487] Dynamic subtest ccs0: SUCCESS (0.820s) [321.438571] Subtest gt-engine-error: SUCCESS (5.459s) [321.595317] [025/131] (698s left) kms_vblank (query-forked-busy-hang) [321.802263] Starting subtest: query-forked-busy-hang [321.804288] Starting dynamic subtest: pipe-A-DP-3 [348.587199] Dynamic subtest pipe-A-DP-3: SUCCESS (26.783s) [348.600202] Starting dynamic subtest: pipe-D-DP-3 [373.577767] Dynamic subtest pipe-D-DP-3: SUCCESS (24.988s) [373.578643] Subtest query-forked-busy-hang: SUCCESS (51.776s) [373.798379] [026/131] (645s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [374.005389] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [374.006309] Starting dynamic subtest: pipe-A-valid-mode [378.678966] Dynamic subtest pipe-A-valid-mode: SUCCESS (4.671s) [378.680861] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SUCCESS (4.673s) [378.945490] [027/131] (640s left) kms_frontbuffer_tracking (fbcpsr-tiling-y) [379.156907] Starting subtest: fbcpsr-tiling-y [379.158630] Subtest fbcpsr-tiling-y: SKIP (0.000s) [379.267861] [028/131] (640s left) gem_userptr_blits (access-control) [379.373525] Starting subtest: access-control [379.375419] Subtest access-control: SKIP (0.000s) [379.554860] [029/131] (640s left) gem_mmap_gtt (basic-write-read) [379.633606] Subtest basic-write-read: SKIP (0.000s) [379.697959] [030/131] (640s left) gem_exec_schedule (preempt-engines) [379.792549] Starting subtest: preempt-engines [379.793480] Starting dynamic subtest: rcs0 [382.042583] Dynamic subtest rcs0: SUCCESS (2.248s) [382.059275] Starting dynamic subtest: bcs0 [384.225973] Dynamic subtest bcs0: SUCCESS (2.180s) [384.242488] Starting dynamic subtest: vcs0 [386.483624] Dynamic subtest vcs0: SUCCESS (2.254s) [386.499087] Starting dynamic subtest: vcs1 [388.740299] Dynamic subtest vcs1: SUCCESS (2.254s) [388.757166] Starting dynamic subtest: vecs0 [390.997658] Dynamic subtest vecs0: SUCCESS (2.255s) [391.011509] Starting dynamic subtest: vecs1 [393.248686] Dynamic subtest vecs1: SUCCESS (2.249s) [393.268445] Starting dynamic subtest: ccs0 [395.438168] Dynamic subtest ccs0: SUCCESS (2.187s) [395.440113] Subtest preempt-engines: SUCCESS (15.646s) [395.827621] [031/131] (624s left) gem_ctx_isolation (nonpriv-switch) [395.919407] Starting subtest: nonpriv-switch [395.920323] Starting dynamic subtest: rcs0 [396.727202] Dynamic subtest rcs0: SUCCESS (0.807s) [396.738709] Starting dynamic subtest: bcs0 [397.594708] Dynamic subtest bcs0: SUCCESS (0.867s) [397.606372] Starting dynamic subtest: vcs0 [398.438815] Dynamic subtest vcs0: SUCCESS (0.843s) [398.450267] Starting dynamic subtest: vcs1 [399.343244] Dynamic subtest vcs1: SUCCESS (0.904s) [399.354540] Starting dynamic subtest: vecs0 [400.213727] Dynamic subtest vecs0: SUCCESS (0.870s) [400.225059] Starting dynamic subtest: vecs1 [401.078510] Dynamic subtest vecs1: SUCCESS (0.864s) [401.090453] Starting dynamic subtest: ccs0 [401.945984] Dynamic subtest ccs0: SUCCESS (0.867s) [401.947006] Subtest nonpriv-switch: SUCCESS (6.027s) [402.224752] [032/131] (617s left) debugfs_test (read_all_entries_display_on) [402.434300] Starting subtest: read_all_entries_display_on [403.159463] Subtest read_all_entries_display_on: SUCCESS (0.725s) [403.372101] [033/131] (616s left) gen9_exec_parse (bb-start-param) [403.457670] Subtest bb-start-param: SKIP (0.000s) [403.515689] [034/131] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [403.725862] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [403.727558] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [403.862628] [035/131] (616s left) gem_ctx_persistence (legacy-engines-cleanup) [403.946021] Starting subtest: legacy-engines-cleanup [403.946942] Starting dynamic subtest: render [404.043359] Dynamic subtest render: SUCCESS (0.097s) [404.057973] Starting dynamic subtest: bsd1 [404.060189] Dynamic subtest bsd1: SUCCESS (0.015s) [404.072155] Starting dynamic subtest: bsd2 [404.104270] Dynamic subtest bsd2: SUCCESS (0.044s) [404.119415] Starting dynamic subtest: blt [404.164828] Dynamic subtest blt: SUCCESS (0.059s) [404.206050] Starting dynamic subtest: vebox [404.225426] Dynamic subtest vebox: SUCCESS (0.059s) [404.226653] Subtest legacy-engines-cleanup: SUCCESS (0.280s) [404.407526] [036/131] (615s left) gem_exec_balancer (parallel-ordering) [404.788052] Starting subtest: parallel-ordering [406.227740] Subtest parallel-ordering: SUCCESS (1.440s) [406.439024] [037/131] (613s left) prime_mmap (test_reprime) [406.521335] Starting subtest: test_reprime [406.522225] Starting dynamic subtest: test_reprime-smem [406.568451] Dynamic subtest test_reprime-smem: SUCCESS (0.048s) [406.582196] Starting dynamic subtest: test_reprime-lmem0 [406.770238] Dynamic subtest test_reprime-lmem0: SUCCESS (0.201s) [406.771221] Subtest test_reprime: SUCCESS (0.250s) [406.909342] [038/131] (613s left) perf_pmu (render-node-busy) [407.011536] Starting subtest: render-node-busy [407.012491] Starting dynamic subtest: rcs0 [407.625069] Dynamic subtest rcs0: SUCCESS (0.612s) [407.640682] Starting dynamic subtest: bcs0 [408.185866] Dynamic subtest bcs0: SUCCESS (0.558s) [408.201713] Starting dynamic subtest: vcs0 [408.744740] Dynamic subtest vcs0: SUCCESS (0.556s) [408.761013] Starting dynamic subtest: vcs1 [409.299809] Dynamic subtest vcs1: SUCCESS (0.552s) [409.315850] Starting dynamic subtest: vecs0 [409.856870] Dynamic subtest vecs0: SUCCESS (0.554s) [409.873250] Starting dynamic subtest: vecs1 [410.418030] Dynamic subtest vecs1: SUCCESS (0.558s) [410.433788] Starting dynamic subtest: ccs0 [410.977853] Dynamic subtest ccs0: SUCCESS (0.557s) [410.979748] Subtest render-node-busy: SUCCESS (3.967s) [411.080939] [039/131] (609s left) gem_exec_reloc (basic-concurrent16) [411.169413] Subtest basic-concurrent16: SKIP (0.000s) [411.251528] [040/131] (609s left) syncobj_wait (invalid-reset-illegal-handle) [411.343163] Starting subtest: invalid-reset-illegal-handle [411.344173] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [411.539211] [041/131] (609s left) prime_vgem (fence-read-hang) [411.641955] Subtest fence-read-hang: SKIP (0.000s) [411.803272] [042/131] (608s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt) [412.016899] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt [412.018587] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [412.136627] [043/131] (608s left) gen3_render_tiledy_blits [412.289313] [044/131] (608s left) kms_psr (psr2-cursor-render) [412.496259] Subtest psr2-cursor-render: SKIP (0.000s) [412.549866] [045/131] (608s left) kms_psr (fbc-pr-suspend) [412.759160] Subtest fbc-pr-suspend: SKIP (0.000s) [412.817529] [046/131] (608s left) gem_madvise (dontneed-before-exec) [412.870579] Starting subtest: dontneed-before-exec [412.900410] Subtest dontneed-before-exec: SKIP (0.028s) [412.965663] [047/131] (608s left) kms_psr (fbc-psr2-cursor-render) [413.171386] Subtest fbc-psr2-cursor-render: SKIP (0.000s) [413.234265] [048/131] (607s left) perf (gen8-unprivileged-single-ctx-counters) [413.587500] Starting subtest: gen8-unprivileged-single-ctx-counters [413.589231] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [413.637440] [049/131] (607s left) kms_flip (nonexisting-fb-interruptible) [413.849418] Starting subtest: nonexisting-fb-interruptible [413.854168] Starting dynamic subtest: A-DP3 [414.186711] Dynamic subtest A-DP3: SUCCESS (0.332s) [414.229678] Starting dynamic subtest: B-DP3 [414.455290] Dynamic subtest B-DP3: SUCCESS (0.265s) [414.491930] Starting dynamic subtest: C-DP3 [414.724355] Dynamic subtest C-DP3: SUCCESS (0.267s) [414.762274] Starting dynamic subtest: D-DP3 [414.990473] Dynamic subtest D-DP3: SUCCESS (0.263s) [414.995649] Subtest nonexisting-fb-interruptible: SUCCESS (1.146s) [415.398560] [050/131] (605s left) gem_pxp (verify-pxp-stale-buf-execution) [418.010951] Starting subtest: verify-pxp-stale-buf-execution [418.013155] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s) [418.122507] [051/131] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [418.333901] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [418.335644] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [418.494997] [052/131] (602s left) syncobj_timeline (wait-any-complex) [418.573782] Starting subtest: wait-any-complex [418.637152] Subtest wait-any-complex: SUCCESS (0.063s) [418.793452] [053/131] (602s left) kms_joiner (invalid-modeset-force-big-joiner) [419.006083] Starting subtest: invalid-modeset-force-big-joiner [419.006876] Starting dynamic subtest: big_joiner_on_last_pipe [419.215159] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.211s) [419.216059] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.212s) [419.481821] [054/131] (602s left) gem_ringfill (basic-all) [419.939888] Starting subtest: basic-all [421.892779] Subtest basic-all: SUCCESS (1.953s) [422.047908] [055/131] (599s left) kms_cursor_crc (cursor-offscreen-32x10) [422.337565] Starting subtest: cursor-offscreen-32x10 [422.381464] Subtest cursor-offscreen-32x10: SKIP (0.042s) [422.785935] [056/131] (598s left) kms_psr (fbc-pr-basic) [422.996256] Subtest fbc-pr-basic: SKIP (0.000s) [423.058065] [057/131] (598s left) syncobj_basic (test-valid-cycle) [423.136370] Starting subtest: test-valid-cycle [423.137307] Subtest test-valid-cycle: SUCCESS (0.000s) [423.293680] [058/131] (598s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [423.507514] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc [423.509661] Starting dynamic subtest: pipe-A-DP-3 [423.518404] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [423.530672] Starting dynamic subtest: pipe-B-DP-3 [423.539424] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [423.551642] Starting dynamic subtest: pipe-C-DP-3 [423.560487] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [423.572617] Starting dynamic subtest: pipe-D-DP-3 [423.583497] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [423.585822] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [423.956545] [059/131] (597s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [424.168895] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [426.655114] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.486s) [426.874227] [060/131] (595s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [427.084922] Starting subtest: fbc-rgb101010-draw-blt [429.938738] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.853s) [430.153506] [061/131] (591s left) perf_pmu (busy) [430.228301] Starting subtest: busy [430.229261] Starting dynamic subtest: rcs0 [430.850802] Dynamic subtest rcs0: SUCCESS (0.621s) [430.866889] Starting dynamic subtest: bcs0 [431.413991] Dynamic subtest bcs0: SUCCESS (0.559s) [431.430543] Starting dynamic subtest: vcs0 [431.978788] Dynamic subtest vcs0: SUCCESS (0.561s) [431.995261] Starting dynamic subtest: vcs1 [432.544806] Dynamic subtest vcs1: SUCCESS (0.562s) [432.561530] Starting dynamic subtest: vecs0 [433.108951] Dynamic subtest vecs0: SUCCESS (0.560s) [433.125458] Starting dynamic subtest: vecs1 [433.671033] Dynamic subtest vecs1: SUCCESS (0.558s) [433.687476] Starting dynamic subtest: ccs0 [434.235059] Dynamic subtest ccs0: SUCCESS (0.560s) [434.236982] Subtest busy: SUCCESS (4.008s) [434.384537] [062/131] (587s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [434.597944] Starting subtest: fbcpsr-farfromfence-mmap-gtt [434.599855] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [434.719710] [063/131] (587s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [434.933429] Starting subtest: yf-tiled-64bpp-rotate-0 [434.935212] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [435.089932] [064/131] (587s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [435.170014] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [435.170954] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [435.323605] [065/131] (586s left) kms_chamelium_edid (hdmi-mode-timings) [435.614280] Subtest hdmi-mode-timings: SKIP (0.000s) [435.770945] [066/131] (586s left) dmabuf_sync_file (export-basic) [435.832202] Starting subtest: export-basic [435.833156] Subtest export-basic: SUCCESS (0.001s) [435.926530] [067/131] (586s left) kms_selftest (drm_plane_helper) [435.985365] Starting subtest: drm_plane_helper [435.995340] Starting dynamic subtest: drm_test_check_plane_state [436.122790] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.126s) [436.135802] Starting dynamic subtest: drm_test_check_invalid_plane_state [436.235183] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.110s) [436.237087] Subtest drm_plane_helper: SUCCESS (0.249s) [436.481164] [068/131] (586s left) prime_self_import (export-vs-gem_close-race) [436.533184] Starting subtest: export-vs-gem_close-race [441.634417] Subtest export-vs-gem_close-race: SUCCESS (5.102s) [441.794370] [069/131] (580s left) gem_ctx_shared (single-timeline) [441.902762] Starting subtest: single-timeline [441.937360] Subtest single-timeline: SUCCESS (0.031s) [442.229192] [070/131] (580s left) kms_flip (flip-vs-expired-vblank) [442.438082] Starting subtest: flip-vs-expired-vblank [442.442425] Starting dynamic subtest: A-DP3 [450.290799] Dynamic subtest A-DP3: SUCCESS (7.848s) [450.306372] Starting dynamic subtest: B-DP3 [458.044813] Dynamic subtest B-DP3: SUCCESS (7.753s) [458.059635] Starting dynamic subtest: C-DP3 [465.802192] Dynamic subtest C-DP3: SUCCESS (7.755s) [465.844856] Starting dynamic subtest: D-DP3 [473.586924] Dynamic subtest D-DP3: SUCCESS (7.780s) [473.589342] Subtest flip-vs-expired-vblank: SUCCESS (31.151s) [473.925959] [071/131] (548s left) kms_async_flips (crc) [474.131636] Starting subtest: crc [474.356366] Starting dynamic subtest: pipe-A-DP-3 [476.743975] Dynamic subtest pipe-A-DP-3: SUCCESS (2.387s) [476.972646] Starting dynamic subtest: pipe-B-DP-3 [479.188146] Dynamic subtest pipe-B-DP-3: SUCCESS (2.229s) [479.370344] Starting dynamic subtest: pipe-C-DP-3 [481.610569] Dynamic subtest pipe-C-DP-3: SUCCESS (2.253s) [481.795704] Starting dynamic subtest: pipe-D-DP-3 [484.011887] Dynamic subtest pipe-D-DP-3: SUCCESS (2.232s) [484.012852] Subtest crc: SUCCESS (9.880s) [484.424418] [072/131] (538s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [484.640275] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [484.642136] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [484.768714] [073/131] (538s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [484.854177] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [484.855252] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [485.005727] [074/131] (537s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [485.219040] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [485.220860] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [485.350220] [075/131] (537s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [485.567190] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [485.568999] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [485.705202] [076/131] (537s left) drm_fdinfo (virtual-busy) [485.777556] Starting subtest: virtual-busy [485.779415] Subtest virtual-busy: SKIP (0.000s) [485.876801] [077/131] (537s left) syncobj_wait (wait-all-for-submit-snapshot) [485.955274] Starting subtest: wait-all-for-submit-snapshot [486.038683] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [486.177827] [078/131] (537s left) kms_flip (dpms-off-confusion-interruptible) [486.396571] Starting subtest: dpms-off-confusion-interruptible [486.401440] Starting dynamic subtest: A-DP3 [494.205094] Dynamic subtest A-DP3: SUCCESS (7.803s) [494.248846] Starting dynamic subtest: B-DP3 [501.968122] Dynamic subtest B-DP3: SUCCESS (7.757s) [501.985218] Starting dynamic subtest: C-DP3 [509.695199] Dynamic subtest C-DP3: SUCCESS (7.722s) [509.739467] Starting dynamic subtest: D-DP3 [517.455771] Dynamic subtest D-DP3: SUCCESS (7.756s) [517.458194] Subtest dpms-off-confusion-interruptible: SUCCESS (31.061s) [517.785013] [079/131] (505s left) kms_lease (lease-get) [517.991538] Starting subtest: lease-get [517.993904] Starting dynamic subtest: pipe-A-DP-3 [517.994788] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s) [518.009748] Starting dynamic subtest: pipe-B-DP-3 [518.010671] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s) [518.023842] Starting dynamic subtest: pipe-C-DP-3 [518.025106] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s) [518.037668] Starting dynamic subtest: pipe-D-DP-3 [518.038908] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s) [518.040158] Subtest lease-get: SUCCESS (0.013s) [518.137071] [080/131] (505s left) kms_pipe_crc_basic (read-crc-frame-sequence) [518.343561] Starting subtest: read-crc-frame-sequence [518.345726] Starting dynamic subtest: pipe-A-DP-3 [519.005707] Dynamic subtest pipe-A-DP-3: SUCCESS (0.660s) [519.034874] Starting dynamic subtest: pipe-B-DP-3 [519.570644] Dynamic subtest pipe-B-DP-3: SUCCESS (0.561s) [519.585557] Starting dynamic subtest: pipe-C-DP-3 [520.129168] Dynamic subtest pipe-C-DP-3: SUCCESS (0.556s) [520.152645] Starting dynamic subtest: pipe-D-DP-3 [520.683854] Dynamic subtest pipe-D-DP-3: SUCCESS (0.551s) [520.684988] Subtest read-crc-frame-sequence: SUCCESS (2.340s) [520.985712] [081/131] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [521.202923] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [521.204719] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [521.331747] [082/131] (502s left) kms_pm_rpm (universal-planes) [523.067699] Starting subtest: universal-planes [523.074112] Starting dynamic subtest: plane-32 [525.926977] Dynamic subtest plane-32: SUCCESS (2.857s) [525.977388] Starting dynamic subtest: plane-41 [528.711214] Dynamic subtest plane-41: SUCCESS (2.779s) [528.760127] Starting dynamic subtest: plane-50 [531.474201] Dynamic subtest plane-50: SUCCESS (2.758s) [531.524969] Starting dynamic subtest: plane-59 [534.356880] Dynamic subtest plane-59: SUCCESS (2.877s) [534.407653] Starting dynamic subtest: plane-68 [537.144129] Dynamic subtest plane-68: SUCCESS (2.782s) [537.193748] Starting dynamic subtest: plane-77 [539.864371] Dynamic subtest plane-77: SUCCESS (2.715s) [539.871127] Subtest universal-planes: SUCCESS (16.798s) [540.258755] [083/131] (483s left) kms_plane (plane-position-covered) [540.467540] Starting subtest: plane-position-covered [540.913732] Starting dynamic subtest: pipe-A-plane-1 [541.381588] Dynamic subtest pipe-A-plane-1: SUCCESS (0.469s) [541.397815] Starting dynamic subtest: pipe-A-plane-2 [541.839771] Dynamic subtest pipe-A-plane-2: SUCCESS (0.457s) [541.856076] Starting dynamic subtest: pipe-A-plane-3 [542.298476] Dynamic subtest pipe-A-plane-3: SUCCESS (0.458s) [542.315483] Starting dynamic subtest: pipe-A-plane-4 [542.758642] Dynamic subtest pipe-A-plane-4: SUCCESS (0.459s) [542.772120] Starting dynamic subtest: pipe-A-plane-5 [542.779556] Dynamic subtest pipe-A-plane-5: SUCCESS (0.019s) [543.127044] Starting dynamic subtest: pipe-B-plane-1 [543.520664] Dynamic subtest pipe-B-plane-1: SUCCESS (0.408s) [543.539596] Starting dynamic subtest: pipe-B-plane-2 [543.947923] Dynamic subtest pipe-B-plane-2: SUCCESS (0.426s) [543.961396] Starting dynamic subtest: pipe-B-plane-3 [544.383182] Dynamic subtest pipe-B-plane-3: SUCCESS (0.434s) [544.396530] Starting dynamic subtest: pipe-B-plane-4 [544.822742] Dynamic subtest pipe-B-plane-4: SUCCESS (0.439s) [544.835916] Starting dynamic subtest: pipe-B-plane-5 [544.842274] Dynamic subtest pipe-B-plane-5: SUCCESS (0.018s) [544.843229] Subtest plane-position-covered: SUCCESS (4.373s) [545.117740] [084/131] (478s left) gem_mmap_offset (bad-extensions) [545.200392] Starting subtest: bad-extensions [545.201455] Subtest bad-extensions: SUCCESS (0.000s) [545.346417] [085/131] (478s left) syncobj_wait (wait-all-delayed-signal) [545.424909] Starting subtest: wait-all-delayed-signal [545.527077] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [545.629369] [086/131] (478s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [545.842419] Starting subtest: short-flip-after-cursor-toggle [546.846192] Subtest short-flip-after-cursor-toggle: SUCCESS (1.004s) [547.120258] [087/131] (476s left) kms_dsc (dsc-with-formats) [547.328608] Starting subtest: dsc-with-formats [547.345183] Subtest dsc-with-formats: SKIP (0.002s) [547.431050] [088/131] (476s left) gem_userptr_blits (sd-probe) [547.520271] Starting subtest: sd-probe [547.522095] Subtest sd-probe: SKIP (0.000s) [547.725721] [089/131] (476s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [547.931578] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [547.933941] Starting dynamic subtest: pipe-A-DP-3 [547.956164] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [547.968967] Starting dynamic subtest: pipe-B-DP-3 [547.992800] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [548.005365] Starting dynamic subtest: pipe-C-DP-3 [548.031227] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [548.043764] Starting dynamic subtest: pipe-D-DP-3 [548.067449] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [548.069548] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.014s) [548.388072] [090/131] (475s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [548.607638] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [548.609953] Starting dynamic subtest: pipe-A-valid-mode [550.476197] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.862s) [550.478146] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (1.866s) [550.767564] [091/131] (473s left) sysfs_timeslice_duration (duration) [550.867350] Starting subtest: duration [550.869996] Starting dynamic subtest: vecs0 [564.054970] Dynamic subtest vecs0: SUCCESS (13.185s) [564.070994] Starting dynamic subtest: ccs0 [577.193927] Dynamic subtest ccs0: SUCCESS (13.134s) [577.210692] Starting dynamic subtest: vcs0 [590.346096] Dynamic subtest vcs0: SUCCESS (13.147s) [590.363140] Starting dynamic subtest: bcs0 [603.475447] Dynamic subtest bcs0: SUCCESS (13.125s) [603.490856] Starting dynamic subtest: vecs1 [616.615640] Dynamic subtest vecs1: SUCCESS (13.137s) [616.632573] Starting dynamic subtest: rcs0 [629.746951] Dynamic subtest rcs0: SUCCESS (13.126s) [629.763746] Starting dynamic subtest: vcs1 [642.877727] Dynamic subtest vcs1: SUCCESS (13.126s) [642.882123] Subtest duration: SUCCESS (92.008s) [642.993450] [092/131] (381s left) kms_chamelium_frames (hdmi-frame-dump) [643.290592] Subtest hdmi-frame-dump: SKIP (0.000s) [643.441849] [093/131] (380s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [643.656977] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [643.658769] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [643.794403] [094/131] (380s left) gem_exec_basic (basic) [643.882127] Starting subtest: basic [643.883166] Starting dynamic subtest: rcs0-smem [643.886552] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [643.901603] Starting dynamic subtest: bcs0-smem [643.902513] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [643.915622] Starting dynamic subtest: vcs0-smem [643.916852] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [643.929671] Starting dynamic subtest: vcs1-smem [643.930870] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [643.943477] Starting dynamic subtest: vecs0-smem [643.944792] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [643.957442] Starting dynamic subtest: vecs1-smem [643.958589] Dynamic subtest vecs1-smem: SUCCESS (0.000s) [643.971105] Starting dynamic subtest: ccs0-smem [643.972359] Dynamic subtest ccs0-smem: SUCCESS (0.001s) [643.984896] Starting dynamic subtest: rcs0-lmem0 [643.986201] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s) [643.998781] Starting dynamic subtest: bcs0-lmem0 [643.999992] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s) [644.012523] Starting dynamic subtest: vcs0-lmem0 [644.013427] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s) [644.026454] Starting dynamic subtest: vcs1-lmem0 [644.027415] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s) [644.040569] Starting dynamic subtest: vecs0-lmem0 [644.041617] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s) [644.057178] Starting dynamic subtest: vecs1-lmem0 [644.058065] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s) [644.070783] Starting dynamic subtest: ccs0-lmem0 [644.071833] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s) [644.072918] Subtest basic: SUCCESS (0.023s) [644.120650] [095/131] (380s left) kms_pm_rpm (modeset-non-lpsp) [646.050387] Starting subtest: modeset-non-lpsp [646.583445] Subtest modeset-non-lpsp: SUCCESS (0.533s) [646.817027] [096/131] (377s left) kms_rotation_crc (exhaust-fences) [647.027594] Starting subtest: exhaust-fences [647.029337] Subtest exhaust-fences: SKIP (0.000s) [647.140964] [097/131] (377s left) gem_ccs (block-copy-uncompressed) [647.230189] Starting subtest: block-copy-uncompressed [647.232484] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [647.272224] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.041s) [647.285405] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0 [647.288429] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s) [647.303298] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem [647.405190] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.116s) [647.417832] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0 [647.520390] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.114s) [647.534769] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem [647.538057] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s) [647.552158] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-lmem0 [647.553135] Dynamic subtest xmajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s) [647.566541] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-smem [647.669511] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.116s) [647.683058] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-lmem0 [647.785159] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.115s) [647.799475] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem [647.801058] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s) [647.815316] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-lmem0 [647.816284] Dynamic subtest tile4-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s) [647.830653] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-smem [647.933398] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.116s) [647.946498] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-lmem0 [648.049867] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.115s) [648.064260] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem [648.067456] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s) [648.081868] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-lmem0 [648.082829] Dynamic subtest tile64-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s) [648.095599] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-smem [648.200019] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.116s) [648.213086] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-lmem0 [648.315272] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.114s) [648.316208] Subtest block-copy-uncompressed: SUCCESS (1.086s) [648.480990] [098/131] (376s left) perf_pmu (invalid-init) [648.554033] Starting subtest: invalid-init [648.583497] Subtest invalid-init: FAIL (0.018s) [648.711418] [099/131] (375s left) kms_color (legacy-gamma) [648.917510] Starting subtest: legacy-gamma [648.918457] Starting dynamic subtest: pipe-A-DP-3 [649.591347] Dynamic subtest pipe-A-DP-3: SUCCESS (0.673s) [649.620288] Starting dynamic subtest: pipe-B-DP-3 [650.196617] Dynamic subtest pipe-B-DP-3: SUCCESS (0.602s) [650.219366] Starting dynamic subtest: pipe-C-DP-3 [650.779895] Dynamic subtest pipe-C-DP-3: SUCCESS (0.581s) [650.794035] Starting dynamic subtest: pipe-D-DP-3 [651.390916] Dynamic subtest pipe-D-DP-3: SUCCESS (0.610s) [651.391998] Subtest legacy-gamma: SUCCESS (2.473s) [651.667394] [100/131] (373s left) i915_suspend (debugfs-reader) [651.762463] Starting subtest: debugfs-reader [673.031326] Subtest debugfs-reader: SUCCESS (6.044s) [673.582397] [101/131] (366s left) kms_chamelium_color (ctm-0-25) [673.816752] Subtest ctm-0-25: SKIP (0.000s) [673.878396] [102/131] (366s left) kms_atomic_interruptible (universal-setplane-cursor) [674.092851] Starting subtest: universal-setplane-cursor [674.093767] Starting dynamic subtest: pipe-A-DP-3 [680.405571] Dynamic subtest pipe-A-DP-3: SUCCESS (6.311s) [680.406518] Subtest universal-setplane-cursor: SUCCESS (6.313s) [680.651681] [103/131] (360s left) i915_pm_rpm (system-suspend-devices) [682.190063] Starting subtest: system-suspend-devices [690.091586] Subtest system-suspend-devices: SUCCESS (7.902s) [690.436946] [104/131] (350s left) gem_exec_fence (syncobj-invalid-wait) [690.940471] Starting subtest: syncobj-invalid-wait [690.941405] Subtest syncobj-invalid-wait: SUCCESS (0.001s) [691.357257] [105/131] (349s left) gem_pxp (reject-modify-context-protection-off-3) [693.966830] Starting subtest: reject-modify-context-protection-off-3 [693.969222] Subtest reject-modify-context-protection-off-3: SKIP (0.000s) [694.083391] [106/131] (346s left) kms_cursor_edge_walk (64x64-top-bottom) [694.293959] Starting subtest: 64x64-top-bottom [694.296340] Starting dynamic subtest: pipe-A-DP-3 [697.762945] Dynamic subtest pipe-A-DP-3: SUCCESS (3.467s) [697.785380] Starting dynamic subtest: pipe-D-DP-3 [701.088256] Dynamic subtest pipe-D-DP-3: SUCCESS (3.323s) [701.089226] Subtest 64x64-top-bottom: SUCCESS (6.795s) [701.358121] [107/131] (339s left) kms_big_fb (4-tiled-addfb) [701.581674] Starting subtest: 4-tiled-addfb [701.582561] Subtest 4-tiled-addfb: SUCCESS (0.000s) [701.692624] [108/131] (339s left) gem_exec_whisper (basic-queues-priority-all) [701.784182] Starting subtest: basic-queues-priority-all [723.691799] Subtest basic-queues-priority-all: SUCCESS (21.908s) [723.941044] [109/131] (317s left) syncobj_basic (create-signaled) [724.020987] Starting subtest: create-signaled [724.021913] Subtest create-signaled: SUCCESS (0.000s) [724.155655] [110/131] (316s left) gem_exec_schedule (u-fairslice) [724.254608] Starting subtest: u-fairslice [724.255595] Starting dynamic subtest: rcs0 [726.296729] Dynamic subtest rcs0: SUCCESS (2.040s) [726.313041] Starting dynamic subtest: bcs0 [728.315763] Dynamic subtest bcs0: SUCCESS (2.018s) [728.331956] Starting dynamic subtest: vcs0 [730.332687] Dynamic subtest vcs0: SUCCESS (2.017s) [730.348802] Starting dynamic subtest: vcs1 [732.351663] Dynamic subtest vcs1: SUCCESS (2.017s) [732.367602] Starting dynamic subtest: vecs0 [734.367821] Dynamic subtest vecs0: SUCCESS (2.016s) [734.384399] Starting dynamic subtest: vecs1 [736.385962] Dynamic subtest vecs1: SUCCESS (2.017s) [736.402121] Starting dynamic subtest: ccs0 [738.402905] Dynamic subtest ccs0: SUCCESS (2.015s) [738.403909] Subtest u-fairslice: SUCCESS (14.148s) [738.793226] [111/131] (302s left) kms_pm_backlight (brightness-with-dpms) [739.015493] Subtest brightness-with-dpms: SKIP (0.000s) [739.076163] [112/131] (302s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [739.291479] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [739.293315] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [739.441845] [113/131] (301s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [739.653254] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [739.655840] Starting dynamic subtest: pipe-A-DP-3 [743.484138] Dynamic subtest pipe-A-DP-3: SUCCESS (3.826s) [743.502920] Starting dynamic subtest: pipe-B-DP-3 [744.243069] Dynamic subtest pipe-B-DP-3: SUCCESS (0.753s) [744.290674] Starting dynamic subtest: pipe-C-DP-3 [745.029108] Dynamic subtest pipe-C-DP-3: SUCCESS (0.778s) [745.074582] Starting dynamic subtest: pipe-D-DP-3 [745.813911] Dynamic subtest pipe-D-DP-3: SUCCESS (0.777s) [745.815650] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SUCCESS (6.157s) [746.201857] [114/131] (295s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [746.282603] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [746.386941] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s) [746.511109] [115/131] (294s left) kms_addfb_basic (bad-pitch-128) [746.589861] Starting subtest: bad-pitch-128 [746.590792] Subtest bad-pitch-128: SUCCESS (0.000s) [746.862414] [116/131] (294s left) kms_properties (get_properties-sanity-non-atomic) [747.069943] Starting subtest: get_properties-sanity-non-atomic [747.072279] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s) [747.185561] [117/131] (294s left) kms_big_fb (y-tiled-16bpp-rotate-270) [747.403962] Starting subtest: y-tiled-16bpp-rotate-270 [747.405706] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [747.560596] [118/131] (294s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [747.773424] Starting subtest: cursorB-vs-flipB-legacy [747.775239] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s) [747.884496] [119/131] (293s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [748.103869] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [749.124825] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.021s) [749.396901] [120/131] (292s left) kms_cursor_crc (cursor-sliding-max-size) [749.852579] Starting subtest: cursor-sliding-max-size [749.855305] Subtest cursor-sliding-max-size: SKIP (0.000s) [750.068957] [121/131] (291s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [750.282706] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [750.414683] [122/131] (291s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [750.496634] Starting subtest: multi-wait-all-for-submit-signaled [750.497729] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [750.649318] [123/131] (291s left) gem_mmap_gtt (ptrace) [750.730845] Subtest ptrace: SKIP (0.000s) [750.819231] [124/131] (291s left) kms_force_connector_basic (force-connector-state) [750.930980] Starting subtest: force-connector-state [751.311597] Subtest force-connector-state: SUCCESS (0.381s) [751.759354] [125/131] (290s left) template (a) [751.841869] Starting subtest: A [751.842750] Subtest A: SUCCESS (0.000s) [751.972686] [126/131] (290s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [752.186440] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [752.188368] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [752.334945] [127/131] (289s left) kms_cursor_crc (cursor-onscreen-128x42) [752.682921] Starting subtest: cursor-onscreen-128x42 [752.687863] Starting dynamic subtest: pipe-A-DP-3 [755.242919] Dynamic subtest pipe-A-DP-3: SUCCESS (2.555s) [755.289657] Starting dynamic subtest: pipe-D-DP-3 [757.914234] Dynamic subtest pipe-D-DP-3: SUCCESS (2.639s) [757.915178] Subtest cursor-onscreen-128x42: SUCCESS (5.231s) [758.316683] [128/131] (284s left) kms_fbcon_fbt (fbc) [758.403742] Starting subtest: fbc [761.989367] Subtest fbc: SUCCESS (3.586s) [762.093103] [129/131] (280s left) gem_exec_flush (basic-batch-kernel-default-wb) [762.183295] Subtest basic-batch-kernel-default-wb: SKIP (0.000s) [762.276406] [130/131] (280s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [762.486913] Starting subtest: plane-scaler-unity-scaling-with-rotation [762.487782] Starting dynamic subtest: pipe-A [762.854536] Dynamic subtest pipe-A: SUCCESS (0.367s) [762.890326] Starting dynamic subtest: pipe-B [763.340039] Dynamic subtest pipe-B: SUCCESS (0.483s) [763.376458] Starting dynamic subtest: pipe-C [763.826114] Dynamic subtest pipe-C: SUCCESS (0.483s) [763.867711] Starting dynamic subtest: pipe-D [764.312147] Dynamic subtest pipe-D: SUCCESS (0.483s) [764.313810] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (1.826s) [764.656463] [131/131] (277s left) gem_fence_thrash (bo-write-verify-threaded-y) [764.708372] Starting subtest: bo-write-verify-threaded-y [764.738720] Subtest bo-write-verify-threaded-y: SKIP (0.030s) [764.841007] Closing watchdogs Done.