[39.387375] Initializing watchdogs
[39.387449]   /dev/watchdog0
[39.394217] [001/140] (960s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[39.452438] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[39.454097] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[39.501976] [002/140] (960s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[41.472885] Starting subtest: 4-tiled-16bpp-rotate-270
[41.476210] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.000s)
[41.556967] [003/140] (958s left) syncobj_timeline (single-wait-for-submit-signaled)
[41.711986] Starting subtest: single-wait-for-submit-signaled
[41.713698] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[41.768952] [004/140] (958s left) perf (non-sampling-read-error)
[41.953837] Starting subtest: non-sampling-read-error
[41.973414] Subtest non-sampling-read-error: SUCCESS (0.018s)
[42.000327] [005/140] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[43.959092] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[43.962356] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[44.040729] [006/140] (955s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[46.085338] Starting subtest: 2x-cursor-vs-flip-atomic
[46.090515] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.004s)
[46.154333] [007/140] (953s left) kms_pm_dc (dc5-dpms-negative)
[49.184132] Starting subtest: dc5-dpms-negative
[53.598612] Subtest dc5-dpms-negative: SUCCESS (4.411s)
[53.899932] [008/140] (946s left) v3d/v3d_submit_csd (multisync-out-syncs)
[53.971217] Subtest multisync-out-syncs: SKIP (0.000s)
[54.022313] [009/140] (946s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[56.146661] Starting subtest: pipe-D-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[58.052627] Subtest pipe-D-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SUCCESS (1.905s)
[58.238960] [010/140] (941s left) gem_ppgtt (shrink-vs-evict-pinned)
[58.294213] Starting subtest: shrink-vs-evict-pinned
[64.274075] Subtest shrink-vs-evict-pinned: SUCCESS (5.977s)
[64.353308] [011/140] (935s left) gen3_render_tiledx_blits
[64.431727] [012/140] (935s left) kms_ccs (pipe-a-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[66.467555] Starting subtest: pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[66.470939] Subtest pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[66.672556] [013/140] (933s left) syncobj_wait (wait-any-snapshot)
[66.723250] Starting subtest: wait-any-snapshot
[66.805443] Subtest wait-any-snapshot: SUCCESS (0.082s)
[66.899413] [014/140] (933s left) kms_frontbuffer_tracking (basic)
[68.869151] Starting subtest: basic
[71.624981] Subtest basic: SUCCESS (2.761s)
[71.750286] [015/140] (928s left) kms_psr2_su (frontbuffer-xrgb8888)
[71.800134] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[71.831026] [016/140] (928s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-mtl-rc-ccs)
[73.885409] Starting subtest: pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs
[73.888613] Subtest pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[74.036031] [017/140] (926s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[75.995965] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[75.998914] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[76.074314] [018/140] (924s left) gem_mmap_gtt (basic-write-read-distinct)
[76.215161] Subtest basic-write-read-distinct: SKIP (0.000s)
[76.244974] [019/140] (923s left) vc4/vc4_perfmon (create-single-perfmon)
[76.322256] Subtest create-single-perfmon: SKIP (0.000s)
[76.375022] [020/140] (923s left) kms_ccs (pipe-b-bad-aux-stride-yf-tiled-ccs)
[78.452668] Starting subtest: pipe-B-bad-aux-stride-yf-tiled-ccs
[78.454584] Subtest pipe-B-bad-aux-stride-yf-tiled-ccs: SKIP (0.000s)
[78.616631] [021/140] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[80.575329] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[80.577408] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[80.634963] [022/140] (919s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-dg2-mc-ccs)
[82.706466] Starting subtest: pipe-B-random-ccs-data-4-tiled-dg2-mc-ccs
[82.709377] Subtest pipe-B-random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[82.881582] [023/140] (917s left) gem_exec_reloc (basic-gtt-active)
[82.934723] Subtest basic-gtt-active: SKIP (0.000s)
[82.974593] [024/140] (917s left) perf_pmu (busy-start)
[83.037649] Starting subtest: busy-start
[83.038475] Starting dynamic subtest: rcs0
[85.595887] Dynamic subtest rcs0: SUCCESS (2.558s)
[85.603455] Starting dynamic subtest: bcs0
[88.140928] Dynamic subtest bcs0: SUCCESS (2.545s)
[88.148532] Starting dynamic subtest: vcs0
[90.685937] Dynamic subtest vcs0: SUCCESS (2.545s)
[90.693462] Starting dynamic subtest: vcs1
[93.230908] Dynamic subtest vcs1: SUCCESS (2.545s)
[93.238454] Starting dynamic subtest: vecs0
[95.775904] Dynamic subtest vecs0: SUCCESS (2.545s)
[95.776883] Subtest busy-start: SUCCESS (12.738s)
[95.844770] [025/140] (904s left) gem_mmap_offset (perf)
[95.892590] Starting subtest: perf
[95.893458] Starting dynamic subtest: lmem0
[96.033653] Dynamic subtest lmem0: SUCCESS (0.140s)
[96.039731] Starting dynamic subtest: smem0
[96.043910] Dynamic subtest smem0: SUCCESS (0.004s)
[96.044841] Subtest perf: SUCCESS (0.144s)
[96.144291] [026/140] (904s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[98.097328] Starting subtest: fbc-rgb565-draw-blt
[100.667122] Subtest fbc-rgb565-draw-blt: SUCCESS (2.571s)
[100.798723] [027/140] (899s left) kms_getfb (getfb2-accept-ccs)
[100.848885] Starting subtest: getfb2-accept-ccs
[100.849860] Subtest getfb2-accept-ccs: SUCCESS (0.000s)
[100.931054] [028/140] (899s left) kms_ccs (pipe-d-crc-primary-basic-yf-tiled-ccs)
[103.051815] Starting subtest: pipe-D-crc-primary-basic-yf-tiled-ccs
[103.053981] Subtest pipe-D-crc-primary-basic-yf-tiled-ccs: SKIP (0.000s)
[103.163831] [029/140] (897s left) kms_cursor_edge_walk (64x64-right-edge)
[105.121534] Starting subtest: 64x64-right-edge
[105.122596] Starting dynamic subtest: pipe-A-HDMI-A-4
[108.511504] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.388s)
[108.517197] Starting dynamic subtest: pipe-D-HDMI-A-4
[111.713806] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.201s)
[111.714714] Subtest 64x64-right-edge: SUCCESS (6.593s)
[111.837254] [030/140] (888s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[113.791929] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[113.793885] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[113.875230] [031/140] (886s left) gem_workarounds (basic-read)
[114.026307] Starting subtest: basic-read
[114.049732] Subtest basic-read: SUCCESS (0.023s)
[114.152267] [032/140] (886s left) sw_sync (sync_merge)
[114.232161] Starting subtest: sync_merge
[114.233158] Subtest sync_merge: SUCCESS (0.000s)
[114.268710] [033/140] (886s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[116.219114] Starting subtest: pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[116.221073] Subtest pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[116.484754] [034/140] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[118.446285] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[118.448119] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[118.522652] [035/140] (881s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[120.542893] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[122.892065] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (2.351s)
[122.988540] [036/140] (877s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-ccs)
[124.991287] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-ccs
[124.993189] Subtest pipe-A-missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[125.199906] [037/140] (875s left) i915_query (query-regions-garbage-items)
[125.252430] Starting subtest: query-regions-garbage-items
[125.253253] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[125.320691] [038/140] (875s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[127.298444] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[127.300861] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[127.392672] [039/140] (873s left) gem_ctx_param (set-priority-range)
[127.536216] Starting subtest: set-priority-range
[127.559754] Subtest set-priority-range: SUCCESS (0.024s)
[127.671684] [040/140] (872s left) gem_mmap_gtt (fault-concurrent)
[127.754151] Subtest fault-concurrent: SKIP (0.000s)
[127.774982] [041/140] (872s left) gem_exec_whisper (basic-sync-all)
[127.828475] Starting subtest: basic-sync-all
[134.298479] Subtest basic-sync-all: SUCCESS (6.469s)
[134.536091] [042/140] (866s left) sw_sync (alloc_fence_invalid_timeline)
[134.613623] Starting subtest: alloc_fence_invalid_timeline
[134.614601] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[134.648337] [043/140] (866s left) kms_psr (psr2_primary_mmap_cpu)
[136.600921] Subtest psr2_primary_mmap_cpu: SKIP (0.000s)
[136.624737] [044/140] (864s left) kms_ccs (pipe-d-crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[138.723063] Starting subtest: pipe-D-crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[138.724998] Subtest pipe-D-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[138.831929] [045/140] (861s left) kms_big_fb (linear-8bpp-rotate-0)
[140.801519] Starting subtest: linear-8bpp-rotate-0
[142.318661] Subtest linear-8bpp-rotate-0: SUCCESS (1.515s)
[142.455785] [046/140] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[144.424485] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[144.426655] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[144.503254] [047/140] (856s left) gem_ctx_persistence (engines-hang)
[144.658430] Starting subtest: engines-hang
[144.659848] Starting dynamic subtest: rcs0
[144.728414] Dynamic subtest rcs0: SUCCESS (0.070s)
[144.736077] Starting dynamic subtest: bcs0
[144.811695] Dynamic subtest bcs0: SUCCESS (0.082s)
[144.837999] Starting dynamic subtest: vcs0
[144.858577] Dynamic subtest vcs0: SUCCESS (0.047s)
[144.870494] Starting dynamic subtest: vcs1
[144.891581] Dynamic subtest vcs1: SUCCESS (0.033s)
[144.905573] Starting dynamic subtest: vecs0
[144.911761] Dynamic subtest vecs0: SUCCESS (0.020s)
[144.913237] Subtest engines-hang: SUCCESS (0.254s)
[145.050155] [048/140] (855s left) gem_exec_capture (pi)
[145.140874] Starting subtest: pi
[145.141915] Starting dynamic subtest: rcs0
[151.693578] Dynamic subtest rcs0: SUCCESS (6.550s)
[151.699752] Starting dynamic subtest: bcs0
[157.819484] Dynamic subtest bcs0: SUCCESS (6.126s)
[157.825722] Starting dynamic subtest: vcs0
[163.959900] Dynamic subtest vcs0: SUCCESS (6.140s)
[163.965938] Starting dynamic subtest: vcs1
[170.175163] Dynamic subtest vcs1: SUCCESS (6.216s)
[170.181618] Starting dynamic subtest: vecs0
[176.039187] Dynamic subtest vecs0: SUCCESS (5.864s)
[176.040094] Subtest pi: SUCCESS (30.895s)
[176.178427] [049/140] (824s left) tools_test (sysfs_l3_parity)
[176.271234] Starting subtest: sysfs_l3_parity
[176.346535] Subtest sysfs_l3_parity: SKIP (0.080s)
[176.397391] [050/140] (824s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[176.451524] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[176.556547] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[176.622452] [051/140] (824s left) gem_close (many-handles-one-vma)
[176.679713] Starting subtest: many-handles-one-vma
[176.708785] Subtest many-handles-one-vma: SUCCESS (0.029s)
[176.807965] [052/140] (824s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[178.773165] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[178.776787] Starting dynamic subtest: pipe-A-HDMI-A-4
[178.918543] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.142s)
[178.930364] Starting dynamic subtest: pipe-B-HDMI-A-4
[179.058530] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.135s)
[179.069139] Starting dynamic subtest: pipe-C-HDMI-A-4
[179.180405] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.117s)
[179.191404] Starting dynamic subtest: pipe-D-HDMI-A-4
[179.303685] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.119s)
[179.304605] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.532s)
[179.423958] [053/140] (821s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[181.381140] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[181.383051] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[181.463619] [054/140] (819s left) gen9_exec_parse (valid-registers)
[181.598857] Subtest valid-registers: SKIP (0.000s)
[181.636570] [055/140] (819s left) kms_flip (flip-vs-panning-vs-hang)
[182.663373] Starting subtest: flip-vs-panning-vs-hang
[182.667897] Starting dynamic subtest: A-HDMI-A4
[220.825818] Dynamic subtest A-HDMI-A4: SUCCESS (38.158s)
[220.832157] Starting dynamic subtest: D-HDMI-A4
[270.860288] Dynamic subtest D-HDMI-A4: SUCCESS (50.034s)
[270.861208] Subtest flip-vs-panning-vs-hang: SUCCESS (88.198s)
[270.981911] [056/140] (729s left) vc4/vc4_tiling (set-bad-flags)
[271.067360] Subtest set-bad-flags: SKIP (0.000s)
[271.120471] [057/140] (729s left) gem_pwrite_snooped
[271.209029] [058/140] (729s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[273.223256] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[273.275409] [059/140] (727s left) drm_fdinfo (memory-info-purgeable)
[273.323764] Starting subtest: memory-info-purgeable
[273.327132] Starting dynamic subtest: lmem0
[273.355316] Dynamic subtest lmem0: SKIP (0.031s)
[273.362648] Starting dynamic subtest: smem0
[273.382612] Dynamic subtest smem0: SKIP (0.027s)
[273.385041] Subtest memory-info-purgeable: SKIP (0.058s)
[273.485174] [060/140] (727s left) gem_exec_schedule (pi-shared-iova)
[273.695790] Starting subtest: pi-shared-iova
[273.696742] Starting dynamic subtest: rcs0
[273.850216] Dynamic subtest rcs0: SUCCESS (0.155s)
[273.856516] Starting dynamic subtest: bcs0
[273.940664] Dynamic subtest bcs0: SUCCESS (0.093s)
[273.947117] Starting dynamic subtest: vcs0
[274.050964] Dynamic subtest vcs0: SUCCESS (0.107s)
[274.057555] Starting dynamic subtest: vcs1
[274.161500] Dynamic subtest vcs1: SUCCESS (0.109s)
[274.167859] Starting dynamic subtest: vecs0
[274.267166] Dynamic subtest vecs0: SUCCESS (0.108s)
[274.267933] Subtest pi-shared-iova: SUCCESS (0.575s)
[274.556146] [061/140] (726s left) kms_draw_crc (draw-method-mmap-gtt)
[276.538218] Starting subtest: draw-method-mmap-gtt
[276.540243] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[276.618381] [062/140] (724s left) drm_fdinfo (busy-hang)
[276.746962] Starting subtest: busy-hang
[276.748047] Starting dynamic subtest: rcs0
[276.750036] Dynamic subtest rcs0: SKIP (0.001s)
[276.758604] Starting dynamic subtest: bcs0
[276.760884] Dynamic subtest bcs0: SKIP (0.000s)
[276.769204] Starting dynamic subtest: vcs0
[276.771500] Dynamic subtest vcs0: SKIP (0.000s)
[276.780023] Starting dynamic subtest: vcs1
[276.782161] Dynamic subtest vcs1: SKIP (0.000s)
[276.790672] Starting dynamic subtest: vecs0
[276.792916] Dynamic subtest vecs0: SKIP (0.000s)
[276.795295] Subtest busy-hang: SKIP (0.004s)
[276.816808] [063/140] (724s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[278.791596] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[278.793713] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[278.867970] [064/140] (722s left) gem_ctx_shared (disjoint-timelines)
[278.985790] Starting subtest: disjoint-timelines
[279.036898] Subtest disjoint-timelines: SUCCESS (0.051s)
[279.318889] [065/140] (721s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[281.285631] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[281.288058] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[281.368248] [066/140] (719s left) kms_psr (psr_sprite_plane_move)
[283.402145] Subtest psr_sprite_plane_move: SKIP (0.000s)
[283.421281] [067/140] (717s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[285.382529] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[285.384591] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[285.469296] [068/140] (715s left) gem_exec_schedule (u-lateslice)
[285.623500] Starting subtest: u-lateslice
[285.624529] Starting dynamic subtest: rcs0
[285.658070] Dynamic subtest rcs0: SUCCESS (0.034s)
[285.671944] Starting dynamic subtest: bcs0
[285.685313] Dynamic subtest bcs0: SUCCESS (0.027s)
[285.692760] Starting dynamic subtest: vcs0
[285.706903] Dynamic subtest vcs0: SUCCESS (0.021s)
[285.721121] Starting dynamic subtest: vcs1
[285.735282] Dynamic subtest vcs1: SUCCESS (0.028s)
[285.742392] Starting dynamic subtest: vecs0
[285.754661] Dynamic subtest vecs0: SUCCESS (0.019s)
[285.755677] Subtest u-lateslice: SUCCESS (0.131s)
[286.122617] [069/140] (715s left) gem_ringfill (engines-basic)
[286.526280] Starting subtest: engines-basic
[286.528545] Starting dynamic subtest: rcs0
[286.609977] Dynamic subtest rcs0: SUCCESS (0.084s)
[286.617293] Starting dynamic subtest: bcs0
[286.649212] Dynamic subtest bcs0: SUCCESS (0.039s)
[286.661069] Starting dynamic subtest: vcs0
[286.691883] Dynamic subtest vcs0: SUCCESS (0.041s)
[286.724648] Starting dynamic subtest: vcs1
[286.744610] Dynamic subtest vcs1: SUCCESS (0.052s)
[286.761670] Starting dynamic subtest: vecs0
[286.790745] Dynamic subtest vecs0: SUCCESS (0.045s)
[286.792190] Subtest engines-basic: SUCCESS (0.266s)
[286.924440] [070/140] (714s left) kms_flip (2x-plain-flip-fb-recreate)
[287.925961] Starting subtest: 2x-plain-flip-fb-recreate
[287.950620] Subtest 2x-plain-flip-fb-recreate: SKIP (0.024s)
[288.013834] [071/140] (713s left) kms_chamelium_color (ctm-0-25)
[290.007616] Subtest ctm-0-25: SKIP (0.000s)
[290.037485] [072/140] (711s left) kms_ccs (pipe-d-bad-pixel-format-y-tiled-gen12-rc-ccs)
[292.140725] Starting subtest: pipe-D-bad-pixel-format-y-tiled-gen12-rc-ccs
[292.141719] Subtest pipe-D-bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.000s)
[292.260650] [073/140] (709s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[294.219757] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[294.221625] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[294.299559] [074/140] (707s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[296.342122] Starting subtest: yf-tiled-16bpp-rotate-180
[296.344615] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[296.415125] [075/140] (704s left) gen7_exec_parse (basic-allocation)
[296.537737] Subtest basic-allocation: SKIP (0.000s)
[296.577469] [076/140] (704s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[298.702551] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[298.706781] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[298.840319] [077/140] (702s left) syncobj_timeline (multi-wait-all-available-submitted)
[298.898480] Starting subtest: multi-wait-all-available-submitted
[298.899627] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[298.975671] [078/140] (702s left) kms_sequence (get-busy)
[300.955596] Starting subtest: get-busy
[300.956616] Starting dynamic subtest: pipe-A-HDMI-A-4
[303.485657] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.529s)
[303.493781] Starting dynamic subtest: pipe-B-HDMI-A-4
[305.852628] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.365s)
[305.859098] Starting dynamic subtest: pipe-C-HDMI-A-4
[308.230270] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.376s)
[308.239056] Starting dynamic subtest: pipe-D-HDMI-A-4
[310.615433] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.383s)
[310.616420] Subtest get-busy: SUCCESS (9.660s)
[310.762323] [079/140] (690s left) kms_flip (2x-flip-vs-suspend)
[311.766997] Starting subtest: 2x-flip-vs-suspend
[311.791871] Subtest 2x-flip-vs-suspend: SKIP (0.024s)
[311.860309] [080/140] (689s left) syncobj_wait (single-wait-submitted)
[311.952320] Starting subtest: single-wait-submitted
[312.062676] Subtest single-wait-submitted: SUCCESS (0.106s)
[312.153749] [081/140] (689s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[314.135832] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[314.136934] Starting dynamic subtest: pipe-A-valid-mode
[314.181721] Dynamic subtest pipe-A-valid-mode: SKIP (0.043s)
[314.183838] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.045s)
[314.266014] [082/140] (687s left) gem_ctx_sseu (mmap-args)
[314.327149] Subtest mmap-args: SKIP (0.000s)
[314.360583] [083/140] (687s left) gem_exec_reloc (basic-cpu-gtt)
[314.419856] Subtest basic-cpu-gtt: SKIP (0.000s)
[314.457600] [084/140] (687s left) kms_flip (flip-vs-fences)
[315.461420] Starting subtest: flip-vs-fences
[315.463040] Subtest flip-vs-fences: SKIP (0.000s)
[315.536055] [085/140] (686s left) i915_pm_rps (basic-api)
[315.657340] Starting subtest: basic-api
[315.659300] Subtest basic-api: SKIP (0.001s)
[315.738073] [086/140] (685s left) kms_cursor_crc (cursor-random-64x21)
[317.805675] Starting subtest: cursor-random-64x21
[317.812432] Starting dynamic subtest: pipe-A-HDMI-A-4
[322.403188] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.591s)
[322.428100] Starting dynamic subtest: pipe-D-HDMI-A-4
[326.880416] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.457s)
[326.881384] Subtest cursor-random-64x21: SUCCESS (9.074s)
[327.228870] [087/140] (674s left) kms_pm_rpm (modeset-pc8-residency-stress)
[331.535346] Starting subtest: modeset-pc8-residency-stress
[331.537812] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[332.661046] [088/140] (668s left) kms_flip (plain-flip-interruptible)
[333.676843] Starting subtest: plain-flip-interruptible
[333.688015] Starting dynamic subtest: A-HDMI-A4
[334.381317] Dynamic subtest A-HDMI-A4: SUCCESS (0.693s)
[334.391819] Starting dynamic subtest: B-HDMI-A4
[335.021249] Dynamic subtest B-HDMI-A4: SUCCESS (0.639s)
[335.028814] Starting dynamic subtest: C-HDMI-A4
[335.660729] Dynamic subtest C-HDMI-A4: SUCCESS (0.639s)
[335.668192] Starting dynamic subtest: D-HDMI-A4
[336.301344] Dynamic subtest D-HDMI-A4: SUCCESS (0.640s)
[336.302298] Subtest plain-flip-interruptible: SUCCESS (2.625s)
[336.465671] [089/140] (665s left) gem_exec_nop (basic-parallel)
[336.526834] Starting subtest: basic-parallel
[340.258466] Subtest basic-parallel: SUCCESS (3.732s)
[340.470112] [090/140] (661s left) gem_eio (in-flight-contexts-1us)
[340.664625] Starting subtest: in-flight-contexts-1us
[354.243754] Subtest in-flight-contexts-1us: SUCCESS (13.579s)
[356.209307] [091/140] (645s left) syncobj_wait (invalid-single-wait-unsubmitted)
[356.295374] Starting subtest: invalid-single-wait-unsubmitted
[356.296778] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[356.377442] [092/140] (645s left) kms_vblank (wait-forked-hang)
[358.358927] Starting subtest: wait-forked-hang
[358.361743] Starting dynamic subtest: pipe-A-HDMI-A-4
[360.759281] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.398s)
[360.770217] Starting dynamic subtest: pipe-D-HDMI-A-4
[362.972819] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.208s)
[362.973747] Subtest wait-forked-hang: SUCCESS (4.614s)
[363.073457] [093/140] (638s left) kms_prop_blob (blob-prop-lifetime)
[363.122660] Starting subtest: blob-prop-lifetime
[363.123471] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[363.201285] [094/140] (638s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[365.193651] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[366.275967] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.079s)
[366.394616] [095/140] (635s left) gen9_exec_parse (bb-start-far)
[366.445493] Subtest bb-start-far: SKIP (0.000s)
[366.465568] [096/140] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[368.426644] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[368.428642] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[368.512650] [097/140] (633s left) kms_plane_lowres (tiling-y)
[370.548783] Starting subtest: tiling-y
[370.549847] Starting dynamic subtest: pipe-A-HDMI-A-4
[379.402675] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (8.853s)
[379.439571] Starting dynamic subtest: pipe-B-HDMI-A-4
[388.024423] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (8.589s)
[388.115504] Starting dynamic subtest: pipe-C-HDMI-A-4
[396.697600] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (8.589s)
[396.735190] Starting dynamic subtest: pipe-D-HDMI-A-4
[405.325092] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (8.600s)
[405.413684] Subtest tiling-y: SUCCESS (34.864s)
[405.553607] [098/140] (596s left) gem_userptr_blits (sync-overlap)
[405.621237] Starting subtest: sync-overlap
[405.622137] Subtest sync-overlap: SUCCESS (0.000s)
[405.746404] [099/140] (596s left) gem_ccs (ctrl-surf-copy)
[405.829033] Starting subtest: ctrl-surf-copy
[405.830816] Subtest ctrl-surf-copy: SKIP (0.000s)
[405.884845] [100/140] (596s left) gem_eio (banned)
[406.076472] Starting subtest: banned
[406.943097] Subtest banned: SUCCESS (0.867s)
[408.921386] [101/140] (593s left) kms_vblank (ts-continuation-dpms-suspend)
[410.956315] Starting subtest: ts-continuation-dpms-suspend
[410.959570] Starting dynamic subtest: pipe-A-HDMI-A-4
[431.755176] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (9.306s)
[431.768928] Starting dynamic subtest: pipe-D-HDMI-A-4
[452.748623] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (8.734s)
[452.749488] Subtest ts-continuation-dpms-suspend: SUCCESS (18.048s)
[459.877112] [102/140] (572s left) sw_sync (sync_multi_producer_single_consumer)
[459.929503] Starting subtest: sync_multi_producer_single_consumer
[461.007665] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[461.049061] [103/140] (571s left) kms_cursor_crc (cursor-offscreen-512x512)
[463.189686] Starting subtest: cursor-offscreen-512x512
[463.193368] Subtest cursor-offscreen-512x512: SKIP (0.002s)
[463.401258] [104/140] (569s left) gem_mmap_gtt (basic-small-copy)
[463.468243] Subtest basic-small-copy: SKIP (0.000s)
[463.492417] [105/140] (569s left) kms_plane_alpha_blend (alpha-transparent-fb)
[465.448428] Starting subtest: alpha-transparent-fb
[465.673114] Starting dynamic subtest: pipe-A-HDMI-A-4
[466.149776] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.476s)
[466.160784] Starting dynamic subtest: pipe-D-HDMI-A-4
[466.630469] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.478s)
[466.631427] Subtest alpha-transparent-fb: SUCCESS (1.182s)
[466.777797] [106/140] (566s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[467.258228] Starting subtest: syncobj-backward-timeline-chain-engines
[467.363060] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.104s)
[467.655500] [107/140] (565s left) core_auth (getclient-simple)
[467.707799] Starting subtest: getclient-simple
[467.711235] Subtest getclient-simple: SUCCESS (0.002s)
[467.790525] [108/140] (565s left) kms_getfb (getfb-handle-protection)
[467.842710] Starting subtest: getfb-handle-protection
[467.862935] Subtest getfb-handle-protection: SUCCESS (0.020s)
[468.015594] [109/140] (564s left) syncobj_eventfd (binary-wait)
[468.080080] Starting subtest: binary-wait
[468.090217] Subtest binary-wait: SUCCESS (0.011s)
[468.189067] [110/140] (564s left) kms_chamelium_hpd (hdmi-hpd-fast)
[470.182986] Subtest hdmi-hpd-fast: SKIP (0.000s)
[470.240834] [111/140] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[472.198592] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[472.200669] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[472.286981] [112/140] (560s left) kms_color (legacy-gamma)
[474.323613] Starting subtest: legacy-gamma
[474.324859] Starting dynamic subtest: pipe-A
[475.010903] Dynamic subtest pipe-A: SUCCESS (0.687s)
[475.020065] Starting dynamic subtest: pipe-B
[475.512259] Dynamic subtest pipe-B: SUCCESS (0.500s)
[475.522997] Starting dynamic subtest: pipe-C
[476.002879] Dynamic subtest pipe-C: SUCCESS (0.489s)
[476.011752] Starting dynamic subtest: pipe-D
[476.477079] Dynamic subtest pipe-D: SUCCESS (0.474s)
[476.477955] Subtest legacy-gamma: SUCCESS (2.155s)
[476.605807] [113/140] (556s left) kms_async_flips (crc)
[478.556742] Starting subtest: crc
[478.734505] Starting dynamic subtest: pipe-A-HDMI-A-4
[481.534079] Dynamic subtest pipe-A-HDMI-A-4: FAIL (2.518s)
[481.549670] Starting dynamic subtest: pipe-B-HDMI-A-4
[484.064513] Dynamic subtest pipe-B-HDMI-A-4: FAIL (2.568s)
[484.116764] Starting dynamic subtest: pipe-C-HDMI-A-4
[486.707906] Dynamic subtest pipe-C-HDMI-A-4: FAIL (2.512s)
[486.777582] Starting dynamic subtest: pipe-D-HDMI-A-4
[489.413300] Dynamic subtest pipe-D-HDMI-A-4: FAIL (2.560s)
[489.414523] Subtest crc: FAIL (10.775s)
[489.599092] [114/140] (543s left) gem_softpin (allocator-evict)
[489.655567] Starting subtest: allocator-evict
[489.656516] Starting dynamic subtest: rcs0
[517.350268] Dynamic subtest rcs0: SUCCESS (27.691s)
[517.359692] Starting dynamic subtest: bcs0
[545.373117] Dynamic subtest bcs0: SUCCESS (28.022s)
[545.382197] Starting dynamic subtest: vcs0
[573.273858] Dynamic subtest vcs0: SUCCESS (27.899s)
[573.282822] Starting dynamic subtest: vcs1
[601.213995] Dynamic subtest vcs1: SUCCESS (27.939s)
[601.223137] Starting dynamic subtest: vecs0
[629.127776] Dynamic subtest vecs0: SUCCESS (27.913s)
[629.128619] Subtest allocator-evict: SUCCESS (139.470s)
[629.233440] [115/140] (403s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[631.278158] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[631.280227] Subtest pipe-A-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[631.500265] [116/140] (401s left) prime_busy (hang)
[631.554721] Starting subtest: hang
[631.557169] Starting dynamic subtest: rcs0
[645.564785] Dynamic subtest rcs0: SUCCESS (14.007s)
[645.574077] Starting dynamic subtest: bcs0
[652.715421] Dynamic subtest bcs0: SUCCESS (7.151s)
[652.726093] Starting dynamic subtest: vcs0
[659.691897] Dynamic subtest vcs0: SUCCESS (6.975s)
[659.702498] Starting dynamic subtest: vcs1
[666.733380] Dynamic subtest vcs1: SUCCESS (7.040s)
[666.744155] Starting dynamic subtest: vecs0
[673.709091] Dynamic subtest vecs0: SUCCESS (6.974s)
[673.710138] Subtest hang: SUCCESS (42.155s)
[673.800409] [117/140] (359s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[675.759132] Starting subtest: psr-rgb565-draw-blt
[675.761116] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[675.855940] [118/140] (357s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[677.918657] Starting subtest: x-tiled-64bpp-rotate-90
[677.975427] Subtest x-tiled-64bpp-rotate-90: SKIP (0.056s)
[678.087008] [119/140] (355s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[680.089468] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[680.091475] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[680.166667] [120/140] (353s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[682.194432] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[682.196584] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[682.266049] [121/140] (350s left) syncobj_timeline (wait-for-submit-delayed-submit)
[682.382648] Starting subtest: wait-for-submit-delayed-submit
[682.489127] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[682.624061] [122/140] (350s left) gem_create (create-ext-placement-all)
[682.801064] Starting subtest: create-ext-placement-all
[682.802380] Subtest create-ext-placement-all: SUCCESS (0.000s)
[682.909384] [123/140] (350s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-ccs)
[684.938163] Starting subtest: pipe-B-crc-primary-basic-y-tiled-ccs
[684.940203] Subtest pipe-B-crc-primary-basic-y-tiled-ccs: SKIP (0.001s)
[685.128838] [124/140] (348s left) v3d/v3d_perfmon (create-perfmon-exceed)
[685.226537] Subtest create-perfmon-exceed: SKIP (0.000s)
[685.290996] [125/140] (348s left) gem_exec_schedule (preempt-queue)
[685.358421] Subtest preempt-queue: SKIP (0.000s)
[685.717634] [126/140] (347s left) gem_render_copy (y-tiled)
[685.771547] Starting subtest: y-tiled
[685.772424] Starting dynamic subtest: smem
[685.854727] Dynamic subtest smem: SUCCESS (0.083s)
[685.865230] Starting dynamic subtest: lmem0
[686.613360] Dynamic subtest lmem0: SUCCESS (0.754s)
[686.614648] Subtest y-tiled: SUCCESS (0.839s)
[686.865684] [127/140] (346s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[686.928069] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[686.953182] [128/140] (346s left) kms_lease (page-flip-implicit-plane)
[688.904375] Starting subtest: page-flip-implicit-plane
[688.905438] Starting dynamic subtest: pipe-A-HDMI-A-4
[689.299286] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.393s)
[689.311112] Starting dynamic subtest: pipe-B-HDMI-A-4
[689.518477] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.217s)
[689.532083] Starting dynamic subtest: pipe-C-HDMI-A-4
[689.752424] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.230s)
[689.764654] Starting dynamic subtest: pipe-D-HDMI-A-4
[689.981683] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.226s)
[689.982593] Subtest page-flip-implicit-plane: SUCCESS (1.078s)
[690.100680] [129/140] (343s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[692.060767] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[692.062754] Subtest psr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[692.139059] [130/140] (341s left) gem_exec_balancer (full-late-pulse)
[692.284318] Starting subtest: full-late-pulse
[693.840508] Subtest full-late-pulse: SUCCESS (1.556s)
[694.153419] [131/140] (339s left) v3d/v3d_submit_csd (bad-multisync-in-sync)
[694.231325] Subtest bad-multisync-in-sync: SKIP (0.000s)
[694.290045] [132/140] (339s left) gem_exec_flush (basic-wb-prw-default)
[694.358209] Subtest basic-wb-prw-default: SKIP (0.000s)
[694.392195] [133/140] (339s left) kms_ccs (pipe-c-crc-primary-basic-y-tiled-gen12-mc-ccs)
[696.464479] Starting subtest: pipe-C-crc-primary-basic-y-tiled-gen12-mc-ccs
[696.466769] Subtest pipe-C-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[696.618565] [134/140] (336s left) kms_ccs (pipe-b-missing-ccs-buffer-yf-tiled-ccs)
[698.657274] Starting subtest: pipe-B-missing-ccs-buffer-yf-tiled-ccs
[698.659274] Subtest pipe-B-missing-ccs-buffer-yf-tiled-ccs: SKIP (0.000s)
[698.834935] [135/140] (334s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[698.890836] Starting subtest: mixed-tiled-to-y-tiled-ccs
[698.891670] Starting dynamic subtest: smem
[698.990020] Dynamic subtest smem: SUCCESS (0.099s)
[699.000631] Starting dynamic subtest: lmem0
[699.930703] Dynamic subtest lmem0: SUCCESS (0.937s)
[699.931644] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (1.037s)
[700.119581] [136/140] (333s left) kms_plane_scaling (2x-scaler-multi-pipe)
[702.076350] Starting subtest: 2x-scaler-multi-pipe
[702.080640] Subtest 2x-scaler-multi-pipe: SKIP (0.003s)
[702.156773] [137/140] (331s left) api_intel_bb (destroy-bb)
[702.277405] Starting subtest: destroy-bb
[702.301219] Subtest destroy-bb: SUCCESS (0.025s)
[702.442594] [138/140] (331s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[704.419421] Starting subtest: cursorB-vs-flipA-legacy
[704.422274] Subtest cursorB-vs-flipA-legacy: SKIP (0.004s)
[704.486356] [139/140] (329s left) gem_exec_fence (syncobj-timeline-export)
[705.039993] Starting subtest: syncobj-timeline-export
[705.057602] Subtest syncobj-timeline-export: SUCCESS (0.020s)
[705.286526] [140/140] (328s left) gem_media_vme
[705.374765] Closing watchdogs
Done.