[50.810971] Initializing watchdogs
[50.811252]   /dev/watchdog0
[50.828410] [001/142] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[51.176197] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[51.178800] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[51.270120] [002/142] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[51.590212] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[51.592913] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[51.684690] [003/142] (959s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_mc_ccs)
[51.991852] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs
[51.994797] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[52.672722] [004/142] (958s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_ccs)
[53.262737] Starting subtest: pipe-C-bad-pixel-format-y_tiled_ccs
[53.265412] Subtest pipe-C-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[53.674751] [005/142] (957s left) gem_exec_balancer (smoke)
[53.922484] Starting subtest: smoke
[57.873736] Subtest smoke: SUCCESS (3.945s)
[62.025416] [006/142] (949s left) kms_plane (plane-position-covered)
[62.329337] Starting subtest: plane-position-covered
[62.330636] Starting dynamic subtest: pipe-A-planes
[63.835316] Dynamic subtest pipe-A-planes: SUCCESS (1.507s)
[63.850927] Starting dynamic subtest: pipe-B-planes
[65.633916] Dynamic subtest pipe-B-planes: SUCCESS (1.796s)
[65.635733] Subtest plane-position-covered: SUCCESS (3.308s)
[65.973059] [007/142] (945s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[66.280391] Starting subtest: fbcpsr-slowdraw
[66.282959] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[66.372519] [008/142] (945s left) prime_vgem (fence-flip-hang)
[66.694870] Subtest fence-flip-hang: SKIP (0.000s)
[66.772653] [009/142] (944s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[67.077319] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[67.078690] Starting dynamic subtest: pipe-A-valid-mode
[67.212980] Dynamic subtest pipe-A-valid-mode: SKIP (0.132s)
[67.215982] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.134s)
[67.541304] [010/142] (944s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[67.858506] Starting subtest: psr-2p-primscrn-spr-indfb-move
[67.860996] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[67.941157] [011/142] (943s left) gem_exec_fence (syncobj-import)
[68.625956] Starting subtest: syncobj-import
[68.633834] Subtest syncobj-import: SUCCESS (0.008s)
[68.975091] [012/142] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[69.281114] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[69.283773] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[69.375060] [013/142] (942s left) gem_softpin (evict-snoop-interruptible)
[69.597370] Starting subtest: evict-snoop-interruptible
[69.601040] Subtest evict-snoop-interruptible: SKIP (0.000s)
[69.691990] [014/142] (942s left) kms_flip (plain-flip-fb-recreate-interruptible)
[69.992986] Starting subtest: plain-flip-fb-recreate-interruptible
[69.995580] Starting dynamic subtest: A-DP1
[81.011891] Dynamic subtest A-DP1: SUCCESS (11.014s)
[81.026834] Starting dynamic subtest: B-DP1
[91.767635] Dynamic subtest B-DP1: SUCCESS (10.757s)
[91.782196] Starting dynamic subtest: C-DP1
[102.490751] Dynamic subtest C-DP1: SUCCESS (10.722s)
[102.492547] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.501s)
[102.887946] [015/142] (908s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[103.221436] Starting subtest: fbc-tiling-linear
[105.150406] Subtest fbc-tiling-linear: SUCCESS (1.930s)
[105.267395] [016/142] (906s left) feature_discovery (display-2x)
[105.564646] Starting subtest: display-2x
[105.567287] Subtest display-2x: SKIP (0.000s)
[105.651157] [017/142] (906s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done)
[105.916727] Subtest poll-write-waits-until-write-done: SKIP (0.000s)
[105.983442] [018/142] (905s left) kms_plane_lowres (tiling-4)
[106.282243] Starting subtest: tiling-4
[106.284856] Subtest tiling-4: SKIP (0.000s)
[106.367794] [019/142] (905s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs)
[106.981379] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs
[106.984051] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[107.375940] [020/142] (904s left) gem_exec_flush (basic-wb-ro-default)
[107.604284] Starting subtest: basic-wb-ro-default
[113.090454] Subtest basic-wb-ro-default: SUCCESS (5.485s)
[113.294309] [021/142] (898s left) gem_ctx_persistence (heartbeat-hang)
[113.507609] Starting subtest: heartbeat-hang
[114.706731] Subtest heartbeat-hang: SUCCESS (1.199s)
[114.793071] [022/142] (897s left) kms_flip (nonexisting-fb)
[115.073377] Starting subtest: nonexisting-fb
[115.074863] Starting dynamic subtest: A-DP1
[115.627373] Dynamic subtest A-DP1: SUCCESS (0.554s)
[115.643129] Starting dynamic subtest: B-DP1
[116.091928] Dynamic subtest B-DP1: SUCCESS (0.461s)
[116.107488] Starting dynamic subtest: C-DP1
[116.567191] Dynamic subtest C-DP1: SUCCESS (0.476s)
[116.570464] Subtest nonexisting-fb: SUCCESS (1.500s)
[116.975147] [023/142] (895s left) kms_cursor_crc (cursor-random-128x42)
[117.286835] Starting subtest: cursor-random-128x42
[117.299474] Starting dynamic subtest: pipe-A-DP-1
[121.101174] Dynamic subtest pipe-A-DP-1: SUCCESS (3.802s)
[121.178757] Starting dynamic subtest: pipe-C-DP-1
[125.296602] Dynamic subtest pipe-C-DP-1: SUCCESS (4.133s)
[125.298151] Subtest cursor-random-128x42: SUCCESS (8.009s)
[125.651503] [024/142] (886s left) vc4/vc4_purgeable_bo (mark-unpurgeable-twice)
[125.913844] Subtest mark-unpurgeable-twice: SKIP (0.000s)
[125.982422] [025/142] (886s left) v3d/v3d_submit_csd (bad-extension)
[126.247307] Subtest bad-extension: SKIP (0.000s)
[126.315954] [026/142] (885s left) kms_invalid_mode (bad-vtotal)
[126.618052] Starting subtest: bad-vtotal
[126.619505] Starting dynamic subtest: DP-1-pipe-A
[126.739990] Dynamic subtest DP-1-pipe-A: SUCCESS (0.121s)
[126.755647] Starting dynamic subtest: DP-1-pipe-B
[126.757083] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s)
[126.772524] Starting dynamic subtest: DP-1-pipe-C
[126.774245] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[126.775624] Subtest bad-vtotal: SUCCESS (0.157s)
[127.092122] [027/142] (885s left) i915_pm_rpm (debugfs-read)
[128.907378] Starting subtest: debugfs-read
[132.721028] Subtest debugfs-read: SUCCESS (3.810s)
[133.163195] [028/142] (879s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[133.473585] Starting subtest: psr-rgb101010-draw-pwrite
[133.476286] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[133.579491] [029/142] (878s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_ccs)
[134.139718] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_ccs
[134.664896] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_ccs: SUCCESS (0.525s)
[135.194873] [030/142] (877s left) prime_mmap (test_errors)
[135.400633] Starting subtest: test_errors
[135.401964] Starting dynamic subtest: test_errors-smem
[135.419641] Dynamic subtest test_errors-smem: SUCCESS (0.020s)
[135.421605] Subtest test_errors: SUCCESS (0.021s)
[135.527753] [031/142] (876s left) gem_exec_capture (capture-recoverable)
[135.744944] Starting subtest: capture-recoverable
[135.747877] Subtest capture-recoverable: SKIP (0.000s)
[135.844206] [032/142] (876s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[136.154735] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[142.035117] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (5.882s)
[142.369872] [033/142] (870s left) drm_fdinfo (all-busy-check-all)
[142.584472] Starting subtest: all-busy-check-all
[143.108754] Subtest all-busy-check-all: SUCCESS (0.524s)
[143.184757] [034/142] (869s left) kms_vblank (pipe-a-ts-continuation-suspend)
[143.491343] Starting subtest: pipe-A-ts-continuation-suspend
[160.242279] Subtest pipe-A-ts-continuation-suspend: SUCCESS (1.751s)
[163.374988] [035/142] (866s left) gem_exec_schedule (smoketest)
[163.777585] Starting subtest: smoketest
[163.779136] Starting dynamic subtest: rcs0
[169.249605] Dynamic subtest rcs0: SUCCESS (5.465s)
[169.271282] Starting dynamic subtest: bcs0
[174.721467] Dynamic subtest bcs0: SUCCESS (5.469s)
[174.741189] Starting dynamic subtest: vcs0
[180.193436] Dynamic subtest vcs0: SUCCESS (5.470s)
[180.213698] Starting dynamic subtest: vecs0
[185.669232] Dynamic subtest vecs0: SUCCESS (5.474s)
[185.670597] Subtest smoketest: SUCCESS (21.887s)
[185.896637] [036/142] (844s left) kms_prime (basic-modeset-hybrid)
[187.983485] Subtest basic-modeset-hybrid: SKIP (0.000s)
[188.082537] [037/142] (842s left) api_intel_bb (object-noreloc-purge-cache-simple)
[188.288946] Starting subtest: object-noreloc-purge-cache-simple
[188.297947] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.008s)
[188.411671] [038/142] (842s left) gem_exec_suspend (basic-s3)
[188.639161] Starting subtest: basic-S3
[188.640779] Starting dynamic subtest: smem
[210.895392] Dynamic subtest smem: SUCCESS (5.802s)
[210.897084] Subtest basic-S3: SUCCESS (5.804s)
[212.870105] [039/142] (835s left) gem_create (hog-create)
[213.096903] Starting subtest: hog-create
[213.098380] Starting dynamic subtest: smem0
[245.358382] Dynamic subtest smem0: SUCCESS (32.261s)
[245.360390] Subtest hog-create: SUCCESS (32.263s)
[245.570142] [040/142] (803s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[245.890894] Starting subtest: cursor-rapid-movement-64x21
[245.903771] Starting dynamic subtest: pipe-A-DP-1
[246.407450] Dynamic subtest pipe-A-DP-1: SUCCESS (0.504s)
[246.501660] Starting dynamic subtest: pipe-C-DP-1
[247.328226] Dynamic subtest pipe-C-DP-1: SUCCESS (0.848s)
[247.332554] Subtest cursor-rapid-movement-64x21: SUCCESS (1.436s)
[247.700385] [041/142] (801s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[247.910286] Starting subtest: no-spare-fences-busy-interruptible
[250.076837] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.166s)
[250.247249] [042/142] (798s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[250.907333] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[251.224082] [043/142] (797s left) gem_exec_schedule (preempt-queue-chain)
[251.460669] Starting subtest: preempt-queue-chain
[251.464893] Starting dynamic subtest: rcs0
[251.959045] Dynamic subtest rcs0: SUCCESS (0.494s)
[251.981737] Starting dynamic subtest: bcs0
[252.554675] Dynamic subtest bcs0: SUCCESS (0.593s)
[252.576344] Starting dynamic subtest: vcs0
[253.083325] Dynamic subtest vcs0: SUCCESS (0.525s)
[253.105956] Starting dynamic subtest: vecs0
[253.636195] Dynamic subtest vecs0: SUCCESS (0.552s)
[253.638053] Subtest preempt-queue-chain: SUCCESS (2.175s)
[254.008081] [044/142] (794s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[254.316154] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[254.318795] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[254.424210] [045/142] (794s left) gem_ctx_create (basic)
[254.649994] Starting subtest: basic
[254.651406] Subtest basic: SUCCESS (0.000s)
[254.858365] [046/142] (794s left) gem_eio (wait-1us)
[255.092932] Starting subtest: wait-1us
[255.183976] Subtest wait-1us: SUCCESS (0.091s)
[255.392989] [047/142] (793s left) kms_plane_scaling (planes-downscale-factor-0-25)
[255.703262] Starting subtest: planes-downscale-factor-0-25
[255.704759] Starting dynamic subtest: pipe-A-DP-1
[255.739554] Dynamic subtest pipe-A-DP-1: SKIP (0.034s)
[255.772711] Starting dynamic subtest: pipe-B-DP-1
[255.833143] Dynamic subtest pipe-B-DP-1: SKIP (0.086s)
[255.864043] Starting dynamic subtest: pipe-C-DP-1
[255.915594] Dynamic subtest pipe-C-DP-1: SKIP (0.078s)
[255.918624] Subtest planes-downscale-factor-0-25: SKIP (0.214s)
[256.024475] [048/142] (793s left) i915_query (query-regions-garbage-items)
[256.228096] Starting subtest: query-regions-garbage-items
[256.229701] Subtest query-regions-garbage-items: SUCCESS (0.002s)
[256.324068] [049/142] (792s left) gem_exec_reloc (basic-scanout)
[256.645892] Starting subtest: basic-scanout
[256.647262] Starting dynamic subtest: rcs0
[256.897403] Dynamic subtest rcs0: SUCCESS (0.252s)
[256.922902] Starting dynamic subtest: bcs0
[257.067124] Dynamic subtest bcs0: SUCCESS (0.164s)
[257.091703] Starting dynamic subtest: vcs0
[257.230919] Dynamic subtest vcs0: SUCCESS (0.165s)
[257.255802] Starting dynamic subtest: vecs0
[257.397571] Dynamic subtest vecs0: SUCCESS (0.164s)
[257.399265] Subtest basic-scanout: SUCCESS (0.754s)
[257.525804] [050/142] (791s left) kms_psr2_sf (plane-move-sf-dmg-area)
[257.729900] Subtest plane-move-sf-dmg-area: SKIP (0.000s)
[257.789976] [051/142] (791s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[258.093873] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[258.096713] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[258.191790] [052/142] (791s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[259.978529] Starting subtest: gem-execbuf-stress-pc8
[260.025946] Subtest gem-execbuf-stress-pc8: SKIP (0.043s)
[260.449815] [053/142] (788s left) gem_ctx_param (invalid-param-get)
[260.657375] Starting subtest: invalid-param-get
[260.659298] Subtest invalid-param-get: SUCCESS (0.000s)
[260.747739] [054/142] (788s left) syncobj_timeline (wait-for-submit-complex)
[260.950449] Starting subtest: wait-for-submit-complex
[261.014967] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[261.097798] [055/142] (788s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[261.412215] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[261.415725] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[261.514967] [056/142] (787s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[261.810197] Starting subtest: modeset-atomic-cursor-hotspot
[261.812898] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[261.898648] [057/142] (787s left) gem_mmap_gtt (hang-busy)
[262.102004] Starting subtest: hang-busy
[277.641076] Subtest hang-busy: SUCCESS (15.534s)
[277.747861] [058/142] (771s left) gem_mmap_gtt (coherency)
[277.950864] Starting subtest: coherency
[277.954557] Subtest coherency: SKIP (0.000s)
[278.047787] [059/142] (771s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[278.455635] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[278.748969] [060/142] (770s left) syncobj_wait (multi-wait-signaled)
[278.952195] Starting subtest: multi-wait-signaled
[278.953990] Subtest multi-wait-signaled: SUCCESS (0.001s)
[279.043166] [061/142] (770s left) gen9_exec_parse (bb-start-param)
[279.275377] Starting subtest: bb-start-param
[279.280949] Subtest bb-start-param: SUCCESS (0.005s)
[279.511346] [062/142] (770s left) kms_draw_crc (fill-fb)
[279.813427] Starting subtest: fill-fb
[280.249139] Subtest fill-fb: SUCCESS (0.437s)
[280.359745] [063/142] (769s left) kms_addfb_basic (bad-pitch-999)
[280.565934] Starting subtest: bad-pitch-999
[280.567434] Subtest bad-pitch-999: SUCCESS (0.000s)
[280.777194] [064/142] (768s left) syncobj_timeline (invalid-query-one-illegal-handle)
[280.980401] Starting subtest: invalid-query-one-illegal-handle
[280.982480] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s)
[281.076651] [065/142] (768s left) syncobj_timeline (invalid-wait-zero-handles)
[281.281335] Starting subtest: invalid-wait-zero-handles
[281.283147] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[281.378023] [066/142] (768s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[281.687200] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[281.689863] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[281.793835] [067/142] (768s left) gem_exec_async (forked-writes)
[282.025086] Starting subtest: forked-writes
[282.029375] Starting dynamic subtest: rcs0
[282.113446] Dynamic subtest rcs0: SUCCESS (0.084s)
[282.134976] Starting dynamic subtest: bcs0
[282.188434] Dynamic subtest bcs0: SUCCESS (0.074s)
[282.213009] Starting dynamic subtest: vcs0
[282.264184] Dynamic subtest vcs0: SUCCESS (0.073s)
[282.287723] Starting dynamic subtest: vecs0
[282.338466] Dynamic subtest vecs0: SUCCESS (0.072s)
[282.340119] Subtest forked-writes: SUCCESS (0.314s)
[282.577075] [068/142] (767s left) prime_self_import (export-vs-gem_close-race)
[282.777753] Starting subtest: export-vs-gem_close-race
[287.805779] Subtest export-vs-gem_close-race: SUCCESS (5.027s)
[287.892683] [069/142] (762s left) kms_flip (dpms-vs-vblank-race-interruptible)
[288.188863] Starting subtest: dpms-vs-vblank-race-interruptible
[288.194645] Starting dynamic subtest: A-DP1
[292.510291] Dynamic subtest A-DP1: SUCCESS (4.314s)
[292.535625] Starting dynamic subtest: B-DP1
[296.783009] Dynamic subtest B-DP1: SUCCESS (4.266s)
[296.806304] Starting dynamic subtest: C-DP1
[301.039702] Dynamic subtest C-DP1: SUCCESS (4.256s)
[301.041188] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.851s)
[301.406109] [070/142] (748s left) kms_cdclk (mode-transition-all-outputs)
[301.618256] Subtest mode-transition-all-outputs: SKIP (0.000s)
[301.669245] [071/142] (748s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[301.990125] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[303.094332] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.103s)
[303.326152] [072/142] (746s left) kms_big_fb (linear-16bpp-rotate-180)
[303.651990] Starting subtest: linear-16bpp-rotate-180
[308.159463] Subtest linear-16bpp-rotate-180: SUCCESS (4.507s)
[308.489921] [073/142] (741s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[308.799118] Starting subtest: 2x-flip-vs-rmfb-interruptible
[308.804329] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.003s)
[308.905374] [074/142] (741s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_mc_ccs)
[309.324677] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs
[309.328581] Subtest pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[309.876927] [075/142] (740s left) kms_atomic (atomic_plane_damage)
[310.305809] Starting subtest: atomic_plane_damage
[310.309107] Subtest atomic_plane_damage: SKIP (0.000s)
[310.741632] [076/142] (739s left) vc4/vc4_wait_seqno (bad-seqno-1ns)
[310.993947] Subtest bad-seqno-1ns: SKIP (0.000s)
[311.069419] [077/142] (739s left) kms_chamelium_hpd (hdmi-hpd-storm)
[311.460455] Subtest hdmi-hpd-storm: SKIP (0.000s)
[311.753485] [078/142] (738s left) kms_vblank (pipe-a-wait-forked-busy-hang)
[312.054812] Starting subtest: pipe-A-wait-forked-busy-hang
[319.439775] Subtest pipe-A-wait-forked-busy-hang: SUCCESS (7.384s)
[319.791119] [079/142] (730s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[320.098976] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[320.101820] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[320.207566] [080/142] (730s left) kms_psr (psr2_sprite_plane_move)
[320.414724] Subtest psr2_sprite_plane_move: SKIP (0.000s)
[320.472922] [081/142] (729s left) kms_draw_crc (draw-method-mmap-cpu)
[320.766387] Starting subtest: draw-method-mmap-cpu
[320.767943] Starting dynamic subtest: xrgb8888-untiled
[321.062351] Dynamic subtest xrgb8888-untiled: SUCCESS (0.295s)
[321.088344] Starting dynamic subtest: rgb565-untiled
[321.329900] Dynamic subtest rgb565-untiled: SUCCESS (0.264s)
[321.351525] Starting dynamic subtest: xrgb2101010-untiled
[321.629956] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.297s)
[321.652735] Starting dynamic subtest: xrgb8888-xtiled
[321.812305] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.181s)
[321.838530] Starting dynamic subtest: rgb565-xtiled
[322.002259] Dynamic subtest rgb565-xtiled: SUCCESS (0.181s)
[322.023280] Starting dynamic subtest: xrgb2101010-xtiled
[322.197797] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.196s)
[322.228238] Starting dynamic subtest: xrgb8888-ytiled
[322.397921] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.199s)
[322.422839] Starting dynamic subtest: rgb565-ytiled
[322.580186] Dynamic subtest rgb565-ytiled: SUCCESS (0.178s)
[322.601583] Starting dynamic subtest: xrgb2101010-ytiled
[322.778980] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.198s)
[322.780400] Subtest draw-method-mmap-cpu: SUCCESS (2.015s)
[322.910035] [082/142] (727s left) gem_exec_params (dr1-dirt)
[323.122365] Starting subtest: DR1-dirt
[323.124621] Subtest DR1-dirt: SUCCESS (0.001s)
[323.223357] [083/142] (727s left) kms_atomic_interruptible (legacy-dpms)
[323.526763] Starting subtest: legacy-dpms
[323.530905] Starting dynamic subtest: DP-1-pipe-A
[330.100836] Dynamic subtest DP-1-pipe-A: SUCCESS (6.571s)
[330.102133] Subtest legacy-dpms: SUCCESS (6.577s)
[330.440914] [084/142] (720s left) gem_wait (busy)
[330.684167] Starting subtest: busy
[330.685799] Starting dynamic subtest: all-engines
[331.211181] Dynamic subtest all-engines: SUCCESS (0.526s)
[331.239767] Starting dynamic subtest: rcs0
[331.729357] Dynamic subtest rcs0: SUCCESS (0.515s)
[331.753828] Starting dynamic subtest: bcs0
[332.251344] Dynamic subtest bcs0: SUCCESS (0.519s)
[332.276213] Starting dynamic subtest: vcs0
[332.771301] Dynamic subtest vcs0: SUCCESS (0.517s)
[332.796344] Starting dynamic subtest: vecs0
[333.286321] Dynamic subtest vecs0: SUCCESS (0.512s)
[333.288029] Subtest busy: SUCCESS (2.604s)
[333.540208] [085/142] (717s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[333.857783] Starting subtest: x-tiled-8bpp-rotate-90
[333.937842] Subtest x-tiled-8bpp-rotate-90: SKIP (0.077s)
[334.057649] [086/142] (716s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[334.373298] Starting subtest: fbcpsr-rgb101010-draw-render
[334.376324] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[334.473342] [087/142] (716s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[334.773290] Starting subtest: cursorA-vs-flipA-varying-size
[345.848112] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.075s)
[346.192541] [088/142] (704s left) gem_exec_reloc (basic-wc-read-active)
[346.408874] Starting subtest: basic-wc-read-active
[346.550071] Subtest basic-wc-read-active: SUCCESS (0.139s)
[346.739707] [089/142] (704s left) gem_ppgtt (shrink-vs-evict-any)
[346.951981] Starting subtest: shrink-vs-evict-any
[352.044114] Subtest shrink-vs-evict-any: SUCCESS (5.092s)
[352.138804] [090/142] (698s left) kms_flip (absolute-wf_vblank)
[352.419623] Starting subtest: absolute-wf_vblank
[352.426943] Starting dynamic subtest: A-DP1
[362.960029] Dynamic subtest A-DP1: SUCCESS (10.536s)
[362.985097] Starting dynamic subtest: B-DP1
[373.424876] Dynamic subtest B-DP1: SUCCESS (10.461s)
[373.449653] Starting dynamic subtest: C-DP1
[383.877984] Dynamic subtest C-DP1: SUCCESS (10.451s)
[383.882295] Subtest absolute-wf_vblank: SUCCESS (31.461s)
[384.310687] [091/142] (666s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[384.624054] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[384.627011] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[384.725114] [092/142] (666s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[384.927471] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[384.929350] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[385.025110] [093/142] (665s left) kms_color (deep-color)
[385.333257] Starting subtest: deep-color
[385.336166] Subtest deep-color: SKIP (0.000s)
[385.425146] [094/142] (665s left) kms_big_fb (y-tiled-addfb)
[385.755051] Starting subtest: y-tiled-addfb
[385.757141] Subtest y-tiled-addfb: SUCCESS (0.001s)
[385.875974] [095/142] (665s left) kms_pipe_crc_basic (nonblocking-crc)
[386.185530] Starting subtest: nonblocking-crc
[386.187197] Starting dynamic subtest: pipe-A-DP-1
[386.795843] Dynamic subtest pipe-A-DP-1: SUCCESS (0.609s)
[386.822690] Starting dynamic subtest: pipe-B-DP-1
[387.687118] Dynamic subtest pipe-B-DP-1: SUCCESS (0.886s)
[387.711296] Starting dynamic subtest: pipe-C-DP-1
[388.707362] Dynamic subtest pipe-C-DP-1: SUCCESS (1.014s)
[388.708887] Subtest nonblocking-crc: SUCCESS (2.526s)
[389.031393] [096/142] (662s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_mc_ccs)
[389.690258] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs
[389.693138] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[390.037777] [097/142] (661s left) gem_userptr_blits (sd-probe)
[390.249892] Starting subtest: sd-probe
[390.254735] Subtest sd-probe: SUCCESS (0.003s)
[390.422790] [098/142] (660s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[390.746756] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[392.159103] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.412s)
[392.306202] [099/142] (658s left) gem_render_copy (y-tiled-ccs-to-linear)
[392.530134] Starting subtest: y-tiled-ccs-to-linear
[392.534761] Starting dynamic subtest: smem
[392.801125] Dynamic subtest smem: SUCCESS (0.267s)
[392.802639] Subtest y-tiled-ccs-to-linear: SUCCESS (0.270s)
[393.006253] [100/142] (658s left) gem_softpin (evict-active)
[393.219906] Starting subtest: evict-active
[393.243805] Subtest evict-active: SUCCESS (0.023s)
[393.355219] [101/142] (657s left) perf (polling-small-buf)
[393.698047] Starting subtest: polling-small-buf
[393.834288] Subtest polling-small-buf: SUCCESS (0.136s)
[393.886931] [102/142] (657s left) device_reset (cold-reset-bound)
[394.125526] Subtest cold-reset-bound: SKIP (0.000s)
[394.204333] [103/142] (657s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[394.509965] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[395.634610] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.124s)
[395.979040] [104/142] (655s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_rc_ccs)
[396.597934] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs
[396.601830] Subtest pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[396.989761] [105/142] (654s left) perf_pmu (busy-idle-no-semaphores)
[397.207683] Starting subtest: busy-idle-no-semaphores
[397.209150] Starting dynamic subtest: rcs0
[397.848368] Dynamic subtest rcs0: SUCCESS (0.639s)
[397.874056] Starting dynamic subtest: bcs0
[398.483903] Dynamic subtest bcs0: SUCCESS (0.633s)
[398.510281] Starting dynamic subtest: vcs0
[399.119427] Dynamic subtest vcs0: SUCCESS (0.631s)
[399.145458] Starting dynamic subtest: vecs0
[399.749204] Dynamic subtest vecs0: SUCCESS (0.626s)
[399.751025] Subtest busy-idle-no-semaphores: SUCCESS (2.544s)
[399.858414] [106/142] (651s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[400.178873] Starting subtest: 4-tiled-64bpp-rotate-90
[400.182241] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[400.290815] [107/142] (651s left) kms_vblank (pipe-b-wait-busy)
[400.596752] Starting subtest: pipe-B-wait-busy
[403.459754] Subtest pipe-B-wait-busy: SUCCESS (2.865s)
[403.812476] [108/142] (647s left) v3d/v3d_perfmon (get-values-invalid-perfmon)
[404.068285] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[404.146019] [109/142] (647s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_mc_ccs)
[404.565837] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs
[404.568470] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[405.160390] [110/142] (646s left) gem_lmem_swapping (massive-random)
[405.377753] Subtest massive-random: SKIP (0.000s)
[405.443441] [111/142] (646s left) gem_close_race (basic-threads)
[405.676263] Starting subtest: basic-threads
[406.868758] Subtest basic-threads: SUCCESS (1.192s)
[407.077388] [112/142] (644s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[407.558918] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[407.562376] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[408.074670] [113/142] (643s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_ccs)
[408.760118] Subtest pipe-D-crc-primary-basic-y_tiled_ccs: SKIP (0.000s)
[409.085733] [114/142] (642s left) prime_mmap (test_reprime)
[409.288163] Starting subtest: test_reprime
[409.289750] Starting dynamic subtest: test_reprime-smem
[409.296762] Dynamic subtest test_reprime-smem: SUCCESS (0.007s)
[409.298560] Subtest test_reprime: SUCCESS (0.010s)
[409.400967] [115/142] (642s left) kms_universal_plane (universal-plane-pipe-c-sanity)
[409.707674] Starting subtest: universal-plane-pipe-C-sanity
[410.643444] Subtest universal-plane-pipe-C-sanity: SUCCESS (0.936s)
[410.965398] [116/142] (641s left) kms_addfb_basic (basic-x-tiled-legacy)
[411.170946] Starting subtest: basic-x-tiled-legacy
[411.172466] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[411.381997] [117/142] (640s left) kms_ccs (pipe-b-bad-aux-stride-yf_tiled_ccs)
[411.936192] Starting subtest: pipe-B-bad-aux-stride-yf_tiled_ccs
[411.938254] Subtest pipe-B-bad-aux-stride-yf_tiled_ccs: SUCCESS (0.002s)
[412.412399] [118/142] (639s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[412.622062] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[412.732466] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.110s)
[412.828894] [119/142] (639s left) i915_pm_backlight (fade-with-dpms)
[413.128130] Subtest fade-with-dpms: SKIP (0.000s)
[413.177876] [120/142] (638s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[413.381639] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[413.383472] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[413.479396] [121/142] (638s left) kms_vblank (pipe-d-query-forked-busy)
[413.785197] Subtest pipe-D-query-forked-busy: SKIP (0.000s)
[413.879285] [122/142] (638s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[414.103519] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[414.105306] Starting dynamic subtest: smem
[414.536472] Dynamic subtest smem: SUCCESS (0.430s)
[414.537882] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.432s)
[414.747875] [123/142] (637s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[415.044897] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[415.046472] Starting dynamic subtest: pipe-A-valid-mode
[415.133444] Dynamic subtest pipe-A-valid-mode: SKIP (0.086s)
[415.136100] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.091s)
[415.457364] [124/142] (636s left) gem_ctx_persistence (userptr)
[415.669397] Starting subtest: userptr
[415.788633] Subtest userptr: SUCCESS (0.119s)
[415.889723] [125/142] (636s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[416.562857] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs
[416.568436] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.004s)
[416.906420] [126/142] (635s left) kms_addfb_basic (bad-pitch-0)
[417.109543] Starting subtest: bad-pitch-0
[417.110876] Subtest bad-pitch-0: SUCCESS (0.000s)
[417.323073] [127/142] (635s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs)
[417.726866] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs
[417.729448] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[418.327457] [128/142] (634s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[418.635873] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[418.638671] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[418.744249] [129/142] (633s left) kms_flip (flip-vs-panning)
[419.033325] Starting subtest: flip-vs-panning
[419.034759] Starting dynamic subtest: A-DP1
[429.631156] Dynamic subtest A-DP1: SUCCESS (10.594s)
[429.654568] Starting dynamic subtest: B-DP1
[440.147533] Dynamic subtest B-DP1: SUCCESS (10.515s)
[440.174773] Starting dynamic subtest: C-DP1
[450.688795] Dynamic subtest C-DP1: SUCCESS (10.537s)
[450.693330] Subtest flip-vs-panning: SUCCESS (31.661s)
[451.132667] [130/142] (601s left) kms_ccs (pipe-d-random-ccs-data-yf_tiled_ccs)
[451.824823] Subtest pipe-D-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[452.145712] [131/142] (600s left) gem_softpin (allocator-basic-reserve)
[452.362903] Starting subtest: allocator-basic-reserve
[452.606425] Subtest allocator-basic-reserve: SUCCESS (0.242s)
[452.728109] [132/142] (599s left) gem_readwrite (beyond-eob)
[452.933117] Starting subtest: beyond-EOB
[452.936754] Subtest beyond-EOB: SUCCESS (0.000s)
[453.049909] [133/142] (599s left) kms_vrr (negative-basic)
[453.356407] Starting subtest: negative-basic
[453.359464] Subtest negative-basic: SKIP (0.000s)
[453.445393] [134/142] (599s left) gem_eio (in-flight-1us)
[453.671452] Starting subtest: in-flight-1us
[454.614905] Subtest in-flight-1us: SUCCESS (0.941s)
[454.829760] [135/142] (598s left) gem_pread (bench)
[455.036739] Starting subtest: bench
[459.443980] Subtest bench: SUCCESS (4.403s)
[459.544947] [136/142] (593s left) kms_psr (dpms)
[459.748339] Subtest dpms: SKIP (0.000s)
[459.809983] [137/142] (593s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[460.124898] Starting subtest: fbc-indfb-scaledprimary
[463.283456] Subtest fbc-indfb-scaledprimary: SUCCESS (3.159s)
[463.427774] [138/142] (589s left) gem_exec_whisper (basic-queues-forked-all)
[463.662474] Starting subtest: basic-queues-forked-all
[486.461243] Subtest basic-queues-forked-all: SUCCESS (22.795s)
[486.679200] [139/142] (566s left) gem_ctx_freq (sysfs)
[486.894244] Starting subtest: sysfs
[486.895804] Starting dynamic subtest: gt0
[491.888370] Dynamic subtest gt0: SUCCESS (4.992s)
[491.890451] Subtest sysfs: SUCCESS (4.995s)
[491.978956] [140/142] (561s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[492.187718] Starting subtest: single-wait-for-submit-available-submitted
[492.189399] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[492.278461] [141/142] (560s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[492.594901] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[492.597677] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[492.696620] [142/142] (560s left) gem_partial_pwrite_pread (write-uncached)
[492.911870] Starting subtest: write-uncached
[507.240214] Subtest write-uncached: SUCCESS (14.331s)
[507.358706] Closing watchdogs
Done.