[39.401598] Initializing watchdogs
[39.401640]   /dev/watchdog0
[39.407642] [001/142] (960s left) gem_render_copy (linear)
[39.466445] Starting subtest: linear
[39.468826] Starting dynamic subtest: smem
[39.505489] Dynamic subtest smem: SUCCESS (0.040s)
[39.508483] Subtest linear: SUCCESS (0.040s)
[39.683753] [002/142] (960s left) kms_feature_discovery (display)
[39.757431] Starting subtest: display
[39.759926] Subtest display: SUCCESS (0.000s)
[39.817989] [003/142] (960s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[39.925143] Starting subtest: cursorB-vs-flipB-atomic
[39.929928] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[40.044196] [004/142] (959s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[40.135768] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[44.781524] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.651s)
[44.908646] [005/142] (955s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[45.009067] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[45.013254] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[45.092614] [006/142] (954s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[45.153855] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[45.157844] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[45.245970] [007/142] (954s left) core_setmaster (master-drop-set-user)
[45.841433] Starting subtest: master-drop-set-user
[45.857965] Subtest master-drop-set-user: SUCCESS (0.017s)
[45.880354] [008/142] (954s left) gem_eio (in-flight-suspend)
[46.025041] Starting subtest: in-flight-suspend
[88.638020] Subtest in-flight-suspend: SUCCESS (13.252s)
[89.889510] [009/142] (939s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[89.977747] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[89.982143] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[90.064138] [010/142] (939s left) gem_partial_pwrite_pread (reads-display)
[90.113297] Subtest reads-display: SKIP (0.000s)
[90.171826] [011/142] (939s left) kms_hdr (static-swap)
[90.255400] Starting subtest: static-swap
[90.259804] Subtest static-swap: SKIP (0.000s)
[90.312775] [012/142] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[90.375825] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[94.938530] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.568s)
[95.051113] [013/142] (934s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[95.122283] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[95.126696] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[95.204654] [014/142] (934s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_rc_ccs)
[95.607029] Starting subtest: pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs
[95.609944] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs: SUCCESS (0.000s)
[96.427070] [015/142] (933s left) kms_chamelium_frames (hdmi-frame-dump)
[96.787197] Subtest hdmi-frame-dump: SKIP (0.000s)
[97.694493] [016/142] (931s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[97.775377] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[102.661742] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.889s)
[102.773386] [017/142] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[102.837900] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[102.841733] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[102.926888] [018/142] (926s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[103.024445] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[103.030010] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[103.114502] [019/142] (926s left) kms_universal_plane (cursor-fb-leak-pipe-b)
[103.173693] Starting subtest: cursor-fb-leak-pipe-B
[104.871640] Subtest cursor-fb-leak-pipe-B: SUCCESS (1.700s)
[105.792184] [020/142] (923s left) kms_psr (psr2_primary_blt)
[105.877556] Starting subtest: psr2_primary_blt
[107.669942] Subtest psr2_primary_blt: SUCCESS (1.791s)
[108.608118] [021/142] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[108.679614] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[113.666236] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.992s)
[113.799935] [022/142] (915s left) gem_ctx_param (invalid-size-set)
[113.862287] Starting subtest: invalid-size-set
[113.864742] Subtest invalid-size-set: SUCCESS (0.000s)
[113.919569] [023/142] (915s left) gem_userptr_blits (invalid-null-pointer)
[113.968751] Starting subtest: invalid-null-pointer
[113.971351] Subtest invalid-null-pointer: SUCCESS (0.000s)
[114.070384] [024/142] (915s left) kms_prop_blob (basic)
[114.117058] Starting subtest: basic
[114.119122] Subtest basic: SUCCESS (0.000s)
[114.172273] [025/142] (915s left) kms_3d
[116.400658] [026/142] (913s left) gen9_exec_parse (batch-invalid-length)
[116.459326] Subtest batch-invalid-length: SKIP (0.000s)
[116.476588] [027/142] (913s left) gem_eio (kms)
[116.649388] Starting subtest: kms
[154.144204] Subtest kms: SUCCESS (37.496s)
[155.398770] [028/142] (874s left) kms_async_flips (test-cursor)
[155.491212] Starting subtest: test-cursor
[155.496124] Subtest test-cursor: SKIP (0.000s)
[156.803228] [029/142] (873s left) gem_softpin (allocator-basic-reserve)
[156.851208] Starting subtest: allocator-basic-reserve
[156.902882] Subtest allocator-basic-reserve: SUCCESS (0.052s)
[157.011282] [030/142] (872s left) perf (gen12-invalid-class-instance)
[157.174104] Starting subtest: gen12-invalid-class-instance
[157.182114] Subtest gen12-invalid-class-instance: SUCCESS (0.009s)
[157.209826] [031/142] (872s left) gem_tiled_wc
[157.310219] [032/142] (872s left) gem_exec_parallel (engines)
[157.378614] Starting subtest: engines
[157.380653] Starting dynamic subtest: basic
[158.820342] Dynamic subtest basic: SUCCESS (1.447s)
[158.835113] Starting dynamic subtest: contexts
[160.829938] Dynamic subtest contexts: SUCCESS (2.007s)
[160.844112] Starting dynamic subtest: fds
[162.987328] Dynamic subtest fds: SUCCESS (2.156s)
[163.004688] Starting dynamic subtest: userptr
[164.837017] Dynamic subtest userptr: SUCCESS (1.849s)
[164.840134] Subtest engines: SUCCESS (7.463s)
[165.033116] [033/142] (865s left) gem_ctx_persistence (engines-persistence)
[165.100886] Starting subtest: engines-persistence
[165.102815] Starting dynamic subtest: rcs0
[165.863223] Dynamic subtest rcs0: SUCCESS (0.764s)
[165.878391] Starting dynamic subtest: bcs0
[166.627832] Dynamic subtest bcs0: SUCCESS (0.764s)
[166.643119] Starting dynamic subtest: vcs0
[167.398819] Dynamic subtest vcs0: SUCCESS (0.770s)
[167.413608] Starting dynamic subtest: vcs1
[168.162883] Dynamic subtest vcs1: SUCCESS (0.763s)
[168.177614] Starting dynamic subtest: vecs0
[168.930716] Dynamic subtest vecs0: SUCCESS (0.767s)
[168.945416] Starting dynamic subtest: ccs0
[169.699257] Dynamic subtest ccs0: SUCCESS (0.767s)
[169.701767] Subtest engines-persistence: SUCCESS (4.601s)
[169.800279] [034/142] (860s left) sysfs_defaults (readonly)
[169.862073] Starting subtest: readonly
[169.864554] Starting dynamic subtest: vecs0
[169.866974] Dynamic subtest vecs0: SUCCESS (0.001s)
[169.878198] Starting dynamic subtest: ccs0
[169.880186] Dynamic subtest ccs0: SUCCESS (0.001s)
[169.888565] Starting dynamic subtest: vcs0
[169.890529] Dynamic subtest vcs0: SUCCESS (0.000s)
[169.897792] Starting dynamic subtest: bcs0
[169.899764] Dynamic subtest bcs0: SUCCESS (0.000s)
[169.906399] Starting dynamic subtest: rcs0
[169.908329] Dynamic subtest rcs0: SUCCESS (0.000s)
[169.915106] Starting dynamic subtest: vcs1
[169.917431] Dynamic subtest vcs1: SUCCESS (0.000s)
[169.919665] Subtest readonly: SUCCESS (0.009s)
[169.970708] [035/142] (860s left) syncobj_timeline (invalid-single-wait-available-unsubmitted)
[170.026920] Starting subtest: invalid-single-wait-available-unsubmitted
[170.029650] Subtest invalid-single-wait-available-unsubmitted: SUCCESS (0.000s)
[170.094732] [036/142] (860s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[170.159847] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[170.162350] Starting dynamic subtest: pipe-A-default-mode
[171.370669] Dynamic subtest pipe-A-default-mode: SKIP (1.205s)
[171.375562] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.206s)
[171.501869] [037/142] (858s left) i915_query (query-topology-kernel-writes)
[171.548986] Starting subtest: query-topology-kernel-writes
[171.551179] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[171.602000] [038/142] (858s left) prime_vgem (basic-blt)
[171.692670] Starting subtest: basic-blt
[171.769591] Subtest basic-blt: FAIL (0.046s)
[171.850807] [039/142] (858s left) kms_psr (psr2_primary_render)
[171.936936] Starting subtest: psr2_primary_render
[173.747961] Subtest psr2_primary_render: SUCCESS (1.810s)
[174.660115] [040/142] (855s left) perf_pmu (init-busy)
[174.712980] Starting subtest: init-busy
[174.715246] Starting dynamic subtest: rcs0
[174.717607] Dynamic subtest rcs0: SUCCESS (0.002s)
[174.726449] Starting dynamic subtest: bcs0
[174.728908] Dynamic subtest bcs0: SUCCESS (0.001s)
[174.739944] Starting dynamic subtest: vcs0
[174.741838] Dynamic subtest vcs0: SUCCESS (0.002s)
[174.748936] Starting dynamic subtest: vcs1
[174.751212] Dynamic subtest vcs1: SUCCESS (0.001s)
[174.765975] Starting dynamic subtest: vecs0
[174.768367] Dynamic subtest vecs0: SUCCESS (0.001s)
[174.780145] Starting dynamic subtest: ccs0
[174.782253] Dynamic subtest ccs0: SUCCESS (0.001s)
[174.784804] Subtest init-busy: SUCCESS (0.015s)
[174.822275] [041/142] (855s left) kms_ccs (pipe-c-bad-pixel-format-yf_tiled_ccs)
[175.218002] Starting subtest: pipe-C-bad-pixel-format-yf_tiled_ccs
[175.223509] Subtest pipe-C-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[176.065791] [042/142] (854s left) gem_exec_schedule (lateslice)
[176.154622] Starting subtest: lateslice
[176.156620] Starting dynamic subtest: rcs0
[176.162289] Dynamic subtest rcs0: SUCCESS (0.016s)
[176.175020] Starting dynamic subtest: bcs0
[176.177336] Dynamic subtest bcs0: SUCCESS (0.013s)
[176.184922] Starting dynamic subtest: vcs0
[176.189052] Dynamic subtest vcs0: SUCCESS (0.012s)
[176.196574] Starting dynamic subtest: vcs1
[176.201210] Dynamic subtest vcs1: SUCCESS (0.012s)
[176.208817] Starting dynamic subtest: vecs0
[176.213435] Dynamic subtest vecs0: SUCCESS (0.012s)
[176.221100] Starting dynamic subtest: ccs0
[176.227197] Dynamic subtest ccs0: SUCCESS (0.013s)
[176.229503] Subtest lateslice: SUCCESS (0.082s)
[177.895850] [043/142] (852s left) kms_vblank (pipe-d-query-idle)
[177.973657] Starting subtest: pipe-D-query-idle
[180.880888] Subtest pipe-D-query-idle: SUCCESS (2.905s)
[181.815139] [044/142] (848s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[181.879060] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[181.978210] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[182.047612] [045/142] (848s left) gem_ctx_param (invalid-param-get)
[182.088145] Starting subtest: invalid-param-get
[182.090680] Subtest invalid-param-get: SUCCESS (0.000s)
[182.142512] [046/142] (848s left) api_intel_allocator (reloc-allocator)
[182.203929] Starting subtest: reloc-allocator
[182.206434] Starting dynamic subtest: basic
[182.208881] Dynamic subtest basic: SUCCESS (0.002s)
[182.223415] Starting dynamic subtest: parallel-one
[182.225796] Dynamic subtest parallel-one: SUCCESS (0.009s)
[182.237180] Starting dynamic subtest: print
[182.239596] Dynamic subtest print: SUCCESS (0.000s)
[182.248487] Starting dynamic subtest: reuse
[182.250771] Dynamic subtest reuse: SUCCESS (0.000s)
[182.258458] Starting dynamic subtest: fork-reopen-allocator
[182.260720] Dynamic subtest fork-reopen-allocator: SUCCESS (0.018s)
[182.262969] Subtest reloc-allocator: SUCCESS (0.031s)
[182.327211] [047/142] (848s left) gem_fence_thrash (bo-write-verify-threaded-none)
[182.384229] Starting subtest: bo-write-verify-threaded-none
[182.391217] Subtest bo-write-verify-threaded-none: SKIP (0.001s)
[182.414809] [048/142] (848s left) vc4/vc4_wait_seqno (bad-seqno-0ns)
[182.489347] Subtest bad-seqno-0ns: SKIP (0.000s)
[182.537382] [049/142] (847s left) vc4/vc4_perfmon (create-perfmon-invalid-events)
[182.610794] Subtest create-perfmon-invalid-events: SKIP (0.000s)
[182.660498] [050/142] (847s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[182.732095] Starting subtest: bo-too-small-due-to-tiling
[182.736712] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[182.815534] [051/142] (847s left) gem_eio (wait-immediate)
[183.016641] Starting subtest: wait-immediate
[183.337224] Subtest wait-immediate: SUCCESS (0.323s)
[184.863553] [052/142] (845s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[185.233672] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[191.080216] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SUCCESS (5.846s)
[192.249501] [053/142] (838s left) kms_color (ctm-red-to-blue)
[192.333547] Starting subtest: ctm-red-to-blue
[192.335967] Starting dynamic subtest: pipe-A
[193.076067] Dynamic subtest pipe-A: SUCCESS (0.743s)
[193.092017] Starting dynamic subtest: pipe-B
[194.598529] Dynamic subtest pipe-B: SUCCESS (1.521s)
[194.610878] Starting dynamic subtest: pipe-C
[196.033546] Dynamic subtest pipe-C: SUCCESS (1.434s)
[196.046040] Starting dynamic subtest: pipe-D
[197.453419] Dynamic subtest pipe-D: SUCCESS (1.418s)
[197.456392] Subtest ctm-red-to-blue: SUCCESS (5.120s)
[198.403852] [054/142] (832s left) gem_exec_alignment (single)
[198.467379] Starting subtest: single
[198.474366] Subtest single: SUCCESS (0.005s)
[198.564599] [055/142] (832s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[198.652829] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[198.656748] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[198.739742] [056/142] (831s left) gem_userptr_blits (sync-unmap-after-close)
[198.792200] Starting subtest: sync-unmap-after-close
[198.804557] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[198.906220] [057/142] (831s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[198.989690] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[198.994018] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[199.070957] [058/142] (831s left) kms_plane_scaling (planes-scaler-unity-scaling)
[199.135734] Starting subtest: planes-scaler-unity-scaling
[199.138098] Starting dynamic subtest: pipe-A-eDP-1
[199.212608] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.076s)
[199.229374] Starting dynamic subtest: pipe-B-eDP-1
[200.439396] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.223s)
[200.457640] Starting dynamic subtest: pipe-C-eDP-1
[201.644410] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s)
[201.662767] Starting dynamic subtest: pipe-D-eDP-1
[202.860277] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s)
[202.862738] Subtest planes-scaler-unity-scaling: SUCCESS (3.727s)
[204.093964] [059/142] (826s left) syncobj_wait (wait-for-submit-snapshot)
[204.129897] Starting subtest: wait-for-submit-snapshot
[204.210765] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[204.279888] [060/142] (826s left) v3d/v3d_submit_csd (bad-pad)
[204.387272] Subtest bad-pad: SKIP (0.000s)
[204.431986] [061/142] (826s left) gem_mmap_offset (basic-uaf)
[204.493873] Starting subtest: basic-uaf
[204.496345] Subtest basic-uaf: SUCCESS (0.001s)
[204.579602] [062/142] (826s left) perf (unprivileged-single-ctx-counters)
[204.679289] Starting subtest: unprivileged-single-ctx-counters
[204.683988] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[204.710527] [063/142] (826s left) gem_exec_balancer (sliced)
[204.763974] Starting subtest: sliced
[204.768632] Subtest sliced: SKIP (0.000s)
[205.022515] [064/142] (825s left) gem_exec_flush (basic-uc-pro-default)
[205.084998] Starting subtest: basic-uc-pro-default
[210.541059] Subtest basic-uc-pro-default: SUCCESS (5.463s)
[210.723313] [065/142] (820s left) kms_chamelium_hpd (hdmi-hpd-fast)
[211.084484] Subtest hdmi-hpd-fast: SKIP (0.000s)
[211.935294] [066/142] (818s left) syncobj_wait (single-wait-all-for-submit-submitted)
[211.995785] Starting subtest: single-wait-all-for-submit-submitted
[212.097814] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[212.169636] [067/142] (818s left) gem_tiled_blits (basic)
[212.235291] Subtest basic: SKIP (0.000s)
[212.266343] [068/142] (818s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[212.332466] Starting subtest: fbc-rgb101010-draw-render
[215.968965] Subtest fbc-rgb101010-draw-render: SUCCESS (3.643s)
[216.083755] [069/142] (814s left) kms_vblank (pipe-d-ts-continuation-idle)
[216.169714] Starting subtest: pipe-D-ts-continuation-idle
[217.753541] Subtest pipe-D-ts-continuation-idle: SUCCESS (1.583s)
[218.685604] [070/142] (812s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[218.739322] Starting subtest: multi-wait-all-for-submit-signaled
[218.742335] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[218.804869] [071/142] (812s left) kms_rotation_crc (bad-tiling)
[218.887347] Starting subtest: bad-tiling
[218.892097] Subtest bad-tiling: SKIP (0.001s)
[218.945184] [072/142] (812s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[219.361934] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[221.760364] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SUCCESS (2.396s)
[222.942881] [073/142] (808s left) syncobj_timeline (transfer-timeline-point)
[222.989642] Starting subtest: transfer-timeline-point
[222.991660] Subtest transfer-timeline-point: SUCCESS (0.000s)
[223.053697] [074/142] (808s left) kms_big_fb (linear-16bpp-rotate-90)
[223.140976] Starting subtest: linear-16bpp-rotate-90
[223.154601] Subtest linear-16bpp-rotate-90: SKIP (0.016s)
[223.250384] [075/142] (807s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[223.631324] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[223.637463] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[224.515825] [076/142] (806s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf_tiled_ccs)
[224.921102] Starting subtest: pipe-C-crc-sprite-planes-basic-yf_tiled_ccs
[224.927305] Subtest pipe-C-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.001s)
[225.751445] [077/142] (805s left) gem_exec_schedule (submit-late-slice)
[225.822105] Starting subtest: submit-late-slice
[225.824752] Starting dynamic subtest: rcs0
[225.827392] Dynamic subtest rcs0: SUCCESS (0.017s)
[225.834876] Starting dynamic subtest: bcs0
[225.850672] Dynamic subtest bcs0: SUCCESS (0.023s)
[225.859648] Starting dynamic subtest: vcs0
[225.867664] Dynamic subtest vcs0: SUCCESS (0.017s)
[225.879367] Starting dynamic subtest: vcs1
[225.884584] Dynamic subtest vcs1: SUCCESS (0.016s)
[225.893646] Starting dynamic subtest: vecs0
[225.899050] Dynamic subtest vecs0: SUCCESS (0.013s)
[225.907485] Starting dynamic subtest: ccs0
[225.912181] Dynamic subtest ccs0: SUCCESS (0.014s)
[225.914387] Subtest submit-late-slice: SUCCESS (0.103s)
[227.904484] [078/142] (803s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[228.031780] Starting subtest: flip-vs-cursor-busy-crc-legacy
[228.928116] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.897s)
[229.807346] [079/142] (801s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[230.242093] Starting subtest: pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[230.247434] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[231.097430] [080/142] (800s left) drm_buddy (drm_buddy)
[231.155558] Starting subtest: drm_buddy
[231.189920] Starting dynamic subtest: drm_buddy-drm_test_buddy_alloc_limit
[231.192510] Dynamic subtest drm_buddy-drm_test_buddy_alloc_limit: SUCCESS (0.000s)
[231.202026] Starting dynamic subtest: drm_buddy-drm_test_buddy_alloc_range
[231.204444] Dynamic subtest drm_buddy-drm_test_buddy_alloc_range: SUCCESS (0.000s)
[231.217964] Starting dynamic subtest: drm_buddy-drm_test_buddy_alloc_optimistic
[231.220467] Dynamic subtest drm_buddy-drm_test_buddy_alloc_optimistic: SUCCESS (0.000s)
[231.230620] Starting dynamic subtest: drm_buddy-drm_test_buddy_alloc_pessimistic
[231.232969] Dynamic subtest drm_buddy-drm_test_buddy_alloc_pessimistic: SUCCESS (0.000s)
[231.585703] Starting dynamic subtest: drm_buddy-drm_test_buddy_alloc_smoke
[231.589196] Dynamic subtest drm_buddy-drm_test_buddy_alloc_smoke: SUCCESS (0.000s)
[231.599385] Starting dynamic subtest: drm_buddy-drm_test_buddy_alloc_pathological
[231.601644] Dynamic subtest drm_buddy-drm_test_buddy_alloc_pathological: SUCCESS (0.000s)
[231.603928] Subtest drm_buddy: SUCCESS (0.422s)
[231.719984] [081/142] (799s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[231.813219] Starting subtest: 4-tiled-32bpp-rotate-90
[231.845254] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.033s)
[231.940983] [082/142] (799s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_ccs)
[232.312642] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_ccs
[232.317957] Subtest pipe-A-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.000s)
[233.183337] [083/142] (798s left) gem_pxp (fail-invalid-protected-context)
[235.775905] Subtest fail-invalid-protected-context: SKIP (0.000s)
[235.848414] [084/142] (795s left) gem_exec_whisper (basic-fds-priority-all)
[235.907280] Starting subtest: basic-fds-priority-all
[269.789952] Subtest basic-fds-priority-all: SUCCESS (33.879s)
[269.972090] [085/142] (761s left) gem_compute (compute-square)
[270.010574] Starting subtest: compute-square
[270.015531] Subtest compute-square: SKIP (0.000s)
[270.075814] [086/142] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[270.148510] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[270.152991] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[270.237935] [087/142] (761s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[270.427392] Starting subtest: cursor-rapid-movement-512x512
[270.432106] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[270.554965] [088/142] (760s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[270.633617] Starting subtest: disable-crc-after-crtc
[270.636075] Starting dynamic subtest: pipe-A-eDP-1
[272.422720] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.788s)
[272.447377] Starting dynamic subtest: pipe-B-eDP-1
[274.950613] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.525s)
[274.964873] Starting dynamic subtest: pipe-C-eDP-1
[277.444971] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.489s)
[277.459970] Starting dynamic subtest: pipe-D-eDP-1
[279.918012] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.471s)
[279.920584] Subtest disable-crc-after-crtc: SUCCESS (9.284s)
[280.838792] [089/142] (750s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[281.224993] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc
[281.227873] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.000s)
[282.116703] [090/142] (749s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[282.197028] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[283.286128] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.090s)
[283.422126] [091/142] (748s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[283.502150] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[283.506213] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[283.594569] [092/142] (748s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[283.663596] Starting subtest: 2x-plain-flip-ts-check-interruptible
[283.681657] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.015s)
[283.750779] [093/142] (747s left) gem_exec_params (no-bsd)
[283.800715] Starting subtest: no-bsd
[283.802583] Subtest no-bsd: SUCCESS (0.001s)
[285.858008] [094/142] (745s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[286.280022] Starting subtest: pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[286.283040] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.000s)
[287.116741] [095/142] (744s left) kms_cursor_crc (cursor-onscreen-128x128)
[287.238881] Starting subtest: cursor-onscreen-128x128
[287.244196] Starting dynamic subtest: pipe-A-eDP-1
[289.375378] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.131s)
[289.409679] Starting dynamic subtest: pipe-D-eDP-1
[292.251988] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.855s)
[292.254516] Subtest cursor-onscreen-128x128: SUCCESS (5.013s)
[293.142607] [096/142] (738s left) syncobj_wait (multi-wait-all-submitted-signaled)
[293.198167] Starting subtest: multi-wait-all-submitted-signaled
[293.307282] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.109s)
[293.378001] [097/142] (738s left) gem_lmem_swapping (smem-oom)
[293.436277] Subtest smem-oom: SKIP (0.000s)
[293.471331] [098/142] (738s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[293.555978] Starting subtest: basic-busy-flip-before-cursor-varying-size
[293.561137] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[293.681922] [099/142] (738s left) kms_vblank (pipe-a-query-forked)
[293.760837] Starting subtest: pipe-A-query-forked
[295.572296] Subtest pipe-A-query-forked: SUCCESS (1.813s)
[296.517875] [100/142] (735s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[296.611442] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[296.615770] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[296.698354] [101/142] (735s left) kms_flip (nonblocking-read)
[296.761970] Starting subtest: nonblocking-read
[296.763923] Subtest nonblocking-read: SUCCESS (0.000s)
[296.862625] [102/142] (735s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite)
[296.939369] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite
[299.872789] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (2.937s)
[299.999314] [103/142] (731s left) kms_lease (lease-unleased-connector)
[300.088481] Starting subtest: lease-unleased-connector
[300.090950] Starting dynamic subtest: pipe-A-eDP-1
[300.108734] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.016s)
[300.130783] Starting dynamic subtest: pipe-B-eDP-1
[300.132613] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[300.144617] Starting dynamic subtest: pipe-C-eDP-1
[300.146452] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[300.158120] Starting dynamic subtest: pipe-D-eDP-1
[300.160037] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[300.162006] Subtest lease-unleased-connector: SUCCESS (0.048s)
[300.239665] [104/142] (731s left) i915_pm_rc6_residency (media-rc6-accuracy)
[301.537626] Subtest media-rc6-accuracy: SKIP (0.000s)
[301.604286] [105/142] (730s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[301.666581] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[306.509766] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.849s)
[306.624446] [106/142] (725s left) gem_exec_balancer (parallel)
[306.867515] Starting subtest: parallel
[307.595584] Subtest parallel: SUCCESS (0.728s)
[308.898795] [107/142] (723s left) syncobj_wait (invalid-wait-zero-handles)
[308.941527] Starting subtest: invalid-wait-zero-handles
[308.943899] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[309.008329] [108/142] (723s left) kms_ccs (pipe-a-bad-pixel-format-yf_tiled_ccs)
[309.068975] Starting subtest: pipe-A-bad-pixel-format-yf_tiled_ccs
[309.073708] Subtest pipe-A-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[310.263920] [109/142] (721s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[310.359231] Starting subtest: x-tiled-8bpp-rotate-180
[311.500216] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.144s)
[311.615387] [110/142] (720s left) kms_vblank (pipe-c-ts-continuation-idle-hang)
[311.683394] Starting subtest: pipe-C-ts-continuation-idle-hang
[326.672367] Subtest pipe-C-ts-continuation-idle-hang: SUCCESS (14.989s)
[327.620127] [111/142] (704s left) kms_dsc (dsc-with-bpc)
[327.682197] Starting subtest: dsc-with-bpc
[327.686181] Subtest dsc-with-bpc: SKIP (0.001s)
[327.742589] [112/142] (704s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[327.793930] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[327.891368] [113/142] (704s left) v3d/v3d_get_param (get-bad-param)
[327.955452] Subtest get-bad-param: SKIP (0.000s)
[328.004484] [114/142] (704s left) api_intel_bb (offset-control)
[328.056792] Starting subtest: offset-control
[328.059357] Subtest offset-control: SUCCESS (0.004s)
[328.155694] [115/142] (704s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_mc_ccs)
[328.549495] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs
[328.551987] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs: SUCCESS (0.001s)
[329.478752] [116/142] (702s left) gem_pread (exhaustion)
[329.536537] Subtest exhaustion: SKIP (0.000s)
[329.594874] [117/142] (702s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs)
[329.950485] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs
[329.955477] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[330.873699] [118/142] (701s left) kms_plane (pixel-format)
[330.937119] Starting subtest: pixel-format
[330.939192] Starting dynamic subtest: pipe-A-planes
[339.819434] Dynamic subtest pipe-A-planes: SUCCESS (8.880s)
[339.836998] Starting dynamic subtest: pipe-B-planes
[349.294488] Dynamic subtest pipe-B-planes: SUCCESS (9.474s)
[349.297948] Subtest pixel-format: SUCCESS (18.358s)
[350.200761] [119/142] (682s left) i915_pm_rpm (system-suspend)
[352.046737] Starting subtest: system-suspend
[374.550651] Subtest system-suspend: SUCCESS (7.967s)
[375.345543] [120/142] (671s left) gem_exec_schedule (semaphore-user)
[375.413341] Starting subtest: semaphore-user
[375.419719] Subtest semaphore-user: SUCCESS (0.012s)
[377.393309] [121/142] (669s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[377.434561] Starting subtest: saturated-hostile-nopreempt
[377.436886] Starting dynamic subtest: rcs0
[377.479905] Dynamic subtest rcs0: SKIP (0.042s)
[377.496338] Starting dynamic subtest: bcs0
[377.503604] Dynamic subtest bcs0: SKIP (0.021s)
[377.516927] Starting dynamic subtest: vcs0
[377.527977] Dynamic subtest vcs0: SKIP (0.024s)
[377.545683] Starting dynamic subtest: vcs1
[377.550370] Dynamic subtest vcs1: SKIP (0.017s)
[377.563800] Starting dynamic subtest: vecs0
[377.568336] Dynamic subtest vecs0: SKIP (0.016s)
[377.578832] Starting dynamic subtest: ccs0
[377.585969] Dynamic subtest ccs0: SKIP (0.022s)
[377.590310] Subtest saturated-hostile-nopreempt: SKIP (0.149s)
[377.658439] [122/142] (669s left) gem_userptr_blits (userfault)
[377.722634] Starting subtest: userfault
[377.724607] Subtest userfault: SUCCESS (0.004s)
[377.861868] [123/142] (669s left) kms_psr (dpms)
[377.929502] Starting subtest: dpms
[381.038041] Subtest dpms: SUCCESS (3.106s)
[381.967688] [124/142] (665s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_rc_ccs)
[382.362046] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs
[383.186708] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs: SUCCESS (0.823s)
[384.392031] [125/142] (662s left) gen9_exec_parse (secure-batches)
[384.431048] Subtest secure-batches: SKIP (0.000s)
[384.461415] [126/142] (662s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[384.543793] Starting subtest: 2x-flip-vs-modeset-vs-hang
[384.562006] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.020s)
[384.637912] [127/142] (662s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[384.697361] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[384.699773] Starting dynamic subtest: pipe-A-eDP-1
[385.394488] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[385.411748] Starting dynamic subtest: pipe-B-eDP-1
[387.179426] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.782s)
[387.191817] Starting dynamic subtest: pipe-C-eDP-1
[389.017048] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.836s)
[389.036948] Starting dynamic subtest: pipe-D-eDP-1
[390.816508] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.796s)
[390.818947] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (6.121s)
[392.077940] [128/142] (655s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[392.158303] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[392.162313] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[392.245576] [129/142] (654s left) gem_exec_fair (basic-none-solo)
[392.318858] Subtest basic-none-solo: SKIP (0.000s)
[392.373609] [130/142] (654s left) gem_exec_params (invalid-ring)
[392.421545] Starting subtest: invalid-ring
[392.424060] Subtest invalid-ring: SUCCESS (0.000s)
[392.512991] [131/142] (654s left) kms_chamelium_audio (hdmi-audio)
[392.900160] Subtest hdmi-audio: SKIP (0.000s)
[393.770786] [132/142] (653s left) i915_query (engine-info-invalid)
[393.818902] Starting subtest: engine-info-invalid
[393.821331] Subtest engine-info-invalid: SUCCESS (0.000s)
[393.877163] [133/142] (653s left) gem_ctx_create (basic-files)
[393.939956] Starting subtest: basic-files
[395.952266] Subtest basic-files: SUCCESS (2.012s)
[397.416608] [134/142] (649s left) dumb_buffer (map-valid)
[397.461974] Starting subtest: map-valid
[397.464525] Subtest map-valid: SUCCESS (0.000s)
[397.555031] [135/142] (649s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[397.619334] Starting subtest: psr-modesetfrombusy
[401.898497] Subtest psr-modesetfrombusy: SUCCESS (4.285s)
[401.998494] [136/142] (645s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[402.073276] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[402.078396] Starting dynamic subtest: A-eDP1
[405.874634] Dynamic subtest A-eDP1: SUCCESS (3.794s)
[405.890736] Starting dynamic subtest: B-eDP1
[409.330303] Dynamic subtest B-eDP1: SUCCESS (3.456s)
[409.344580] Starting dynamic subtest: C-eDP1
[412.789357] Dynamic subtest C-eDP1: SUCCESS (3.456s)
[412.808686] Starting dynamic subtest: D-eDP1
[416.244383] Dynamic subtest D-eDP1: SUCCESS (3.455s)
[416.249582] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (14.176s)
[417.168741] [137/142] (630s left) v3d/v3d_submit_cl (simple-flush-cache)
[417.241623] Subtest simple-flush-cache: SKIP (0.000s)
[417.295047] [138/142] (630s left) kms_busy (extended-modeset-hang-oldfb)
[417.375016] Starting subtest: extended-modeset-hang-oldfb
[417.377152] Starting dynamic subtest: pipe-A
[432.310639] Dynamic subtest pipe-A: SUCCESS (14.931s)
[432.331184] Starting dynamic subtest: pipe-D
[457.345210] Dynamic subtest pipe-D: SUCCESS (25.029s)
[457.347825] Subtest extended-modeset-hang-oldfb: SUCCESS (39.970s)
[458.257767] [139/142] (589s left) kms_flip (basic-flip-vs-wf_vblank)
[458.317406] Starting subtest: basic-flip-vs-wf_vblank
[458.322729] Starting dynamic subtest: A-eDP1
[460.307254] Dynamic subtest A-eDP1: SUCCESS (1.985s)
[460.326084] Starting dynamic subtest: B-eDP1
[462.356223] Dynamic subtest B-eDP1: SUCCESS (2.046s)
[462.374627] Starting dynamic subtest: C-eDP1
[464.392314] Dynamic subtest C-eDP1: SUCCESS (2.034s)
[464.410404] Starting dynamic subtest: D-eDP1
[466.378191] Dynamic subtest D-eDP1: SUCCESS (1.984s)
[466.384715] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.072s)
[467.663577] [140/142] (579s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[467.739813] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[467.743886] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[467.824748] [141/142] (579s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[467.889100] Starting subtest: yf-tiled-ccs-to-y-tiled
[467.893818] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[468.072272] [142/142] (579s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[468.151305] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[468.156048] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[468.237744] Closing watchdogs
Done.