[40.353173] Initializing watchdogs
[40.353366]   /dev/watchdog0
[40.387046] [001/139] (960s left) perf (gen8-unprivileged-single-ctx-counters)
[40.816107] Starting subtest: gen8-unprivileged-single-ctx-counters
[41.048710] Subtest gen8-unprivileged-single-ctx-counters: SUCCESS (0.233s)
[41.149499] [002/139] (959s left) gem_exec_flush (basic-wb-rw-before-default)
[41.424490] Starting subtest: basic-wb-rw-before-default
[47.030307] Subtest basic-wb-rw-before-default: SUCCESS (5.495s)
[47.130332] [003/139] (953s left) gem_mmap_offset (bad-extensions)
[47.367195] Starting subtest: bad-extensions
[47.386084] Subtest bad-extensions: SUCCESS (0.000s)
[47.471689] [004/139] (953s left) kms_prop_blob (blob-prop-validate)
[47.702514] Starting subtest: blob-prop-validate
[47.724070] Subtest blob-prop-validate: SUCCESS (0.000s)
[47.807159] [005/139] (953s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf-tiled-ccs)
[48.236081] Starting subtest: pipe-A-crc-primary-rotation-180-yf-tiled-ccs
[49.150286] Subtest pipe-A-crc-primary-rotation-180-yf-tiled-ccs: SUCCESS (0.925s)
[49.747493] [006/139] (951s left) kms_vblank (ts-continuation-suspend)
[50.047333] Starting subtest: ts-continuation-suspend
[50.069215] Starting dynamic subtest: pipe-A-DP-1
[67.246198] Dynamic subtest pipe-A-DP-1: SUCCESS (1.937s)
[67.283032] Starting dynamic subtest: pipe-C-DP-1
[85.237614] Dynamic subtest pipe-C-DP-1: SUCCESS (1.919s)
[85.259062] Subtest ts-continuation-suspend: SUCCESS (3.865s)
[90.612552] [007/139] (947s left) kms_atomic (atomic-invalid-params)
[90.908757] Starting subtest: atomic-invalid-params
[90.927519] Starting dynamic subtest: pipe-A-DP-1
[91.213709] Dynamic subtest pipe-A-DP-1: SUCCESS (0.297s)
[91.235145] Subtest atomic-invalid-params: SUCCESS (0.300s)
[91.562315] [008/139] (946s left) kms_pm_lpsp (kms-lpsp)
[92.881985] Starting subtest: kms-lpsp
[92.924971] Subtest kms-lpsp: SKIP (0.000s)
[93.040286] [009/139] (944s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[93.264487] Starting subtest: tiled-to-tiled
[93.396188] Subtest tiled-to-tiled: SUCCESS (0.119s)
[93.508539] [010/139] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[93.869110] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[93.909318] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[93.993468] [011/139] (944s left) gem_exec_schedule (semaphore-resolve)
[94.392330] Starting subtest: semaphore-resolve
[94.411353] Subtest semaphore-resolve: SUCCESS (0.057s)
[94.676421] [012/139] (943s left) gem_fence_thrash (bo-write-verify-threaded-x)
[94.905131] Starting subtest: bo-write-verify-threaded-x
[100.517693] Subtest bo-write-verify-threaded-x: SUCCESS (5.426s)
[100.616417] [013/139] (937s left) kms_plane_scaling (planes-downscale-factor-0-75)
[100.935408] Starting subtest: planes-downscale-factor-0-75
[100.959035] Starting dynamic subtest: pipe-A-DP-1
[101.050262] Dynamic subtest pipe-A-DP-1: SUCCESS (0.104s)
[101.090797] Starting dynamic subtest: pipe-B-DP-1
[101.439004] Dynamic subtest pipe-B-DP-1: SUCCESS (0.396s)
[101.460305] Subtest planes-downscale-factor-0-75: SUCCESS (0.525s)
[101.887384] [014/139] (936s left) api_intel_bb (misplaced-blitter)
[102.128244] Starting subtest: misplaced-blitter
[102.147310] Subtest misplaced-blitter: SUCCESS (0.014s)
[102.253216] [015/139] (936s left) syncobj_timeline (wait-for-submit-snapshot)
[102.486387] Starting subtest: wait-for-submit-snapshot
[102.546184] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[102.656628] [016/139] (935s left) dmabuf (all-tests)
[102.875466] Starting subtest: all-tests
[102.896603] Starting dynamic subtest: sanitycheck
[102.952755] Dynamic subtest sanitycheck: SUCCESS (0.081s)
[102.988998] Starting dynamic subtest: dma_fence
[103.141219] Dynamic subtest dma_fence: SUCCESS (0.183s)
[103.178173] Starting dynamic subtest: dma_fence_chain
[127.152464] Dynamic subtest dma_fence_chain: SUCCESS (24.014s)
[127.190991] Starting dynamic subtest: dma_fence_unwrap
[127.230041] Dynamic subtest dma_fence_unwrap: SUCCESS (0.074s)
[127.267972] Starting dynamic subtest: dma_resv
[127.312599] Dynamic subtest dma_resv: SUCCESS (0.071s)
[127.333389] Subtest all-tests: SUCCESS (24.425s)
[127.419072] [017/139] (911s left) kms_content_protection (uevent)
[127.760238] Starting subtest: uevent
[127.803599] Starting dynamic subtest: pipe-A-DP-1
[163.924962] Dynamic subtest pipe-A-DP-1: FAIL (35.024s)
[163.943719] Subtest uevent: FAIL (35.200s)
[164.040722] [018/139] (874s left) syncobj_wait (invalid-reset-one-illegal-handle)
[164.270302] Starting subtest: invalid-reset-one-illegal-handle
[164.291734] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[164.383056] [019/139] (874s left) v3d/v3d_wait_bo (used-bo)
[164.651176] Subtest used-bo: SKIP (0.000s)
[164.735128] [020/139] (874s left) syncobj_wait (wait-all-for-submit-snapshot)
[164.961628] Starting subtest: wait-all-for-submit-snapshot
[165.014042] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[165.135808] [021/139] (873s left) gem_gpgpu_fill (basic)
[165.367836] Starting subtest: basic
[165.388723] Starting dynamic subtest: smem
[165.408654] Dynamic subtest smem: SUCCESS (0.010s)
[165.427794] Subtest basic: SUCCESS (0.011s)
[165.513083] [022/139] (873s left) gem_ctx_persistence (hang)
[165.745629] Starting subtest: hang
[165.784638] Subtest hang: SKIP (0.007s)
[165.877279] [023/139] (873s left) gem_exec_fence (syncobj-timeline-wait)
[166.762653] Starting subtest: syncobj-timeline-wait
[166.801151] Subtest syncobj-timeline-wait: SUCCESS (0.036s)
[167.052369] [024/139] (872s left) kms_invalid_mode (zero-clock)
[167.370231] Starting subtest: zero-clock
[167.389218] Starting dynamic subtest: pipe-A-DP-1
[167.454999] Dynamic subtest pipe-A-DP-1: SUCCESS (0.088s)
[167.493423] Starting dynamic subtest: pipe-B-DP-1
[167.513997] Dynamic subtest pipe-B-DP-1: SUCCESS (0.002s)
[167.551258] Starting dynamic subtest: pipe-C-DP-1
[167.570064] Dynamic subtest pipe-C-DP-1: SUCCESS (0.002s)
[167.588708] Subtest zero-clock: SUCCESS (0.098s)
[167.796011] [025/139] (871s left) gem_exec_reloc (basic-cpu-wc-active)
[168.039308] Starting subtest: basic-cpu-wc-active
[168.151975] Subtest basic-cpu-wc-active: SUCCESS (0.139s)
[168.347098] [026/139] (871s left) vc4/vc4_tiling (set-bad-modifier)
[168.618487] Subtest set-bad-modifier: SKIP (0.000s)
[168.709281] [027/139] (870s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-mtl-mc-ccs)
[169.002235] Starting subtest: pipe-A-bad-pixel-format-4-tiled-mtl-mc-ccs
[169.041354] Subtest pipe-A-bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[169.556556] [028/139] (869s left) syncobj_wait (multi-wait-for-submit-submitted)
[169.784939] Starting subtest: multi-wait-for-submit-submitted
[169.858022] Subtest multi-wait-for-submit-submitted: SUCCESS (0.108s)
[169.974128] [029/139] (869s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[170.415785] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[170.458646] Subtest pipe-B-crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.001s)
[170.844314] [030/139] (868s left) gem_partial_pwrite_pread (writes-after-reads-display)
[171.079956] Starting subtest: writes-after-reads-display
[191.169833] Subtest writes-after-reads-display: SUCCESS (20.092s)
[191.291333] [031/139] (848s left) gem_mmap_gtt (basic-write-read-distinct)
[191.533286] Starting subtest: basic-write-read-distinct
[191.552614] Subtest basic-write-read-distinct: SUCCESS (0.034s)
[191.681228] [032/139] (848s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-mtl-rc-ccs)
[192.173199] Starting subtest: pipe-C-random-ccs-data-4-tiled-mtl-rc-ccs
[192.238485] Subtest pipe-C-random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[192.531851] [033/139] (847s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[192.911372] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[195.137408] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (2.308s)
[195.302977] [034/139] (844s left) kms_chamelium_frames (hdmi-frame-dump)
[195.736086] Subtest hdmi-frame-dump: SKIP (0.000s)
[196.039853] [035/139] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[196.389662] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[196.433306] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[196.525472] [036/139] (843s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[196.889105] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[196.932359] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[197.021679] [037/139] (843s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[197.387824] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[197.430139] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[197.518987] [038/139] (842s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[197.820412] Starting subtest: primary-yf-tiled-reflect-x-270
[197.864593] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.003s)
[197.958118] [039/139] (842s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[198.340071] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[198.385218] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[198.483792] [040/139] (842s left) gem_pread (bench)
[198.739109] Starting subtest: bench
[203.373468] Subtest bench: SUCCESS (4.461s)
[203.487083] [041/139] (837s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[203.754434] Starting subtest: mixed-tiled-to-y-tiled-ccs
[203.778406] Starting dynamic subtest: smem
[204.042473] Dynamic subtest smem: SUCCESS (0.302s)
[204.072065] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.303s)
[204.283794] [042/139] (836s left) syncobj_timeline (invalid-wait-illegal-handle)
[204.532637] Starting subtest: invalid-wait-illegal-handle
[204.559978] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[204.668062] [043/139] (836s left) kms_ccs (pipe-b-bad-pixel-format-yf-tiled-ccs)
[205.126017] Starting subtest: pipe-B-bad-pixel-format-yf-tiled-ccs
[205.146525] Subtest pipe-B-bad-pixel-format-yf-tiled-ccs: SUCCESS (0.000s)
[205.534751] [044/139] (835s left) gem_exec_balancer (parallel-ordering)
[209.602506] Subtest parallel-ordering: SKIP (0.000s)
[209.687862] [045/139] (831s left) kms_color (ctm-red-to-blue)
[209.983306] Starting subtest: ctm-red-to-blue
[210.004563] Starting dynamic subtest: pipe-A
[210.523246] Dynamic subtest pipe-A: SUCCESS (0.529s)
[210.564834] Starting dynamic subtest: pipe-B
[211.216592] Dynamic subtest pipe-B: SUCCESS (0.701s)
[211.259079] Starting dynamic subtest: pipe-C
[211.948497] Dynamic subtest pipe-C: SUCCESS (0.712s)
[211.970828] Subtest ctm-red-to-blue: SUCCESS (1.944s)
[212.285291] [046/139] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[212.643692] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[212.681112] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[212.771525] [047/139] (828s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[213.079413] Starting subtest: cursorA-vs-flipB-atomic
[213.118508] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[213.206142] [048/139] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[213.581060] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[213.618557] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[213.709791] [049/139] (827s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[213.940615] Starting subtest: invalid-bsd2-flag-on-blt
[213.962397] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.001s)
[214.057051] [050/139] (827s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[214.388975] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[214.428985] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[214.523100] [051/139] (827s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[214.869986] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[214.913088] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[215.004589] [052/139] (826s left) kms_psr (no_drrs)
[215.259364] Subtest no_drrs: SKIP (0.000s)
[215.344637] [053/139] (826s left) gem_exec_alignment (pi)