[50.464666] Initializing watchdogs
[50.464939]   /dev/watchdog0
[50.482714] [001/142] (960s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[50.847141] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[50.850880] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[51.304548] [002/142] (959s left) v3d/v3d_submit_cl (valid-submission)
[51.502810] Subtest valid-submission: SKIP (0.000s)
[51.565361] [003/142] (959s left) kms_pm_backlight (basic-brightness)
[51.810880] Subtest basic-brightness: SKIP (0.000s)
[51.851742] [004/142] (959s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_rc_ccs)
[52.234350] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs
[52.238439] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[52.667307] [005/142] (958s left) gem_ctx_bad_destroy (double-destroy)
[52.816745] Starting subtest: double-destroy
[52.818945] Subtest double-destroy: SUCCESS (0.000s)
[52.895569] [006/142] (958s left) kms_vblank (pipe-a-query-idle-hang)
[53.139688] Starting subtest: pipe-A-query-idle-hang
[60.028953] Subtest pipe-A-query-idle-hang: SUCCESS (6.891s)
[60.372800] [007/142] (950s left) kms_frontbuffer_tracking (fbcpsr-badstride)
[60.626903] Starting subtest: fbcpsr-badstride
[60.630848] Subtest fbcpsr-badstride: SKIP (0.000s)
[60.723508] [008/142] (950s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[60.966044] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[60.970533] Starting dynamic subtest: A-DP1
[62.362398] Dynamic subtest A-DP1: SUCCESS (1.390s)
[62.377291] Starting dynamic subtest: B-DP1
[63.482772] Dynamic subtest B-DP1: SUCCESS (1.083s)
[63.508776] Starting dynamic subtest: C-DP1
[64.521363] Dynamic subtest C-DP1: SUCCESS (1.071s)
[64.523431] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.552s)
[64.879856] [009/142] (946s left) vc4/vc4_label_bo (set-bad-name)
[65.072785] Subtest set-bad-name: SKIP (0.000s)
[65.134425] [010/142] (946s left) gem_userptr_blits (dmabuf-sync)
[65.331228] Starting subtest: dmabuf-sync
[65.338407] Subtest dmabuf-sync: SKIP (0.008s)
[65.471952] [011/142] (945s left) kms_chamelium_edid (hdmi-mode-timings)
[65.801143] Subtest hdmi-mode-timings: SKIP (0.000s)
[66.085910] [012/142] (945s left) i915_suspend (debugfs-reader)
[66.239514] Starting subtest: debugfs-reader
[85.069864] Subtest debugfs-reader: SUCCESS (3.456s)
[91.129723] [013/142] (941s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_mc_ccs)
[91.576820] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs
[91.580881] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.001s)
[91.920583] [014/142] (940s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[92.251737] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[92.536059] [015/142] (940s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[92.785735] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[92.789626] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[92.879057] [016/142] (940s left) gem_mmap_wc (bad-offset)
[93.022199] Starting subtest: bad-offset
[93.024425] Subtest bad-offset: SUCCESS (0.001s)
[93.129298] [017/142] (939s left) kms_properties (invalid-properties-legacy)
[93.367950] Starting subtest: invalid-properties-legacy
[93.497822] Subtest invalid-properties-legacy: SUCCESS (0.131s)
[93.580287] [018/142] (939s left) gem_compute (compute-square)
[93.720432] Starting subtest: compute-square
[93.724596] Subtest compute-square: SKIP (0.000s)
[93.794363] [019/142] (939s left) kms_psr (cursor_blt)
[93.938240] Subtest cursor_blt: SKIP (0.000s)
[93.979360] [020/142] (939s left) kms_selftest (drm_plane)
[94.118081] Starting subtest: drm_plane
[94.124802] Subtest drm_plane: SKIP (0.004s)
[94.196228] [021/142] (938s left) sysfs_heartbeat_interval (mixed)
[94.345794] Starting subtest: mixed
[94.348276] Starting dynamic subtest: vecs0
[99.578459] Dynamic subtest vecs0: SUCCESS (5.230s)
[99.597054] Starting dynamic subtest: vcs0
[104.851629] Dynamic subtest vcs0: SUCCESS (5.270s)
[104.871148] Starting dynamic subtest: bcs0
[110.134396] Dynamic subtest bcs0: SUCCESS (5.285s)
[110.152298] Starting dynamic subtest: rcs0
[115.403035] Dynamic subtest rcs0: SUCCESS (5.268s)
[115.405502] Subtest mixed: SUCCESS (21.058s)
[115.480297] [022/142] (917s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[115.899685] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[115.905879] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.005s)
[116.278207] [023/142] (916s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_ccs)
[116.739525] Starting subtest: pipe-C-random-ccs-data-y_tiled_ccs
[116.745747] Subtest pipe-C-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[117.111712] [024/142] (916s left) gem_exec_schedule (pi-shared-iova)
[117.427330] Starting subtest: pi-shared-iova
[117.429584] Starting dynamic subtest: rcs0
[117.505746] Dynamic subtest rcs0: SUCCESS (0.077s)
[117.526954] Starting dynamic subtest: bcs0
[117.578438] Dynamic subtest bcs0: SUCCESS (0.073s)
[117.604985] Starting dynamic subtest: vcs0
[117.634419] Dynamic subtest vcs0: SUCCESS (0.056s)
[117.659409] Starting dynamic subtest: vecs0
[117.691950] Dynamic subtest vecs0: SUCCESS (0.055s)
[117.694155] Subtest pi-shared-iova: SUCCESS (0.264s)
[117.919092] [025/142] (915s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[118.181303] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[119.745395] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.565s)
[119.902885] [026/142] (913s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[120.176845] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[120.180866] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[120.267455] [027/142] (913s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[122.936736] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[123.020472] [028/142] (910s left) kms_flip (2x-nonexisting-fb)
[123.257708] Starting subtest: 2x-nonexisting-fb
[123.261672] Subtest 2x-nonexisting-fb: SKIP (0.003s)
[123.368431] [029/142] (910s left) i915_pm_rps (thresholds)
[123.522956] Starting subtest: thresholds
[123.525678] Starting dynamic subtest: gt0
[133.644290] Dynamic subtest gt0: SUCCESS (10.120s)
[133.646329] Subtest thresholds: SUCCESS (10.121s)
[133.734156] [030/142] (899s left) gem_exec_schedule (independent)
[133.902314] Starting subtest: independent
[133.904501] Starting dynamic subtest: rcs0
[134.084699] Dynamic subtest rcs0: SUCCESS (0.181s)
[134.104719] Starting dynamic subtest: bcs0
[134.266549] Dynamic subtest bcs0: SUCCESS (0.181s)
[134.286293] Starting dynamic subtest: vcs0
[134.437689] Dynamic subtest vcs0: SUCCESS (0.170s)
[134.460549] Starting dynamic subtest: vecs0
[134.607257] Dynamic subtest vecs0: SUCCESS (0.169s)
[134.609463] Subtest independent: SUCCESS (0.705s)
[134.952261] [031/142] (898s left) kms_concurrent (pipe-a)
[135.193196] Starting subtest: pipe-A
[135.196196] Starting dynamic subtest: DP-1
[136.027277] Dynamic subtest DP-1: SUCCESS (0.830s)
[136.029991] Subtest pipe-A: SUCCESS (0.834s)
[136.346086] [032/142] (897s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[136.606603] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[139.175446] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (2.573s)
[139.310739] [033/142] (894s left) api_intel_allocator (two-level-inception)
[139.455965] Starting subtest: two-level-inception
[144.975699] Subtest two-level-inception: SUCCESS (5.520s)
[145.062813] [034/142] (888s left) gem_partial_pwrite_pread (reads-snoop)
[145.213079] Starting subtest: reads-snoop
[151.703903] Subtest reads-snoop: SUCCESS (6.490s)
[151.811043] [035/142] (881s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[152.070161] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[152.073967] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[152.177848] [036/142] (881s left) kms_lease (lease_again)
[152.412620] Starting subtest: lease_again
[152.417801] Starting dynamic subtest: pipe-A-DP-1
[152.421223] Dynamic subtest pipe-A-DP-1: SUCCESS (0.005s)
[152.447881] Starting dynamic subtest: pipe-B-DP-1
[152.449788] Dynamic subtest pipe-B-DP-1: SUCCESS (0.003s)
[152.469970] Starting dynamic subtest: pipe-C-DP-1
[152.472241] Dynamic subtest pipe-C-DP-1: SUCCESS (0.003s)
[152.474367] Subtest lease_again: SUCCESS (0.020s)
[152.527702] [037/142] (881s left) i915_pm_rpm (legacy-planes)
[154.361908] Starting subtest: legacy-planes
[154.364989] Starting dynamic subtest: plane-39
[156.477727] Dynamic subtest plane-39: SUCCESS (2.115s)
[156.501420] Starting dynamic subtest: plane-47
[158.454298] Dynamic subtest plane-47: SUCCESS (1.977s)
[158.457301] Subtest legacy-planes: SUCCESS (4.094s)
[158.937866] [038/142] (874s left) syncobj_wait (wait-all-delayed-signal)
[159.088569] Starting subtest: wait-all-delayed-signal
[159.191661] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[159.286240] [039/142] (874s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_rc_ccs)
[159.553087] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs
[159.556874] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[160.090747] [040/142] (873s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs)
[160.451902] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs
[160.459308] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[160.903393] [041/142] (873s left) gem_mmap_gtt (basic-read-write-distinct)
[161.048916] Starting subtest: basic-read-write-distinct
[161.083071] Subtest basic-read-write-distinct: SUCCESS (0.036s)
[161.204504] [042/142] (872s left) gem_ctx_shared (create-shared-gtt)
[161.374859] Starting subtest: create-shared-gtt
[163.525945] Subtest create-shared-gtt: SUCCESS (2.150s)
[163.736575] [043/142] (870s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_ccs)
[164.210125] Subtest pipe-D-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.000s)
[164.530879] [044/142] (869s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-5)
[164.778559] Starting subtest: plane-downscale-with-modifiers-factor-0-5
[164.780648] Starting dynamic subtest: pipe-A-DP-1
[166.030126] Dynamic subtest pipe-A-DP-1: SUCCESS (1.251s)
[166.053108] Starting dynamic subtest: pipe-B-DP-1
[167.334225] Dynamic subtest pipe-B-DP-1: SUCCESS (1.301s)
[167.357175] Starting dynamic subtest: pipe-C-DP-1
[168.342413] Dynamic subtest pipe-C-DP-1: SUCCESS (0.966s)
[168.366838] Subtest plane-downscale-with-modifiers-factor-0-5: SUCCESS (3.529s)
[168.806137] [045/142] (865s left) kms_busy (basic-hang)
[169.063163] Starting subtest: basic-hang
[169.065495] Starting dynamic subtest: flip-pipe-A
[169.677294] Dynamic subtest flip-pipe-A: SUCCESS (0.609s)
[169.697354] Starting dynamic subtest: modeset-pipe-A
[171.059849] Dynamic subtest modeset-pipe-A: SUCCESS (1.383s)
[171.083211] Starting dynamic subtest: flip-pipe-C
[171.787685] Dynamic subtest flip-pipe-C: SUCCESS (0.721s)
[171.809627] Starting dynamic subtest: modeset-pipe-C
[173.182365] Dynamic subtest modeset-pipe-C: SUCCESS (1.391s)
[173.186805] Subtest basic-hang: SUCCESS (4.119s)
[173.536984] [046/142] (860s left) gem_tiled_blits (basic)
[175.005436] Starting subtest: basic
[175.051301] Subtest basic: SUCCESS (0.047s)
[175.206378] [047/142] (859s left) syncobj_timeline (single-wait-all-signaled)
[175.485194] Starting subtest: single-wait-all-signaled
[175.487664] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[175.569225] [048/142] (858s left) syncobj_wait (invalid-signal-illegal-handle)
[175.716913] Starting subtest: invalid-signal-illegal-handle
[175.719436] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[175.802307] [049/142] (858s left) gem_fence_thrash (bo-write-verify-threaded-x)
[175.971639] Starting subtest: bo-write-verify-threaded-x
[178.088069] Subtest bo-write-verify-threaded-x: SUCCESS (2.142s)
[178.191599] [050/142] (856s left) prime_self_import (basic-with_fd_dup)
[178.328983] Starting subtest: basic-with_fd_dup
[178.336748] Subtest basic-with_fd_dup: SUCCESS (0.007s)
[178.437665] [051/142] (856s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[178.583998] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[178.637645] [052/142] (855s left) perf (non-system-wide-paranoid)
[178.927466] Starting subtest: non-system-wide-paranoid
[179.058193] Subtest non-system-wide-paranoid: SUCCESS (0.130s)
[179.122647] [053/142] (855s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_ccs)
[179.552957] Starting subtest: pipe-C-bad-pixel-format-y_tiled_ccs
[179.556892] Subtest pipe-C-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[179.924173] [054/142] (854s left) kms_psr (psr2_primary_page_flip)
[180.072820] Subtest psr2_primary_page_flip: SKIP (0.000s)
[180.123731] [055/142] (854s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[180.476382] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[180.480632] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[180.941468] [056/142] (853s left) gem_mmap_gtt (basic-small-copy-xy)
[181.086615] Starting subtest: basic-small-copy-XY
[184.263314] Subtest basic-small-copy-XY: SUCCESS (3.177s)
[184.361844] [057/142] (850s left) kms_frontbuffer_tracking (fbc-stridechange)
[184.737748] Starting subtest: fbc-stridechange
[186.352315] Subtest fbc-stridechange: SUCCESS (1.616s)
[186.508809] [058/142] (848s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[186.673794] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[186.677747] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[186.877170] [059/142] (847s left) vgem_basic (sysfs)
[187.118368] Starting subtest: sysfs
[187.121748] Subtest sysfs: SUCCESS (0.001s)
[187.191742] [060/142] (847s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[187.432422] Starting subtest: coverage-vs-premult-vs-constant
[187.753622] Starting dynamic subtest: pipe-A-DP-1
[188.195408] Dynamic subtest pipe-A-DP-1: SUCCESS (0.440s)
[188.217697] Starting dynamic subtest: pipe-C-DP-1
[188.847819] Dynamic subtest pipe-C-DP-1: SUCCESS (0.648s)
[188.850060] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.418s)
[189.229507] [061/142] (845s left) kms_prop_blob (invalid-set-prop)
[189.375603] Starting subtest: invalid-set-prop
[189.377901] Subtest invalid-set-prop: SUCCESS (0.000s)
[189.464408] [062/142] (845s left) kms_vblank (pipe-c-wait-idle)
[189.707022] Starting subtest: pipe-C-wait-idle
[192.318948] Subtest pipe-C-wait-idle: SUCCESS (2.614s)
[192.662201] [063/142] (842s left) kms_content_protection (atomic-dpms)
[192.938834] Starting subtest: atomic-dpms
[192.968741] Starting dynamic subtest: pipe-A-DP-1
[313.651129] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[314.397097] Closing watchdogs
[314.404317] Initializing watchdogs
[314.404500]   /dev/watchdog0
[314.432403] [064/142] (720s left) gem_workarounds (reset-context)
[314.620868] Starting subtest: reset-context
[314.648004] Subtest reset-context: SUCCESS (0.027s)
[314.762267] [065/142] (720s left) gem_lmem_swapping (parallel-random-verify)
[314.917224] Subtest parallel-random-verify: SKIP (0.000s)
[314.979347] [066/142] (720s left) kms_flip (flip-vs-modeset-vs-hang)
[315.206387] Starting subtest: flip-vs-modeset-vs-hang
[315.208649] Starting dynamic subtest: A-DP1
[363.301960] Dynamic subtest A-DP1: SUCCESS (48.091s)
[363.323967] Starting dynamic subtest: C-DP1
[409.253944] Dynamic subtest C-DP1: SUCCESS (45.948s)
[409.256307] Subtest flip-vs-modeset-vs-hang: SUCCESS (94.048s)
[426.068045] [067/142] (609s left) kms_atomic_transition (modeset-transition)
[426.311928] Starting subtest: modeset-transition
[426.313950] Starting dynamic subtest: 1x-outputs
[431.284137] Dynamic subtest 1x-outputs: SUCCESS (4.974s)
[431.382279] Subtest modeset-transition: SUCCESS (5.073s)
[431.731155] [068/142] (603s left) gem_ctx_persistence (legacy-engines-hostile)
[431.889452] Starting subtest: legacy-engines-hostile
[431.891901] Starting dynamic subtest: render
[431.932474] Dynamic subtest render: SUCCESS (0.040s)
[431.958960] Starting dynamic subtest: bsd
[432.027536] Dynamic subtest bsd: SUCCESS (0.091s)
[432.054148] Starting dynamic subtest: blt
[432.123453] Dynamic subtest blt: SUCCESS (0.091s)
[432.149989] Starting dynamic subtest: vebox
[432.220211] Dynamic subtest vebox: SUCCESS (0.092s)
[432.222380] Subtest legacy-engines-hostile: SUCCESS (0.333s)
[432.312477] [069/142] (602s left) kms_cursor_crc (cursor-onscreen-64x64)
[432.555691] Starting subtest: cursor-onscreen-64x64
[432.568244] Starting dynamic subtest: pipe-A-DP-1
[434.916227] Dynamic subtest pipe-A-DP-1: SUCCESS (2.348s)
[435.003640] Starting dynamic subtest: pipe-C-DP-1
[437.422800] Dynamic subtest pipe-C-DP-1: SUCCESS (2.442s)
[437.424997] Subtest cursor-onscreen-64x64: SUCCESS (4.869s)
[437.804521] [070/142] (597s left) kms_plane_alpha_blend (constant-alpha-max)
[438.049429] Starting subtest: constant-alpha-max
[438.362904] Starting dynamic subtest: pipe-A-DP-1
[439.080414] Dynamic subtest pipe-A-DP-1: FAIL (0.237s)
[439.102419] Starting dynamic subtest: pipe-C-DP-1
[439.669684] Dynamic subtest pipe-C-DP-1: FAIL (0.529s)
[439.671889] Subtest constant-alpha-max: FAIL (1.090s)
[439.711557] [071/142] (595s left) gem_exec_reloc (basic-gtt-read-noreloc)
[439.869515] Starting subtest: basic-gtt-read-noreloc
[439.877130] Subtest basic-gtt-read-noreloc: SUCCESS (0.007s)
[440.063701] [072/142] (595s left) kms_feature_discovery (display)
[440.303406] Starting subtest: display
[440.305737] Subtest display: SUCCESS (0.000s)
[440.397401] [073/142] (595s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[440.664583] Starting subtest: yf-tiled-64bpp-rotate-270
[440.668803] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[440.763059] [074/142] (594s left) gem_mmap_gtt (cpuset-medium-copy)
[440.907711] Starting subtest: cpuset-medium-copy
[451.759597] Subtest cpuset-medium-copy: SUCCESS (10.851s)
[451.899144] [075/142] (583s left) kms_force_connector_basic (force-connector-state)
[452.161327] Subtest force-connector-state: SKIP (0.000s)
[452.213602] [076/142] (583s left) gem_create (create-invalid-size)
[452.357457] Starting subtest: create-invalid-size
[452.359519] Subtest create-invalid-size: SUCCESS (0.000s)
[452.580990] [077/142] (583s left) gem_userptr_blits (probe)
[452.799433] Starting subtest: probe
[453.666940] Subtest probe: SUCCESS (0.868s)
[453.780049] [078/142] (581s left) gem_exec_fence (syncobj-import)
[454.411560] Starting subtest: syncobj-import
[454.416977] Subtest syncobj-import: SUCCESS (0.006s)
[454.780479] [079/142] (580s left) perf_pmu (pmu-read)
[454.932998] Starting subtest: pmu-read
[454.940006] Subtest pmu-read: SUCCESS (0.007s)
[455.045870] [080/142] (580s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[455.315197] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[455.319319] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[455.415450] [081/142] (580s left) dmabuf_sync_file (export-multiwait)
[455.571636] Starting subtest: export-multiwait
[455.574334] Subtest export-multiwait: SUCCESS (0.002s)
[455.645735] [082/142] (580s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[455.883696] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[455.886380] Starting dynamic subtest: pipe-A-valid-mode
[455.985223] Dynamic subtest pipe-A-valid-mode: SKIP (0.098s)
[455.990420] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.102s)
[456.310576] [083/142] (579s left) gem_basic (multigpu-create-close)
[456.456197] Starting subtest: multigpu-create-close
[456.460223] Subtest multigpu-create-close: SKIP (0.000s)
[456.543948] [084/142] (579s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_mc_ccs)
[457.029490] Subtest pipe-D-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[457.355013] [085/142] (578s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[457.622014] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[457.626074] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[457.719243] [086/142] (578s left) kms_chamelium_color (ctm-max)
[457.962962] Subtest ctm-max: SKIP (0.000s)
[458.020537] [087/142] (578s left) drm_fdinfo (most-busy-check-all)
[458.170561] Starting subtest: most-busy-check-all
[458.172657] Starting dynamic subtest: rcs0
[458.695257] Dynamic subtest rcs0: SUCCESS (0.524s)
[458.727920] Starting dynamic subtest: bcs0
[459.225862] Dynamic subtest bcs0: SUCCESS (0.527s)
[459.255339] Starting dynamic subtest: vcs0
[459.753828] Dynamic subtest vcs0: SUCCESS (0.525s)
[459.785058] Starting dynamic subtest: vecs0
[460.282369] Dynamic subtest vecs0: SUCCESS (0.525s)
[460.284667] Subtest most-busy-check-all: SUCCESS (2.115s)
[460.369204] [088/142] (575s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs)
[460.856734] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[461.185386] [089/142] (575s left) gem_exec_reloc (basic-range-active)
[461.340904] Starting subtest: basic-range-active
[461.437600] Subtest basic-range-active: SUCCESS (0.094s)
[461.632290] [090/142] (574s left) gem_softpin (safe-alignment)
[461.789174] Starting subtest: safe-alignment
[461.818170] Subtest safe-alignment: SUCCESS (0.029s)
[461.933378] [091/142] (574s left) kms_universal_plane (cursor-fb-leak-pipe-b)
[462.179687] Starting subtest: cursor-fb-leak-pipe-B
[462.833136] Subtest cursor-fb-leak-pipe-B: SUCCESS (0.654s)
[463.181536] [092/142] (573s left) v3d/v3d_create_bo (create-bo-4096)
[463.407673] Subtest create-bo-4096: SKIP (0.000s)
[463.480876] [093/142] (572s left) vc4/vc4_tiling (get-bad-flags)
[463.687511] Subtest get-bad-flags: SKIP (0.000s)
[463.761477] [094/142] (572s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_mc_ccs)
[464.172022] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_mc_ccs
[464.178037] Subtest pipe-B-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[464.588980] [095/142] (571s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[465.053623] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[465.057707] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.001s)
[465.418579] [096/142] (571s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[465.663098] Starting subtest: cursorA-vs-flipA-atomic
[476.890250] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.226s)
[477.236228] [097/142] (559s left) perf (invalid-oa-format-id)
[477.510817] Starting subtest: invalid-oa-format-id
[477.557314] Subtest invalid-oa-format-id: SUCCESS (0.047s)
[477.614978] [098/142] (559s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[477.762986] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[477.764950] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[477.866612] [099/142] (558s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[478.111913] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[478.115817] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[478.214950] [100/142] (558s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[478.474845] Starting subtest: y-tiled-64bpp-rotate-180
[486.055375] Subtest y-tiled-64bpp-rotate-180: SUCCESS (7.578s)
[486.999321] [101/142] (549s left) gem_exec_reloc (basic-gtt)
[487.155787] Starting subtest: basic-gtt
[487.179188] Subtest basic-gtt: SUCCESS (0.022s)
[487.380557] [102/142] (549s left) i915_pm_rpm (cursor)
[489.113300] Starting subtest: cursor
[491.508721] Subtest cursor: SUCCESS (2.400s)
[491.983236] [103/142] (544s left) kms_cursor_crc (cursor-sliding-64x21)
[492.233528] Starting subtest: cursor-sliding-64x21
[492.243665] Starting dynamic subtest: pipe-A-DP-1
[495.913388] Dynamic subtest pipe-A-DP-1: SUCCESS (3.671s)
[496.008280] Starting dynamic subtest: pipe-C-DP-1
[499.770168] Dynamic subtest pipe-C-DP-1: SUCCESS (3.779s)
[499.772223] Subtest cursor-sliding-64x21: SUCCESS (7.532s)
[500.125399] [104/142] (536s left) sw_sync (alloc_fence)
[500.271333] Starting subtest: alloc_fence
[500.273972] Subtest alloc_fence: SUCCESS (0.000s)
[500.354542] [105/142] (536s left) gem_ctx_isolation (preservation-s3)
[500.522214] Starting subtest: preservation-S3
[500.524462] Starting dynamic subtest: rcs0
[519.563052] Dynamic subtest rcs0: SUCCESS (2.702s)
[519.592517] Starting dynamic subtest: bcs0
[538.645328] Dynamic subtest bcs0: SUCCESS (2.864s)
[538.670261] Starting dynamic subtest: vcs0
[557.527160] Dynamic subtest vcs0: SUCCESS (2.487s)
[557.556093] Starting dynamic subtest: vecs0
[576.520134] Dynamic subtest vecs0: SUCCESS (2.592s)
[576.522605] Subtest preservation-S3: SUCCESS (10.659s)
[580.784081] [106/142] (525s left) gem_userptr_blits (stress-mm-invalidate-close)
[580.973970] Starting subtest: stress-mm-invalidate-close
[583.123639] Subtest stress-mm-invalidate-close: SUCCESS (2.149s)
[583.275921] [107/142] (523s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[583.525773] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[583.529902] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[583.626436] [108/142] (522s left) gem_exec_reloc (basic-cpu-wc)
[583.779662] Starting subtest: basic-cpu-wc
[583.801790] Subtest basic-cpu-wc: SUCCESS (0.022s)
[583.993709] [109/142] (522s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled)
[584.137502] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled
[584.140052] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.002s)
[584.226005] [110/142] (522s left) kms_getfb (getfb2-handle-not-fb)
[584.371026] Starting subtest: getfb2-handle-not-fb
[584.471407] Subtest getfb2-handle-not-fb: SUCCESS (0.100s)
[584.574981] [111/142] (522s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted)
[584.722502] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted
[584.724975] Subtest invalid-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.002s)
[584.808008] [112/142] (521s left) gem_exec_gttfill (basic)
[584.980525] Starting subtest: basic
[611.612593] Subtest basic: SUCCESS (26.632s)
[611.829410] [113/142] (494s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[612.213971] Starting subtest: fbcpsr-1p-rte
[612.218001] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[612.308960] [114/142] (494s left) gen9_exec_parse (bb-secure)
[612.483264] Starting subtest: bb-secure
[612.485645] Subtest bb-secure: SUCCESS (0.003s)
[612.725670] [115/142] (494s left) api_intel_allocator (reloc-allocator)
[612.878034] Starting subtest: reloc-allocator
[612.881289] Starting dynamic subtest: basic
[612.883609] Dynamic subtest basic: SUCCESS (0.005s)
[612.911030] Starting dynamic subtest: parallel-one
[612.913198] Dynamic subtest parallel-one: SUCCESS (0.010s)
[612.937892] Starting dynamic subtest: print
[612.939995] Dynamic subtest print: SUCCESS (0.000s)
[612.964724] Starting dynamic subtest: reuse
[612.966805] Dynamic subtest reuse: SUCCESS (0.000s)
[612.990942] Starting dynamic subtest: fork-reopen-allocator
[612.993053] Dynamic subtest fork-reopen-allocator: SUCCESS (0.043s)
[612.995136] Subtest reloc-allocator: SUCCESS (0.073s)
[613.060148] [116/142] (493s left) v3d/v3d_submit_csd (bad-multisync-pad)
[613.283451] Subtest bad-multisync-pad: SKIP (0.000s)
[613.359027] [117/142] (493s left) prime_vgem (busy)
[613.542230] Starting subtest: busy
[613.544526] Starting dynamic subtest: rcs0
[613.573980] Dynamic subtest rcs0: SUCCESS (0.030s)
[613.604693] Starting dynamic subtest: vcs0
[613.607093] Dynamic subtest vcs0: SUCCESS (0.017s)
[613.632151] Starting dynamic subtest: vecs0
[613.634247] Dynamic subtest vecs0: SUCCESS (0.016s)
[613.636192] Subtest busy: SUCCESS (0.072s)
[613.709124] [118/142] (493s left) prime_self_import (reimport-vs-gem_close-race)
[613.849833] Starting subtest: reimport-vs-gem_close-race
[618.881068] Subtest reimport-vs-gem_close-race: SUCCESS (5.030s)
[618.978845] [119/142] (488s left) gem_exec_balancer (bonded-sync)
[619.151527] Starting subtest: bonded-sync
[622.938128] Subtest bonded-sync: SUCCESS (3.786s)
[626.896310] [120/142] (480s left) gem_exec_balancer (sequential)
[627.062972] Starting subtest: sequential
[630.809869] Subtest sequential: SUCCESS (3.746s)
[634.777887] [121/142] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[635.037830] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[635.041987] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[635.142806] [122/142] (471s left) gen9_exec_parse (bb-oversize)
[635.309477] Starting subtest: bb-oversize
[635.513374] Subtest bb-oversize: SKIP (0.184s)
[635.757299] [123/142] (471s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[636.143207] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[636.147256] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[636.242989] [124/142] (470s left) gem_exec_params (invalid-bsd-ring)
[636.396965] Starting subtest: invalid-bsd-ring
[636.401915] Subtest invalid-bsd-ring: SUCCESS (0.002s)
[636.529832] [125/142] (470s left) kms_cursor_crc (cursor-offscreen-512x170)
[636.792240] Starting subtest: cursor-offscreen-512x170
[636.796897] Subtest cursor-offscreen-512x170: SKIP (0.003s)
[636.909965] [126/142] (470s left) kms_flip (2x-wf_vblank-ts-check)
[637.136621] Starting subtest: 2x-wf_vblank-ts-check
[637.140513] Subtest 2x-wf_vblank-ts-check: SKIP (0.003s)
[637.259907] [127/142] (470s left) kms_psr (psr2_basic)
[637.405597] Subtest psr2_basic: SKIP (0.000s)
[637.459971] [128/142] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[637.705491] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[637.709462] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[637.810294] [129/142] (469s left) gem_exec_schedule (u-lateslice)
[637.995561] Starting subtest: u-lateslice
[637.997747] Starting dynamic subtest: rcs0
[638.035306] Dynamic subtest rcs0: SUCCESS (0.038s)
[638.065545] Starting dynamic subtest: bcs0
[638.073553] Dynamic subtest bcs0: SUCCESS (0.035s)
[638.104627] Starting dynamic subtest: vcs0
[638.106978] Dynamic subtest vcs0: SUCCESS (0.028s)
[638.132136] Starting dynamic subtest: vecs0
[638.138756] Dynamic subtest vecs0: SUCCESS (0.029s)
[638.140808] Subtest u-lateslice: SUCCESS (0.142s)
[638.510654] [130/142] (468s left) kms_big_fb (linear-32bpp-rotate-90)
[638.775278] Starting subtest: linear-32bpp-rotate-90
[638.862363] Subtest linear-32bpp-rotate-90: SKIP (0.083s)
[638.961143] [131/142] (468s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[639.210529] Starting subtest: flip-vs-cursor-varying-size
[658.831571] Subtest flip-vs-cursor-varying-size: SUCCESS (19.619s)
[659.157926] [132/142] (448s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[659.415431] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[659.419476] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[659.538717] [133/142] (448s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[659.790478] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[659.794245] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[659.888557] [134/142] (447s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[660.132711] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[671.207497] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.074s)
[671.556143] [135/142] (436s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[671.832563] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[671.836582] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[671.935857] [136/142] (435s left) kms_draw_crc (draw-method-mmap-wc)
[672.178637] Starting subtest: draw-method-mmap-wc
[672.180766] Starting dynamic subtest: xrgb8888-untiled
[672.505306] Dynamic subtest xrgb8888-untiled: SUCCESS (0.328s)
[672.533153] Starting dynamic subtest: rgb565-untiled
[672.788355] Dynamic subtest rgb565-untiled: SUCCESS (0.280s)
[672.820077] Starting dynamic subtest: xrgb2101010-untiled
[673.105444] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.314s)
[673.130943] Starting dynamic subtest: xrgb8888-xtiled
[673.326315] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.214s)
[673.352266] Starting dynamic subtest: rgb565-xtiled
[673.526927] Dynamic subtest rgb565-xtiled: SUCCESS (0.197s)
[673.551899] Starting dynamic subtest: xrgb2101010-xtiled
[673.739630] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.214s)
[673.765270] Starting dynamic subtest: xrgb8888-ytiled
[673.956127] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.214s)
[673.981334] Starting dynamic subtest: rgb565-ytiled
[674.156664] Dynamic subtest rgb565-ytiled: SUCCESS (0.197s)
[674.184200] Starting dynamic subtest: xrgb2101010-ytiled
[674.371407] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.214s)
[674.373724] Subtest draw-method-mmap-wc: SUCCESS (2.197s)
[674.485761] [137/142] (433s left) perf_pmu (busy-hang)
[674.639312] Starting subtest: busy-hang
[674.641529] Starting dynamic subtest: rcs0
[675.685934] Dynamic subtest rcs0: SUCCESS (1.044s)
[675.714150] Starting dynamic subtest: bcs0
[676.729913] Dynamic subtest bcs0: SUCCESS (1.041s)
[676.757326] Starting dynamic subtest: vcs0
[677.771966] Dynamic subtest vcs0: SUCCESS (1.039s)
[677.799282] Starting dynamic subtest: vecs0
[678.814378] Dynamic subtest vecs0: SUCCESS (1.039s)
[678.817288] Subtest busy-hang: SUCCESS (4.177s)
[678.920367] [138/142] (428s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[679.182051] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[681.490043] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.313s)
[681.639116] [139/142] (426s left) kms_flip (dpms-vs-vblank-race)
[681.859012] Starting subtest: dpms-vs-vblank-race
[681.866270] Starting dynamic subtest: A-DP1
[686.250102] Dynamic subtest A-DP1: SUCCESS (4.379s)
[686.276886] Starting dynamic subtest: B-DP1
[690.524812] Dynamic subtest B-DP1: SUCCESS (4.275s)
[690.551989] Starting dynamic subtest: C-DP1
[694.712027] Dynamic subtest C-DP1: SUCCESS (4.185s)
[694.714128] Subtest dpms-vs-vblank-race: SUCCESS (12.853s)
[695.101572] [140/142] (412s left) gem_exec_fence (basic-await)
[695.419112] Starting subtest: basic-await
[695.421242] Starting dynamic subtest: rcs0
[695.549974] Dynamic subtest rcs0: SUCCESS (0.130s)
[695.576632] Starting dynamic subtest: bcs0
[695.686005] Dynamic subtest bcs0: SUCCESS (0.131s)
[695.713155] Starting dynamic subtest: vcs0
[695.816408] Dynamic subtest vcs0: SUCCESS (0.130s)
[695.845883] Starting dynamic subtest: vecs0
[695.951644] Dynamic subtest vecs0: SUCCESS (0.131s)
[695.954342] Subtest basic-await: SUCCESS (0.535s)
[696.633001] [141/142] (411s left) gem_exec_whisper (basic-queues-priority)
[696.801688] Starting subtest: basic-queues-priority
[709.087554] Subtest basic-queues-priority: SUCCESS (12.283s)
[709.300589] [142/142] (398s left) kms_vblank (pipe-d-wait-idle)
[709.540855] Subtest pipe-D-wait-idle: SKIP (0.000s)
[709.627932] Closing watchdogs
Done.