[47.453154] Initializing watchdogs
[47.453501]   /dev/watchdog0
[47.469816] [001/136] (960s left) kms_atomic_transition (plane-all-transition-fencing)
[47.762482] Starting subtest: plane-all-transition-fencing
[47.768571] Starting dynamic subtest: pipe-A-DP-1
[51.807071] Dynamic subtest pipe-A-DP-1: SUCCESS (4.042s)
[51.940954] Starting dynamic subtest: pipe-B-DP-1
[56.320322] Dynamic subtest pipe-B-DP-1: SUCCESS (4.394s)
[56.419030] Subtest plane-all-transition-fencing: SUCCESS (8.656s)
[56.769939] [002/136] (951s left) kms_busy (basic-hang)
[57.090492] Starting subtest: basic-hang
[57.093733] Starting dynamic subtest: flip-pipe-A
[57.940679] Dynamic subtest flip-pipe-A: SUCCESS (0.844s)
[57.954635] Starting dynamic subtest: modeset-pipe-A
[59.680777] Dynamic subtest modeset-pipe-A: SUCCESS (1.743s)
[59.730272] Starting dynamic subtest: flip-pipe-C
[60.833952] Dynamic subtest flip-pipe-C: SUCCESS (1.114s)
[60.852399] Starting dynamic subtest: modeset-pipe-C
[62.478732] Dynamic subtest modeset-pipe-C: SUCCESS (1.657s)
[62.480115] Subtest basic-hang: SUCCESS (5.389s)
[62.836068] [003/136] (945s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[63.124169] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[63.126712] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[63.217201] [004/136] (944s left) kms_flip (flip-vs-fences)
[63.480683] Starting subtest: flip-vs-fences
[63.481910] Starting dynamic subtest: A-DP1
[74.084130] Dynamic subtest A-DP1: SUCCESS (10.603s)
[74.103753] Starting dynamic subtest: B-DP1
[84.939257] Dynamic subtest B-DP1: SUCCESS (10.853s)
[84.958473] Starting dynamic subtest: C-DP1
[95.710045] Dynamic subtest C-DP1: SUCCESS (10.769s)
[95.711982] Subtest flip-vs-fences: SUCCESS (32.234s)
[96.156939] [005/136] (911s left) gem_ctx_sseu (invalid-args)
[96.339902] Subtest invalid-args: SKIP (0.000s)
[96.390990] [006/136] (911s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[96.662385] Starting subtest: cursorB-vs-flipB-toggle
[96.665128] Subtest cursorB-vs-flipB-toggle: SKIP (0.002s)
[96.739268] [007/136] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[97.026210] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[97.028655] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[97.104728] [008/136] (911s left) gem_userptr_blits (readonly-pwrite-unsync)
[97.295834] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[97.439676] [009/136] (910s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_rc_ccs)
[97.989199] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs
[97.991620] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[98.361198] [010/136] (909s left) api_intel_allocator (standalone)
[98.534191] Starting subtest: standalone
[98.584493] Subtest standalone: SUCCESS (0.051s)
[98.660659] [011/136] (909s left) kms_vblank (pipe-d-ts-continuation-suspend)
[98.934062] Subtest pipe-D-ts-continuation-suspend: SKIP (0.000s)
[99.010720] [012/136] (909s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_ccs)
[99.632916] Subtest pipe-D-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[99.928598] [013/136] (908s left) gem_render_linear_blits (basic)
[100.113433] Starting subtest: basic
[100.196147] Subtest basic: SUCCESS (0.084s)
[100.263403] [014/136] (908s left) gem_exec_balancer (busy)
[100.454996] Starting subtest: busy
[102.333510] Subtest busy: SUCCESS (1.878s)
[106.195595] [015/136] (902s left) gem_madvise (dontneed-before-exec)
[106.362666] Starting subtest: dontneed-before-exec
[106.370271] Subtest dontneed-before-exec: SUCCESS (0.007s)
[106.477358] [016/136] (901s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[106.778518] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[106.781189] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[106.878170] [017/136] (901s left) gem_exec_balancer (nop)
[107.073135] Starting subtest: nop
[146.503163] Subtest nop: SUCCESS (39.432s)
[150.446843] [018/136] (858s left) kms_draw_crc (draw-method-pwrite)
[150.721640] Starting subtest: draw-method-pwrite
[150.722958] Starting dynamic subtest: xrgb8888-untiled
[151.011716] Dynamic subtest xrgb8888-untiled: SUCCESS (0.292s)
[151.026191] Starting dynamic subtest: xrgb8888-xtiled
[151.312390] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.299s)
[151.326273] Starting dynamic subtest: xrgb8888-ytiled
[151.628263] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.316s)
[151.642203] Starting dynamic subtest: rgb565-untiled
[151.895085] Dynamic subtest rgb565-untiled: SUCCESS (0.266s)
[151.909181] Starting dynamic subtest: rgb565-xtiled
[152.213034] Dynamic subtest rgb565-xtiled: SUCCESS (0.317s)
[152.227087] Starting dynamic subtest: rgb565-ytiled
[152.495350] Dynamic subtest rgb565-ytiled: SUCCESS (0.281s)
[152.511596] Starting dynamic subtest: xrgb2101010-untiled
[152.778460] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.283s)
[152.793130] Starting dynamic subtest: xrgb2101010-xtiled
[153.095501] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.316s)
[153.109864] Starting dynamic subtest: xrgb2101010-ytiled
[153.413898] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.316s)
[153.415414] Subtest draw-method-pwrite: SUCCESS (2.693s)
[153.510613] [019/136] (854s left) gem_pxp (reject-modify-context-protection-off-1)
[156.207556] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[156.276839] [020/136] (852s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[156.561518] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[156.564118] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[156.644489] [021/136] (851s left) gem_ctx_exec (basic-close-race)
[156.822404] Starting subtest: basic-close-race
[162.292637] Subtest basic-close-race: SUCCESS (5.463s)
[163.030858] [022/136] (845s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[163.324419] Starting subtest: yf-tiled-32bpp-rotate-270
[167.997950] Subtest yf-tiled-32bpp-rotate-270: SUCCESS (4.671s)
[168.528711] [023/136] (840s left) gem_exec_schedule (semaphore-codependency)
[168.734230] Starting subtest: semaphore-codependency
[168.754937] Subtest semaphore-codependency: SUCCESS (0.021s)
[169.145624] [024/136] (839s left) gem_ringfill (engines-basic)
[169.747570] Starting subtest: engines-basic
[169.748832] Starting dynamic subtest: rcs0
[169.775861] Dynamic subtest rcs0: SUCCESS (0.028s)
[169.793362] Starting dynamic subtest: bcs0
[169.799809] Dynamic subtest bcs0: SUCCESS (0.023s)
[169.818389] Starting dynamic subtest: vcs0
[169.824040] Dynamic subtest vcs0: SUCCESS (0.023s)
[169.840284] Starting dynamic subtest: vecs0
[169.846816] Dynamic subtest vecs0: SUCCESS (0.022s)
[169.848220] Subtest engines-basic: SUCCESS (0.100s)
[169.928689] [025/136] (838s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[170.549899] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[170.853383] [026/136] (837s left) kms_atomic (plane-invalid-params)
[171.249200] Starting subtest: plane-invalid-params
[171.404981] Subtest plane-invalid-params: SUCCESS (0.156s)
[171.797961] [027/136] (836s left) kms_psr (psr2_sprite_mmap_cpu)
[171.977430] Subtest psr2_sprite_mmap_cpu: SKIP (0.000s)
[172.015965] [028/136] (836s left) kms_cursor_crc (cursor-onscreen-32x32)
[172.288634] Starting subtest: cursor-onscreen-32x32
[172.469291] Subtest cursor-onscreen-32x32: SKIP (0.176s)
[172.579772] [029/136] (836s left) kms_concurrent (pipe-d)
[172.861216] Subtest pipe-D: SKIP (0.000s)
[172.946288] [030/136] (835s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[173.228395] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[173.230939] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[173.331111] [031/136] (835s left) syncobj_timeline (wait-for-submit-complex)
[173.509324] Starting subtest: wait-for-submit-complex
[173.573443] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[173.646668] [032/136] (835s left) gem_exec_create (basic)
[173.839400] Starting subtest: basic
[173.840752] Starting dynamic subtest: smem
[175.897907] Dynamic subtest smem: SUCCESS (2.058s)
[175.899191] Subtest basic: SUCCESS (2.059s)
[176.079984] [033/136] (832s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[176.465660] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[176.468257] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[177.011300] [034/136] (831s left) gem_ctx_create (basic)
[177.207229] Starting subtest: basic
[177.208652] Subtest basic: SUCCESS (0.000s)
[177.394798] [035/136] (831s left) kms_getfb (getfb2-handle-zero)
[177.590553] Starting subtest: getfb2-handle-zero
[177.592099] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[177.680885] [036/136] (831s left) gem_ctx_persistence (idempotent)
[177.862398] Starting subtest: idempotent
[177.863688] Subtest idempotent: SUCCESS (0.000s)
[177.944072] [037/136] (831s left) perf (non-sampling-read-error)
[178.229765] Starting subtest: non-sampling-read-error
[178.284299] Subtest non-sampling-read-error: SUCCESS (0.055s)
[178.324818] [038/136] (830s left) vc4/vc4_tiling (get-bad-handle)
[178.562541] Subtest get-bad-handle: SKIP (0.000s)
[178.627719] [039/136] (830s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[179.013820] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[179.304366] [040/136] (829s left) kms_pipe_crc_basic (hang-read-crc)
[179.576490] Starting subtest: hang-read-crc
[179.577822] Starting dynamic subtest: pipe-A-DP-1
[180.835199] Dynamic subtest pipe-A-DP-1: SUCCESS (1.258s)
[180.850582] Starting dynamic subtest: pipe-B-DP-1
[182.508949] Dynamic subtest pipe-B-DP-1: SUCCESS (1.672s)
[182.527117] Starting dynamic subtest: pipe-C-DP-1
[184.451765] Dynamic subtest pipe-C-DP-1: SUCCESS (1.938s)
[184.454900] Subtest hang-read-crc: SUCCESS (4.877s)
[184.763458] [041/136] (824s left) kms_vblank (pipe-d-query-idle)
[185.039926] Subtest pipe-D-query-idle: SKIP (0.000s)
[185.113381] [042/136] (824s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[185.290995] Starting subtest: etime-multi-wait-all-for-submit-submitted
[185.395447] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[185.479826] [043/136] (823s left) kms_vblank (pipe-b-query-forked-busy)
[185.752666] Starting subtest: pipe-B-query-forked-busy
[188.591273] Subtest pipe-B-query-forked-busy: SUCCESS (2.842s)
[188.907387] [044/136] (820s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[189.188900] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[189.191425] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[189.289818] [045/136] (820s left) kms_chamelium_color (ctm-green-to-red)
[189.571827] Subtest ctm-green-to-red: SKIP (0.000s)
[189.624935] [046/136] (819s left) kms_psr (sprite_plane_onoff)
[189.801799] Subtest sprite_plane_onoff: SKIP (0.000s)
[189.842136] [047/136] (819s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[190.017299] Starting subtest: single-wait-all-for-submit-available-submitted
[190.018788] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[190.106482] [048/136] (819s left) gem_mmap (pf-nonblock)
[190.281771] Starting subtest: pf-nonblock
[190.287980] Subtest pf-nonblock: SUCCESS (0.005s)
[190.390302] [049/136] (819s left) kms_atomic_interruptible (legacy-dpms)
[190.666650] Starting subtest: legacy-dpms
[190.670225] Starting dynamic subtest: DP-1-pipe-A
[197.191094] Dynamic subtest DP-1-pipe-A: SUCCESS (6.520s)
[197.192298] Subtest legacy-dpms: SUCCESS (6.523s)
[197.518665] [050/136] (811s left) sw_sync (sync_expired_merge)
[197.693388] Starting subtest: sync_expired_merge
[198.769837] Subtest sync_expired_merge: SUCCESS (1.075s)
[198.833775] [051/136] (810s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[199.118750] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[199.122224] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[199.217555] [052/136] (810s left) kms_flip (basic-flip-vs-wf_vblank)
[199.483438] Starting subtest: basic-flip-vs-wf_vblank
[199.484861] Starting dynamic subtest: A-DP1
[200.964301] Dynamic subtest A-DP1: SUCCESS (1.480s)
[200.980161] Starting dynamic subtest: B-DP1
[202.374911] Dynamic subtest B-DP1: SUCCESS (1.409s)
[202.390496] Starting dynamic subtest: C-DP1
[203.776752] Dynamic subtest C-DP1: SUCCESS (1.400s)
[203.778113] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.299s)
[204.192898] [053/136] (805s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[204.463419] Starting subtest: cursorA-vs-flipA-legacy
[215.468608] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.007s)
[215.798164] [054/136] (793s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[216.092378] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[219.046665] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (2.954s)
[219.180223] [055/136] (790s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[219.452365] Starting subtest: cursor-vs-flip-legacy
[256.394901] Subtest cursor-vs-flip-legacy: SUCCESS (36.942s)
[256.725937] [056/136] (752s left) gem_flink_basic (flink-lifetime)
[256.899413] Starting subtest: flink-lifetime
[256.903698] Subtest flink-lifetime: SUCCESS (0.003s)
[257.006603] [057/136] (752s left) gem_lmem_evict (dontneed-evict-race)
[257.189358] Subtest dontneed-evict-race: SKIP (0.000s)
[257.249785] [058/136] (752s left) gem_mmap_gtt (basic-small-bo-tiledx)
[257.427094] Starting subtest: basic-small-bo-tiledX
[259.101641] Subtest basic-small-bo-tiledX: SUCCESS (1.673s)
[259.303606] [059/136] (750s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[259.710819] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[261.288135] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.579s)
[261.407674] [060/136] (748s left) kms_async_flips (test-cursor)
[261.686564] Starting subtest: test-cursor
[261.687919] Starting dynamic subtest: pipe-A-DP-1
[262.499063] Dynamic subtest pipe-A-DP-1: SUCCESS (0.813s)
[262.515890] Starting dynamic subtest: pipe-B-DP-1
[263.163157] Dynamic subtest pipe-B-DP-1: SUCCESS (0.662s)
[263.182517] Starting dynamic subtest: pipe-C-DP-1
[263.756315] Dynamic subtest pipe-C-DP-1: SUCCESS (0.591s)
[263.758111] Subtest test-cursor: SUCCESS (2.073s)
[264.311290] [061/136] (745s left) kms_flip (2x-wf_vblank-ts-check)
[264.581103] Starting subtest: 2x-wf_vblank-ts-check
[264.583631] Subtest 2x-wf_vblank-ts-check: SKIP (0.003s)
[264.677933] [062/136] (745s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[265.104984] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[265.111455] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.005s)
[265.605203] [063/136] (744s left) kms_cursor_crc (cursor-sliding-512x170)
[265.907248] Starting subtest: cursor-sliding-512x170
[265.913134] Subtest cursor-sliding-512x170: SKIP (0.002s)
[266.005820] [064/136] (743s left) kms_vblank (pipe-b-ts-continuation-modeset)
[266.281079] Starting subtest: pipe-B-ts-continuation-modeset
[267.279154] Subtest pipe-B-ts-continuation-modeset: SUCCESS (0.998s)
[267.601938] [065/136] (742s left) gem_create (create-ext-placement-each)
[267.898812] Starting subtest: create-ext-placement-each
[267.900595] Subtest create-ext-placement-each: SUCCESS (0.000s)
[268.003166] [066/136] (742s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[268.271733] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[268.273170] Starting dynamic subtest: pipe-A-valid-mode
[268.368957] Dynamic subtest pipe-A-valid-mode: SKIP (0.092s)
[268.373495] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.095s)
[268.683826] [067/136] (741s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[268.957731] Starting subtest: basic-max-pipe-crc-check
[268.960234] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[269.003332] [068/136] (741s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[269.199350] Starting subtest: invalid-single-wait-unsubmitted
[269.201030] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[269.283623] [069/136] (740s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[269.457562] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[269.459196] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[269.550242] [070/136] (740s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[269.725963] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[269.833773] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[269.917153] [071/136] (740s left) v3d/v3d_submit_csd (bad-multisync-pad)
[270.149535] Subtest bad-multisync-pad: SKIP (0.000s)
[270.216797] [072/136] (740s left) gem_partial_pwrite_pread (write-display)
[270.405037] Starting subtest: write-display
[284.464349] Subtest write-display: SUCCESS (14.059s)
[284.567596] [073/136] (725s left) syncobj_wait (single-wait-all-for-submit-submitted)
[284.746943] Starting subtest: single-wait-all-for-submit-submitted
[284.849805] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[284.933469] [074/136] (725s left) gem_exec_whisper (basic-forked-all)
[285.134095] Starting subtest: basic-forked-all
[307.160759] Subtest basic-forked-all: SUCCESS (22.026s)
[307.351800] [075/136] (702s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[307.625026] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[307.627626] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[307.718901] [076/136] (702s left) syncobj_basic (bad-destroy-pad)
[307.889666] Starting subtest: bad-destroy-pad
[307.891027] Subtest bad-destroy-pad: SUCCESS (0.000s)
[307.968848] [077/136] (702s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[308.158631] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[308.160501] Starting dynamic subtest: smem
[308.491422] Dynamic subtest smem: SUCCESS (0.330s)
[308.492800] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.332s)
[308.685959] [078/136] (701s left) feature_discovery (psr1)
[308.952276] Starting subtest: psr1
[308.954846] Subtest psr1: SKIP (0.000s)
[309.035591] [079/136] (701s left) gem_softpin (reverse)
[309.217392] Starting subtest: reverse
[309.237039] Subtest reverse: SUCCESS (0.019s)
[309.352195] [080/136] (701s left) i915_query (hwconfig_table)
[309.525316] Starting subtest: hwconfig_table
[309.527916] Subtest hwconfig_table: SKIP (0.000s)
[309.600906] [081/136] (700s left) kms_flip (2x-nonexisting-fb)
[309.861902] Starting subtest: 2x-nonexisting-fb
[309.864545] Subtest 2x-nonexisting-fb: SKIP (0.003s)
[309.969476] [082/136] (700s left) gen7_exec_parse (basic-allowed)
[310.152847] Subtest basic-allowed: SKIP (0.000s)
[310.204657] [083/136] (700s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[310.568347] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[310.859515] [084/136] (699s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[311.140806] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[311.143327] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[311.235546] [085/136] (699s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[311.511618] Starting subtest: flip-vs-cursor-crc-atomic
[312.345466] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.834s)
[312.668149] [086/136] (698s left) gem_exec_fair (basic-pace-solo)
[312.866737] Starting subtest: basic-pace-solo
[312.870817] Starting dynamic subtest: rcs0
[317.810466] Dynamic subtest rcs0: FAIL (4.913s)
[317.811943] Subtest basic-pace-solo: FAIL (4.916s)
[317.984644] [087/136] (692s left) perf_pmu (init-busy)
[318.164099] Starting subtest: init-busy
[318.165709] Starting dynamic subtest: rcs0
[318.167394] Dynamic subtest rcs0: SUCCESS (0.002s)
[318.187244] Starting dynamic subtest: bcs0
[318.188496] Dynamic subtest bcs0: SUCCESS (0.001s)
[318.207240] Starting dynamic subtest: vcs0
[318.208499] Dynamic subtest vcs0: SUCCESS (0.001s)
[318.227269] Starting dynamic subtest: vecs0
[318.228826] Dynamic subtest vecs0: SUCCESS (0.002s)
[318.230262] Subtest init-busy: SUCCESS (0.011s)
[318.301446] [088/136] (692s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[318.574446] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[318.576373] Starting dynamic subtest: pipe-A-valid-mode
[318.662612] Dynamic subtest pipe-A-valid-mode: SKIP (0.086s)
[318.666347] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.089s)
[318.962555] [089/136] (691s left) syncobj_wait (wait-for-submit-complex)
[319.136328] Starting subtest: wait-for-submit-complex
[319.200776] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[319.278491] [090/136] (691s left) kms_ccs (pipe-d-bad-pixel-format-yf_tiled_ccs)
[319.894631] Subtest pipe-D-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[320.203958] [091/136] (690s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[320.483573] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[320.486241] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[320.587215] [092/136] (690s left) kms_universal_plane (disable-primary-vs-flip-pipe-b)
[320.861430] Starting subtest: disable-primary-vs-flip-pipe-B
[321.970331] Subtest disable-primary-vs-flip-pipe-B: SUCCESS (1.110s)
[322.300890] [093/136] (688s left) v3d/v3d_wait_bo (used-bo-1ns)
[322.534439] Subtest used-bo-1ns: SKIP (0.000s)
[322.600366] [094/136] (688s left) i915_pciid
[322.851391] [095/136] (688s left) gem_exec_reloc (basic-cpu-wc-active)
[323.035443] Starting subtest: basic-cpu-wc-active
[323.174846] Subtest basic-cpu-wc-active: SUCCESS (0.138s)
[323.367906] [096/136] (687s left) gem_softpin (noreloc-interruptible)
[323.545506] Starting subtest: noreloc-interruptible
[329.115587] Subtest noreloc-interruptible: SUCCESS (5.567s)
[329.216388] [097/136] (681s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_mc_ccs)
[329.687927] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_mc_ccs
[329.692186] Subtest pipe-B-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[330.144770] [098/136] (681s left) gem_exec_schedule (preempt-other-chain)
[330.342356] Starting subtest: preempt-other-chain
[330.346655] Starting dynamic subtest: rcs0
[330.448362] Dynamic subtest rcs0: SUCCESS (0.101s)
[330.479768] Starting dynamic subtest: bcs0
[330.554721] Dynamic subtest bcs0: SUCCESS (0.104s)
[330.579475] Starting dynamic subtest: vcs0
[330.657673] Dynamic subtest vcs0: SUCCESS (0.101s)
[330.682855] Starting dynamic subtest: vecs0
[330.759648] Dynamic subtest vecs0: SUCCESS (0.100s)
[330.761121] Subtest preempt-other-chain: SUCCESS (0.414s)
[331.095599] [099/136] (680s left) kms_prime (basic-crc-hybrid)
[333.007326] Subtest basic-crc-hybrid: SKIP (0.000s)
[333.114131] [100/136] (678s left) gem_exec_fence (syncobj-invalid-flags)
[333.723030] Starting subtest: syncobj-invalid-flags
[333.724745] Subtest syncobj-invalid-flags: SUCCESS (0.001s)
[334.061384] [101/136] (677s left) gem_exec_params (readonly)
[334.242982] Starting subtest: readonly
[334.244353] Subtest readonly: SUCCESS (0.002s)
[334.344220] [102/136] (676s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[334.612624] Starting subtest: 2x-absolute-wf_vblank-interruptible
[334.617983] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.003s)
[334.712514] [103/136] (676s left) kms_content_protection (legacy)
[335.014689] Starting subtest: legacy
[335.211359] Starting dynamic subtest: pipe-A-DP-1
[456.027732] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[456.722271] Closing watchdogs
[456.726773] Initializing watchdogs
[456.726956]   /dev/watchdog0
[456.750276] [104/136] (554s left) kms_big_fb (4-tiled-addfb-size-overflow)
[457.056339] Starting subtest: 4-tiled-addfb-size-overflow
[457.058964] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[457.162317] [105/136] (554s left) api_intel_allocator (execbuf-with-allocator)
[457.337114] Starting subtest: execbuf-with-allocator
[457.345735] Subtest execbuf-with-allocator: SUCCESS (0.009s)
[457.444701] [106/136] (554s left) gen9_exec_parse (cmd-crossing-page)
[457.638747] Starting subtest: cmd-crossing-page
[457.643449] Subtest cmd-crossing-page: SUCCESS (0.006s)
[457.862216] [107/136] (553s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[458.158998] Starting subtest: x-tiled-8bpp-rotate-0
[461.057992] Subtest x-tiled-8bpp-rotate-0: SUCCESS (2.897s)
[461.265173] [108/136] (550s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[461.542279] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[461.545151] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[461.645596] [109/136] (549s left) prime_mmap (test_refcounting)
[461.821082] Starting subtest: test_refcounting
[461.822396] Starting dynamic subtest: test_refcounting-smem
[461.829132] Dynamic subtest test_refcounting-smem: SUCCESS (0.007s)
[461.830811] Subtest test_refcounting: SUCCESS (0.009s)
[461.933957] [110/136] (549s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[462.206615] Starting subtest: 2x-long-flip-vs-cursor-atomic
[462.211796] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.004s)
[462.295705] [111/136] (549s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_ccs)
[462.769573] Starting subtest: pipe-B-bad-rotation-90-y_tiled_ccs
[463.231599] Subtest pipe-B-bad-rotation-90-y_tiled_ccs: SUCCESS (0.461s)
[463.859700] [112/136] (547s left) kms_psr2_su (page_flip-xrgb8888)
[464.033810] Subtest page_flip-XRGB8888: SKIP (0.000s)
[464.095343] [113/136] (547s left) kms_frontbuffer_tracking (fbcpsr-badstride)
[464.371567] Starting subtest: fbcpsr-badstride
[464.374417] Subtest fbcpsr-badstride: SKIP (0.000s)
[464.475740] [114/136] (547s left) kms_color (ctm-0-75)
[464.748894] Starting subtest: ctm-0-75
[464.750445] Starting dynamic subtest: pipe-A-DP-1
[467.187686] Dynamic subtest pipe-A-DP-1: SUCCESS (2.436s)
[467.206569] Starting dynamic subtest: pipe-B-DP-1
[469.887521] Dynamic subtest pipe-B-DP-1: SUCCESS (2.698s)
[469.921391] Starting dynamic subtest: pipe-C-DP-1
[472.782035] Dynamic subtest pipe-C-DP-1: SUCCESS (2.889s)
[472.783249] Subtest ctm-0-75: SUCCESS (8.035s)
[473.100331] [115/136] (538s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[473.406775] Starting subtest: x-tiled-16bpp-rotate-180
[476.878980] Subtest x-tiled-16bpp-rotate-180: SUCCESS (3.470s)
[477.201529] [116/136] (534s left) gem_mmap (bad-offset)
[477.372660] Starting subtest: bad-offset
[477.374304] Subtest bad-offset: SUCCESS (0.001s)
[477.466500] [117/136] (534s left) kms_plane_scaling (planes-downscale-factor-0-25)
[477.743707] Starting subtest: planes-downscale-factor-0-25
[477.745109] Starting dynamic subtest: pipe-A-DP-1
[477.916758] Dynamic subtest pipe-A-DP-1: SKIP (0.171s)
[477.942497] Starting dynamic subtest: pipe-B-DP-1
[478.083850] Dynamic subtest pipe-B-DP-1: SKIP (0.158s)
[478.107481] Starting dynamic subtest: pipe-C-DP-1
[478.239376] Dynamic subtest pipe-C-DP-1: SKIP (0.153s)
[478.241947] Subtest planes-downscale-factor-0-25: SKIP (0.494s)
[478.351235] [118/136] (533s left) debugfs_test (basic-hwmon)
[478.536418] Starting subtest: basic-hwmon
[478.538980] Subtest basic-hwmon: SKIP (0.000s)
[478.733465] [119/136] (533s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[479.016781] Starting subtest: psr-rgb101010-draw-mmap-cpu
[479.019485] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[479.117597] [120/136] (532s left) v3d/v3d_submit_cl (bad-bo)
[479.346557] Subtest bad-bo: SKIP (0.000s)
[479.416757] [121/136] (532s left) sw_sync (sync_busy)
[479.592084] Starting subtest: sync_busy
[479.595833] Subtest sync_busy: SUCCESS (0.007s)
[479.666268] [122/136] (532s left) i915_pm_rpm (reg-read-ioctl)
[481.533517] Starting subtest: reg-read-ioctl
[482.293658] Subtest reg-read-ioctl: SUCCESS (0.756s)
[482.763531] [123/136] (529s left) i915_pm_rpm (fences)
[484.522801] Starting subtest: fences
[487.450274] Subtest fences: SUCCESS (2.928s)
[487.622414] [124/136] (524s left) kms_ccs (pipe-b-crc-primary-rotation-180-yf_tiled_ccs)
[488.087315] Starting subtest: pipe-B-crc-primary-rotation-180-yf_tiled_ccs
[488.734962] Subtest pipe-B-crc-primary-rotation-180-yf_tiled_ccs: SUCCESS (0.650s)
[489.275515] [125/136] (522s left) gem_exec_params (rel-constants-invalid-ring)
[489.455909] Starting subtest: rel-constants-invalid-ring
[489.457446] Subtest rel-constants-invalid-ring: SUCCESS (0.001s)
[489.557297] [126/136] (522s left) gem_tiled_pread_basic
[490.091292] [127/136] (522s left) kms_vblank (pipe-b-accuracy-idle)
[490.361768] Starting subtest: pipe-B-accuracy-idle
[493.005518] Subtest pipe-B-accuracy-idle: SUCCESS (2.645s)
[493.335984] [128/136] (518s left) gem_userptr_blits (input-checking)
[493.522932] Starting subtest: input-checking
[493.524304] Subtest input-checking: SUCCESS (0.000s)
[493.669592] [129/136] (518s left) perf_pmu (frequency-idle)
[493.850389] Starting subtest: frequency-idle
[494.358732] Subtest frequency-idle: SUCCESS (0.506s)
[494.452454] [130/136] (517s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[494.627427] Starting subtest: invalid-multi-wait-all-unsubmitted
[494.628994] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[494.718862] [131/136] (517s left) kms_plane_lowres (tiling-yf)
[494.998070] Starting subtest: tiling-yf
[494.999316] Starting dynamic subtest: pipe-A-DP-1
[501.118932] Dynamic subtest pipe-A-DP-1: SUCCESS (6.120s)
[501.237676] Starting dynamic subtest: pipe-B-DP-1
[507.186456] Dynamic subtest pipe-B-DP-1: SUCCESS (5.967s)
[507.319420] Starting dynamic subtest: pipe-C-DP-1
[511.314972] Dynamic subtest pipe-C-DP-1: SUCCESS (4.012s)
[511.427691] Subtest tiling-yf: SUCCESS (16.432s)
[511.889415] [132/136] (500s left) syncobj_wait (multi-wait-all-signaled)
[512.070222] Starting subtest: multi-wait-all-signaled
[512.071752] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[512.154774] [133/136] (500s left) drm_fdinfo (virtual-busy-hang-all)
[512.332951] Starting subtest: virtual-busy-hang-all
[512.334448] Subtest virtual-busy-hang-all: SUCCESS (0.001s)
[512.421575] [134/136] (500s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[512.713778] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[512.719286] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[512.805549] [135/136] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[513.090617] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[513.093525] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[513.188463] [136/136] (499s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[513.462161] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[516.416880] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SUCCESS (2.955s)
[516.551395] Closing watchdogs
Done.