[56.290472] Initializing watchdogs
[56.290669]   /dev/watchdog0
[56.304901] [001/142] (960s left) prime_mmap (test_errors)
[56.499858] Starting subtest: test_errors
[56.503429] Starting dynamic subtest: test_errors-smem
[56.507613] Dynamic subtest test_errors-smem: SUCCESS (0.022s)
[56.511217] Subtest test_errors: SUCCESS (0.022s)
[56.591977] [002/142] (960s left) kms_flip (plain-flip-ts-check-interruptible)
[57.118486] Starting subtest: plain-flip-ts-check-interruptible
[57.184389] Starting dynamic subtest: A-HDMI-A1
[64.304713] Dynamic subtest A-HDMI-A1: SUCCESS (7.359s)
[64.318370] Starting dynamic subtest: B-HDMI-A1
[69.980087] Dynamic subtest B-HDMI-A1: SUCCESS (5.671s)
[69.991745] Starting dynamic subtest: C-HDMI-A1
[75.639998] Dynamic subtest C-HDMI-A1: SUCCESS (5.659s)
[75.652039] Starting dynamic subtest: A-HDMI-A2
[81.327926] Dynamic subtest A-HDMI-A2: SUCCESS (5.684s)
[81.340227] Starting dynamic subtest: B-HDMI-A2
[86.991751] Dynamic subtest B-HDMI-A2: SUCCESS (5.668s)
[87.005052] Starting dynamic subtest: C-HDMI-A2
[92.657176] Dynamic subtest C-HDMI-A2: SUCCESS (5.664s)
[92.660249] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.716s)
[93.099259] [003/142] (923s left) kms_addfb_basic (small-bo)
[93.342840] Starting subtest: small-bo
[93.346158] Subtest small-bo: SUCCESS (0.001s)
[93.431588] [004/142] (923s left) v3d/v3d_wait_bo (bad-bo)
[93.646648] Subtest bad-bo: SKIP (0.000s)
[93.710305] [005/142] (923s left) gem_exec_schedule (preempt-self)
[93.914926] Starting subtest: preempt-self
[93.918333] Starting dynamic subtest: rcs0
[93.942039] Dynamic subtest rcs0: SUCCESS (0.039s)
[93.961592] Starting dynamic subtest: bcs0
[93.977996] Dynamic subtest bcs0: SUCCESS (0.035s)
[93.993750] Starting dynamic subtest: vcs0
[94.012340] Dynamic subtest vcs0: SUCCESS (0.033s)
[94.024829] Starting dynamic subtest: vecs0
[94.044355] Dynamic subtest vecs0: SUCCESS (0.031s)
[94.049509] Subtest preempt-self: SUCCESS (0.142s)
[94.364968] [006/142] (922s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[94.630091] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[97.011466] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.392s)
[97.229715] [007/142] (919s left) prime_vgem (fence-write-hang)
[97.499291] Subtest fence-write-hang: SKIP (0.000s)
[97.592567] [008/142] (919s left) gem_sync (basic-all)
[97.782348] Starting subtest: basic-all
[99.838923] Subtest basic-all: SUCCESS (2.065s)
[100.028900] [009/142] (917s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_mc_ccs)
[100.773241] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs
[100.779817] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[101.094433] [010/142] (915s left) syncobj_timeline (single-wait-available-submitted)
[101.254804] Starting subtest: single-wait-available-submitted
[101.258409] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[101.337634] [011/142] (915s left) gem_ctx_persistence (legacy-engines-hostile)
[101.505114] Starting subtest: legacy-engines-hostile
[101.508675] Starting dynamic subtest: render
[101.585070] Dynamic subtest render: SUCCESS (0.081s)
[101.597518] Starting dynamic subtest: bsd
[101.663358] Dynamic subtest bsd: SUCCESS (0.073s)
[101.677539] Starting dynamic subtest: blt
[101.743552] Dynamic subtest blt: SUCCESS (0.077s)
[101.755577] Starting dynamic subtest: vebox
[101.811609] Dynamic subtest vebox: SUCCESS (0.071s)
[101.814964] Subtest legacy-engines-hostile: SUCCESS (0.308s)
[101.893586] [012/142] (915s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[102.148443] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[102.154796] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[102.226256] [013/142] (914s left) i915_pm_rpm (gem-idle)
[104.234293] Starting subtest: gem-idle
[109.784650] Subtest gem-idle: SUCCESS (5.556s)
[110.113630] [014/142] (907s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[110.357551] Starting subtest: disable-crc-after-crtc
[110.361079] Starting dynamic subtest: pipe-A-HDMI-A-1
[111.473212] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.112s)
[111.502958] Starting dynamic subtest: pipe-B-HDMI-A-2
[112.487475] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.984s)
[112.510708] Starting dynamic subtest: pipe-C-HDMI-A-1
[113.681503] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.185s)
[113.684826] Subtest disable-crc-after-crtc: SUCCESS (3.322s)
[113.926149] [015/142] (903s left) i915_query (test-query-geometry-subslices)
[114.082479] Starting subtest: test-query-geometry-subslices
[114.089062] Subtest test-query-geometry-subslices: SKIP (0.000s)
[114.159685] [016/142] (903s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[114.394617] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[114.397928] Starting dynamic subtest: pipe-A-valid-mode
[114.796917] Dynamic subtest pipe-A-valid-mode: SKIP (0.397s)
[114.805403] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.400s)
[115.036359] [017/142] (902s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[115.299270] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[115.305476] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[115.379875] [018/142] (901s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-25)
[115.620547] Starting subtest: plane-downscale-with-modifiers-factor-0-25
[115.623899] Starting dynamic subtest: pipe-A-HDMI-A-1
[115.700845] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.072s)
[115.719297] Starting dynamic subtest: pipe-B-HDMI-A-1
[115.784119] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.080s)
[115.800806] Starting dynamic subtest: pipe-C-HDMI-A-1
[115.924811] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.137s)
[115.931504] Subtest plane-downscale-with-modifiers-factor-0-25: SKIP (0.301s)
[116.013253] [019/142] (901s left) gem_exec_whisper (basic-queues-priority)
[116.191709] Starting subtest: basic-queues-priority
[124.896556] Subtest basic-queues-priority: SUCCESS (8.703s)
[125.086993] [020/142] (892s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs)
[125.875458] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[126.128891] [021/142] (891s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[126.287963] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[126.391183] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[126.478695] [022/142] (890s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs)
[127.177167] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs
[127.183968] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[127.510417] [023/142] (890s left) gem_exec_schedule (u-semaphore-resolve)
[127.697361] Starting subtest: u-semaphore-resolve
[127.739890] Subtest u-semaphore-resolve: SUCCESS (0.045s)
[128.071622] [024/142] (889s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[128.328042] Starting subtest: fbc-farfromfence-mmap-gtt
[130.995919] Subtest fbc-farfromfence-mmap-gtt: SUCCESS (2.674s)
[131.191086] [025/142] (886s left) gem_exec_flush (basic-uc-ro-default)
[131.370206] Starting subtest: basic-uc-ro-default
[136.802931] Subtest basic-uc-ro-default: SUCCESS (5.432s)
[137.008364] [026/142] (880s left) kms_cursor_crc (cursor-random-512x512)
[137.257773] Starting subtest: cursor-random-512x512
[137.264963] Subtest cursor-random-512x512: SKIP (0.004s)
[137.357628] [027/142] (880s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_mc_ccs)
[138.117188] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs
[138.123687] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[138.428051] [028/142] (879s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[138.689576] Starting subtest: psr-shrfb-scaledprimary
[138.695310] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[138.778273] [029/142] (878s left) kms_vblank (pipe-a-ts-continuation-modeset-hang)
[139.019475] Starting subtest: pipe-A-ts-continuation-modeset-hang
[153.472356] Subtest pipe-A-ts-continuation-modeset-hang: SUCCESS (14.454s)
[153.735966] [030/142] (864s left) kms_lease (implicit-plane-lease)
[153.988159] Starting subtest: implicit-plane-lease
[154.001035] Subtest implicit-plane-lease: SUCCESS (0.021s)
[154.097352] [031/142] (863s left) kms_busy (basic)
[154.351714] Starting subtest: basic
[154.354989] Starting dynamic subtest: flip
[155.295492] Dynamic subtest flip: SUCCESS (0.938s)
[155.318895] Starting dynamic subtest: modeset
[156.623553] Dynamic subtest modeset: SUCCESS (1.324s)
[156.626750] Subtest basic: SUCCESS (2.275s)
[156.933779] [032/142] (860s left) kms_properties (get_properties-sanity-atomic)
[157.188385] Starting subtest: get_properties-sanity-atomic
[157.195762] Subtest get_properties-sanity-atomic: SUCCESS (0.009s)
[157.282953] [033/142] (860s left) kms_vblank (pipe-a-query-forked-hang)
[157.517164] Starting subtest: pipe-A-query-forked-hang
[171.511277] Subtest pipe-A-query-forked-hang: SUCCESS (13.991s)
[171.749157] [034/142] (846s left) gem_exec_reloc (basic-gtt-active)
[171.917208] Starting subtest: basic-gtt-active
[172.045214] Subtest basic-gtt-active: SUCCESS (0.128s)
[172.226958] [035/142] (845s left) gem_exec_whisper (basic-sync-all)
[172.402566] Starting subtest: basic-sync-all
[183.303022] Subtest basic-sync-all: SUCCESS (10.898s)
[183.499927] [036/142] (834s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[183.763374] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[183.769751] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[183.847863] [037/142] (834s left) kms_cursor_edge_walk (128x128-top-bottom)
[184.092232] Starting subtest: 128x128-top-bottom
[184.095554] Starting dynamic subtest: pipe-A-HDMI-A-1
[188.120665] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.023s)
[188.148702] Starting dynamic subtest: pipe-C-HDMI-A-1
[191.622812] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.490s)
[191.627657] Subtest 128x128-top-bottom: SUCCESS (7.529s)
[191.842830] [038/142] (826s left) kms_atomic_transition (plane-all-transition-fencing)
[192.094168] Starting subtest: plane-all-transition-fencing
[192.097194] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.085309] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.988s)
[197.429279] Starting dynamic subtest: pipe-A-HDMI-A-2
[202.237997] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.907s)
[202.514294] Starting dynamic subtest: pipe-B-HDMI-A-1
[208.071219] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.565s)
[208.415865] Starting dynamic subtest: pipe-B-HDMI-A-2
[213.453967] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (5.127s)
[213.689725] Subtest plane-all-transition-fencing: SUCCESS (21.597s)
[214.005808] [039/142] (804s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[214.193880] Starting subtest: multi-wait-for-submit-available-submitted
[214.197562] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.002s)
[214.281039] [040/142] (803s left) gem_render_copy (yf-tiled)
[214.727529] Starting subtest: yf-tiled
[214.792544] Starting dynamic subtest: smem
[214.954634] Dynamic subtest smem: SUCCESS (0.335s)
[215.020138] Subtest yf-tiled: SUCCESS (0.340s)
[215.381319] [041/142] (803s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[216.355736] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[216.491470] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[217.162862] [042/142] (801s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[217.627543] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[220.317631] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (2.698s)
[220.558401] [043/142] (798s left) syncobj_wait (wait-all-for-submit-complex)
[220.723117] Starting subtest: wait-all-for-submit-complex
[220.934838] Subtest wait-all-for-submit-complex: SUCCESS (0.215s)
[221.023759] [044/142] (797s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[221.714098] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[221.920489] [045/142] (796s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[222.078570] Starting subtest: invalid-multi-wait-unsubmitted
[222.081651] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[222.158610] [046/142] (796s left) syncobj_basic (bad-pad-fd-to-handle)
[222.318817] Starting subtest: bad-pad-fd-to-handle
[222.322059] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[222.409729] [047/142] (796s left) gem_ringfill (legacy-basic)
[222.819551] Starting subtest: legacy-basic
[222.822952] Starting dynamic subtest: default
[222.839751] Dynamic subtest default: SUCCESS (0.019s)
[222.859779] Starting dynamic subtest: render
[222.874118] Dynamic subtest render: SUCCESS (0.030s)
[222.903644] Starting dynamic subtest: bsd
[222.907265] Dynamic subtest bsd: SUCCESS (0.024s)
[222.934970] Starting dynamic subtest: bsd1
[222.938938] Dynamic subtest bsd1: SUCCESS (0.021s)
[222.965178] Starting dynamic subtest: blt
[222.968404] Dynamic subtest blt: SUCCESS (0.025s)
[222.991454] Starting dynamic subtest: vebox
[222.994873] Dynamic subtest vebox: SUCCESS (0.022s)
[222.998244] Subtest legacy-basic: SUCCESS (0.160s)
[223.072276] [048/142] (795s left) gem_ctx_persistence (many-contexts)
[223.237358] Starting subtest: many-contexts
[255.976574] Subtest many-contexts: SUCCESS (32.738s)
[256.060669] [049/142] (762s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[256.699700] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[256.706190] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s)
[257.086048] [050/142] (761s left) v3d/v3d_perfmon (destroy-invalid-perfmon)
[257.297665] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[257.369321] [051/142] (761s left) vc4/vc4_wait_bo (bad-pad)
[257.587122] Subtest bad-pad: SKIP (0.000s)
[257.652462] [052/142] (761s left) kms_writeback (writeback-check-output)
[257.976232] Subtest writeback-check-output: SKIP (0.000s)
[258.033133] [053/142] (761s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[258.288438] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[259.928824] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.639s)
[260.187878] [054/142] (758s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[261.025341] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[261.036441] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.008s)
[261.341453] [055/142] (757s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[261.622189] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[264.288608] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.675s)
[264.493955] [056/142] (754s left) gem_eio (in-flight-contexts-immediate)
[264.682594] Starting subtest: in-flight-contexts-immediate
[276.612439] Subtest in-flight-contexts-immediate: SUCCESS (11.920s)
[276.792751] [057/142] (742s left) gem_caching (writes)
[276.954499] Starting subtest: writes
[290.347927] Subtest writes: SUCCESS (13.394s)
[290.444123] [058/142] (728s left) kms_content_protection (dp-mst-type-1)
[290.890484] Starting subtest: dp-mst-type-1
[291.021589] Subtest dp-mst-type-1: SKIP (0.001s)
[291.251198] [059/142] (728s left) gem_mmap_wc (write-wc-read-gtt)
[291.773963] Starting subtest: write-wc-read-gtt
[292.119505] Subtest write-wc-read-gtt: SUCCESS (0.497s)
[292.211475] [060/142] (727s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[292.370517] Starting subtest: write-cpu-read-wc-unflushed
[292.515863] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.153s)
[292.611407] [061/142] (726s left) kms_vblank (pipe-a-accuracy-idle)
[292.854623] Starting subtest: pipe-A-accuracy-idle
[298.020294] Subtest pipe-A-accuracy-idle: SUCCESS (5.164s)
[298.322731] [062/142] (721s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[298.599434] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[298.605898] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[298.688476] [063/142] (720s left) kms_chamelium_edid (dp-edid-resolution-list)
[299.384082] Subtest dp-edid-resolution-list: SKIP (0.000s)
[299.641130] [064/142] (719s left) gem_exec_reloc (basic-cpu-wc-active)
[299.818996] Starting subtest: basic-cpu-wc-active
[299.953037] Subtest basic-cpu-wc-active: SUCCESS (0.134s)
[300.143332] [065/142] (719s left) syncobj_wait (wait-any-snapshot)
[300.304393] Starting subtest: wait-any-snapshot
[300.386992] Subtest wait-any-snapshot: SUCCESS (0.082s)
[300.479169] [066/142] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[300.756215] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[300.762686] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[300.846561] [067/142] (718s left) kms_vblank (pipe-b-wait-busy-hang)
[301.095408] Starting subtest: pipe-B-wait-busy-hang
[315.539910] Subtest pipe-B-wait-busy-hang: SUCCESS (14.440s)
[315.842713] [068/142] (703s left) syncobj_timeline (invalid-wait-zero-handles)
[316.034615] Starting subtest: invalid-wait-zero-handles
[316.043475] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[316.203510] [069/142] (703s left) v3d/v3d_job_submission (threaded-job-submission)
[316.674751] Subtest threaded-job-submission: SKIP (0.000s)
[316.778071] [070/142] (703s left) syncobj_wait (invalid-reset-illegal-handle)
[317.005153] Starting subtest: invalid-reset-illegal-handle
[317.008291] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[317.092851] [071/142] (702s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[317.366969] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[317.371572] Starting dynamic subtest: pipe-A-valid-mode
[318.504803] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.133s)
[318.508540] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (1.139s)
[318.774658] [072/142] (701s left) gem_exec_fair (basic-pace)
[319.204933] Starting subtest: basic-pace
[319.209136] Starting dynamic subtest: rcs0
[323.995588] Dynamic subtest rcs0: SUCCESS (4.804s)
[324.016458] Starting dynamic subtest: bcs0
[324.022908] Dynamic subtest bcs0: SKIP (0.008s)
[324.039295] Starting dynamic subtest: vcs0
[328.753551] Dynamic subtest vcs0: SUCCESS (4.744s)
[328.774150] Starting dynamic subtest: vecs0
[333.525431] Dynamic subtest vecs0: SUCCESS (4.769s)
[333.529090] Subtest basic-pace: SUCCESS (14.336s)
[333.737285] [073/142] (686s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf)
[333.905957] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[333.951248] [074/142] (686s left) kms_atomic (test-only)
[334.295377] Starting subtest: test-only
[335.587707] Subtest test-only: SUCCESS (1.291s)
[335.921585] [075/142] (684s left) kms_psr2_su (page_flip-xrgb8888)
[336.085328] Subtest page_flip-XRGB8888: SKIP (0.000s)
[336.139547] [076/142] (684s left) i915_pm_backlight (basic-brightness)
[336.389422] Subtest basic-brightness: SKIP (0.000s)
[336.446420] [077/142] (683s left) kms_plane (pixel-format)
[336.697243] Starting subtest: pixel-format
[336.700575] Starting dynamic subtest: pipe-A-planes
[352.594176] Dynamic subtest pipe-A-planes: SUCCESS (15.781s)
[352.658780] Starting dynamic subtest: pipe-B-planes
[367.968821] Dynamic subtest pipe-B-planes: SUCCESS (15.358s)
[368.037346] Subtest pixel-format: SUCCESS (31.157s)
[368.346884] [078/142] (652s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[368.990651] Starting subtest: writes-after-reads-uncached
[387.869920] Subtest writes-after-reads-uncached: SUCCESS (19.035s)
[387.982215] [079/142] (632s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[388.643518] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[388.775079] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[389.006292] [080/142] (631s left) gem_create (busy-create)
[389.609631] Starting subtest: busy-create
[389.613913] Starting dynamic subtest: smem0
[421.618769] Dynamic subtest smem0: SUCCESS (32.249s)
[421.622360] Subtest busy-create: SUCCESS (32.252s)
[421.834624] [081/142] (598s left) kms_setmode (clone-exclusive-crtc)
[421.998842] Starting subtest: clone-exclusive-crtc
[422.535044] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[422.888695] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.349s)
[423.420347] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[423.714382] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (0.306s)
[424.200433] Subtest clone-exclusive-crtc: SUCCESS (2.189s)
[424.469520] [082/142] (596s left) gem_pxp (create-regular-buffer)
[427.152171] Subtest create-regular-buffer: SKIP (0.000s)
[427.240517] [083/142] (593s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[427.511422] Starting subtest: fbc-modesetfrombusy
[429.000903] Subtest fbc-modesetfrombusy: SUCCESS (1.494s)
[429.206107] [084/142] (591s left) gem_cs_tlb (engines)
[429.374405] Starting subtest: engines
[429.377643] Starting dynamic subtest: rcs0
[431.542980] Dynamic subtest rcs0: SUCCESS (2.163s)
[431.559142] Starting dynamic subtest: bcs0
[433.710994] Dynamic subtest bcs0: SUCCESS (2.164s)
[433.733602] Starting dynamic subtest: vcs0
[435.873277] Dynamic subtest vcs0: SUCCESS (2.159s)
[435.894418] Starting dynamic subtest: vecs0
[438.033535] Dynamic subtest vecs0: SUCCESS (2.160s)
[438.036862] Subtest engines: SUCCESS (8.655s)
[438.124065] [085/142] (582s left) kms_rotation_crc (primary-rotation-180)
[438.367126] Starting subtest: primary-rotation-180
[449.751288] Subtest primary-rotation-180: SUCCESS (11.383s)
[449.951601] [086/142] (570s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[450.228975] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[450.235774] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[450.318696] [087/142] (570s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[450.594898] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[450.600995] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[450.685613] [088/142] (570s left) gem_render_copy (y-tiled-ccs-to-linear)
[450.863272] Starting subtest: y-tiled-ccs-to-linear
[450.866620] Starting dynamic subtest: smem
[451.078894] Dynamic subtest smem: SUCCESS (0.210s)
[451.082378] Subtest y-tiled-ccs-to-linear: SUCCESS (0.217s)
[451.286380] [089/142] (569s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[451.554160] Starting subtest: yf-tiled-32bpp-rotate-270
[461.264565] Subtest yf-tiled-32bpp-rotate-270: SUCCESS (9.710s)
[461.706038] [090/142] (559s left) kms_big_joiner (basic)
[461.960600] Subtest basic: SKIP (0.000s)
[462.019781] [091/142] (559s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_ccs)
[462.848201] Subtest pipe-D-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[463.098985] [092/142] (558s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[463.261708] Starting subtest: addfb25-x-tiled-mismatch-legacy
[463.265155] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[463.448601] [093/142] (557s left) perf_pmu (cpu-hotplug)
[463.618755] Starting subtest: cpu-hotplug
[466.148128] Subtest cpu-hotplug: SUCCESS (2.527s)
[466.251623] [094/142] (554s left) gem_mmap_gtt (basic-read)
[466.412541] Starting subtest: basic-read
[466.447063] Subtest basic-read: SUCCESS (0.036s)
[466.549403] [095/142] (554s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[466.816591] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[466.823152] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[466.899880] [096/142] (554s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[467.152266] Starting subtest: primary-4-tiled-reflect-x-180
[467.158614] Subtest primary-4-tiled-reflect-x-180: SKIP (0.003s)
[467.244611] [097/142] (554s left) gem_exec_fence (syncobj-channel)
[467.826515] Starting subtest: syncobj-channel
[468.883211] Subtest syncobj-channel: SUCCESS (1.055s)
[469.217552] [098/142] (552s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[469.461911] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[469.470828] Starting dynamic subtest: pipe-A-HDMI-A-1
[469.795915] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.320s)
[469.828048] Starting dynamic subtest: pipe-B-HDMI-A-1
[470.178645] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.375s)
[470.209921] Starting dynamic subtest: pipe-C-HDMI-A-1
[470.576937] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.387s)
[470.580559] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (1.111s)
[471.352298] [099/142] (550s left) perf_pmu (most-busy-idle-check-all)
[471.902594] Starting subtest: most-busy-idle-check-all
[471.971450] Starting dynamic subtest: rcs0
[472.426624] Dynamic subtest rcs0: SUCCESS (0.618s)
[472.443871] Starting dynamic subtest: bcs0
[472.988864] Dynamic subtest bcs0: SUCCESS (0.618s)
[473.008329] Starting dynamic subtest: vcs0
[473.617342] Dynamic subtest vcs0: SUCCESS (0.623s)
[473.634601] Starting dynamic subtest: vecs0
[474.231947] Dynamic subtest vecs0: SUCCESS (0.618s)
[474.235299] Subtest most-busy-idle-check-all: SUCCESS (2.485s)
[474.329857] [100/142] (547s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-b)
[474.582491] Starting subtest: universal-plane-pageflip-windowed-pipe-B
[476.437229] Subtest universal-plane-pageflip-windowed-pipe-B: SUCCESS (1.856s)
[476.697964] [101/142] (545s left) perf_pmu (faulting-read)
[476.861197] Starting subtest: faulting-read
[476.864609] Starting dynamic subtest: gtt
[476.868280] Dynamic subtest gtt: SUCCESS (0.003s)
[476.895215] Starting dynamic subtest: wb
[476.898457] Dynamic subtest wb: SUCCESS (0.002s)
[476.919529] Starting dynamic subtest: wc
[476.923043] Dynamic subtest wc: SUCCESS (0.002s)
[476.949048] Starting dynamic subtest: uc
[476.953802] Dynamic subtest uc: SUCCESS (0.004s)
[476.957043] Subtest faulting-read: SUCCESS (0.027s)
[476.992098] [102/142] (544s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[477.837228] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[478.091841] [103/142] (543s left) gem_exec_balancer (bonded-chain)
[478.269768] Starting subtest: bonded-chain
[481.192678] Subtest bonded-chain: SUCCESS (2.922s)
[484.294113] [104/142] (537s left) sw_sync (sync_busy)
[484.448292] Starting subtest: sync_busy
[484.458206] Subtest sync_busy: SUCCESS (0.007s)
[484.524578] [105/142] (537s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[484.769096] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[484.777992] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[489.323589] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (4.543s)
[489.352690] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[493.853472] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (4.517s)
[493.881797] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[498.735778] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (4.883s)
[498.740044] Subtest 2x-modeset-vs-vblank-race-interruptible: SUCCESS (13.970s)
[499.299747] [106/142] (522s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[499.560591] Starting subtest: cursorA-vs-flipB-varying-size
[511.109911] Subtest cursorA-vs-flipB-varying-size: SUCCESS (11.421s)
[511.489627] [107/142] (510s left) feature_discovery (psr2)
[512.107121] Starting subtest: psr2
[512.337576] Subtest psr2: SKIP (0.000s)
[512.376475] [108/142] (509s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[513.075901] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[513.212521] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[513.520105] [109/142] (509s left) syncobj_basic (bad-pad-handle-to-fd)
[513.991285] Starting subtest: bad-pad-handle-to-fd
[513.994910] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[514.077752] [110/142] (508s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[514.888417] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[514.895037] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[515.190764] [111/142] (507s left) v3d/v3d_submit_csd (valid-multisync-submission)
[515.410849] Subtest valid-multisync-submission: SKIP (0.000s)
[515.479812] [112/142] (507s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[515.749386] Starting subtest: x-tiled-32bpp-rotate-0
[522.415758] Subtest x-tiled-32bpp-rotate-0: SUCCESS (6.667s)
[522.859941] [113/142] (499s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs)
[523.752976] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[524.063164] [114/142] (498s left) vc4/vc4_wait_bo (bad-bo)
[524.277262] Subtest bad-bo: SKIP (0.000s)
[524.353430] [115/142] (498s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[524.624621] Starting subtest: fbcpsr-tiling-linear
[524.631483] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[524.719885] [116/142] (498s left) sw_sync (sync_merge)
[524.878490] Starting subtest: sync_merge
[524.881942] Subtest sync_merge: SUCCESS (0.001s)
[524.951898] [117/142] (497s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[525.700873] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[525.707416] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[526.082776] [118/142] (496s left) drm_fdinfo (basics)
[526.248203] Starting subtest: basics
[526.251716] Subtest basics: SUCCESS (0.000s)
[526.332350] [119/142] (496s left) kms_flip (2x-nonexisting-fb)
[526.568835] Starting subtest: 2x-nonexisting-fb
[526.572301] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[527.455464] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (0.875s)
[527.483906] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[528.185822] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (0.730s)
[528.214729] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[528.918337] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (0.727s)
[528.921743] Subtest 2x-nonexisting-fb: SUCCESS (2.353s)
[529.476698] [120/142] (493s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[529.770498] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[529.778465] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[529.858144] [121/142] (493s left) gen9_exec_parse (batch-zero-length)
[530.039962] Starting subtest: batch-zero-length
[530.043551] Subtest batch-zero-length: SUCCESS (0.002s)
[530.258161] [122/142] (492s left) gem_mmap_gtt (fault-concurrent-x)
[530.420981] Starting subtest: fault-concurrent-X
[533.175464] Subtest fault-concurrent-X: SUCCESS (2.746s)
[533.274236] [123/142] (489s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[533.527232] Starting subtest: cursor-rapid-movement-32x32
[533.735889] Subtest cursor-rapid-movement-32x32: SKIP (0.201s)
[533.846293] [124/142] (489s left) kms_universal_plane (universal-plane-pipe-b-sanity)
[534.098993] Starting subtest: universal-plane-pipe-B-sanity
[536.029250] Subtest universal-plane-pipe-B-sanity: SUCCESS (1.934s)
[536.302955] [125/142] (486s left) i915_pm_rc6_residency (rc6-fence)
[536.466443] Starting subtest: rc6-fence
[551.692698] Subtest rc6-fence: SUCCESS (15.225s)
[551.952540] [126/142] (471s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[552.113811] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[552.215238] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[552.310138] [127/142] (470s left) gem_exec_capture (capture)
[552.474801] Starting subtest: capture
[552.478201] Starting dynamic subtest: rcs0-smem
[553.764104] Dynamic subtest rcs0-smem: SUCCESS (1.287s)
[553.802997] Starting dynamic subtest: bcs0-smem
[555.041186] Dynamic subtest bcs0-smem: SUCCESS (1.276s)
[555.067787] Starting dynamic subtest: vcs0-smem
[556.330275] Dynamic subtest vcs0-smem: SUCCESS (1.286s)
[556.356152] Starting dynamic subtest: vecs0-smem
[557.617954] Dynamic subtest vecs0-smem: SUCCESS (1.286s)
[557.622899] Subtest capture: SUCCESS (5.144s)
[557.710532] [128/142] (465s left) gem_vm_create (execbuf)
[557.882925] Starting subtest: execbuf
[557.892772] Subtest execbuf: SUCCESS (0.010s)
[557.993359] [129/142] (465s left) gem_spin_batch (legacy-resubmit-new)
[558.173093] Starting subtest: legacy-resubmit-new
[558.176484] Starting dynamic subtest: default
[558.184290] Dynamic subtest default: SUCCESS (0.008s)
[558.213838] Starting dynamic subtest: render
[558.217089] Dynamic subtest render: SUCCESS (0.016s)
[558.252469] Starting dynamic subtest: bsd
[558.257527] Dynamic subtest bsd: SUCCESS (0.009s)
[558.284753] Starting dynamic subtest: bsd1
[558.288115] Dynamic subtest bsd1: SUCCESS (0.011s)
[558.304525] Starting dynamic subtest: blt
[558.308304] Dynamic subtest blt: SUCCESS (0.012s)
[558.325179] Starting dynamic subtest: vebox
[558.328424] Dynamic subtest vebox: SUCCESS (0.015s)
[558.331544] Subtest legacy-resubmit-new: SUCCESS (0.101s)
[558.503913] [130/142] (464s left) kms_chamelium_frames (vga-frame-dump)
[559.161689] Subtest vga-frame-dump: SKIP (0.000s)
[559.420937] [131/142] (463s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[559.663821] Starting subtest: basic-busy-flip-before-cursor-legacy
[559.670604] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[559.758834] [132/142] (463s left) gem_render_copy (x-tiled)
[559.931580] Starting subtest: x-tiled
[559.935050] Starting dynamic subtest: smem
[560.143960] Dynamic subtest smem: SUCCESS (0.211s)
[560.147345] Subtest x-tiled: SUCCESS (0.214s)
[560.361071] [133/142] (463s left) gem_ctx_param (set-priority-invalid-size)
[560.521169] Starting subtest: set-priority-invalid-size
[560.524539] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[560.608561] [134/142] (462s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf_tiled_ccs)
[561.315207] Starting subtest: pipe-A-crc-sprite-planes-basic-yf_tiled_ccs
[562.399496] Subtest pipe-A-crc-sprite-planes-basic-yf_tiled_ccs: SUCCESS (1.080s)
[563.361162] [135/142] (460s left) kms_universal_plane (universal-plane-pipe-a-functional)
[563.889442] Starting subtest: universal-plane-pipe-A-functional
[569.510258] Subtest universal-plane-pipe-A-functional: SUCCESS (5.710s)
[569.756705] [136/142] (453s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[570.033487] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[570.040191] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[570.122198] [137/142] (453s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[570.390459] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[570.397106] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[570.483387] [138/142] (453s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_ccs)
[571.241303] Starting subtest: pipe-B-bad-aux-stride-y_tiled_ccs
[571.249139] Subtest pipe-B-bad-aux-stride-y_tiled_ccs: SUCCESS (0.003s)
[571.603100] [139/142] (452s left) gem_exec_schedule (implicit-read-write)
[571.793487] Starting subtest: implicit-read-write
[571.796879] Starting dynamic subtest: rcs0
[571.902810] Dynamic subtest rcs0: SUCCESS (0.118s)
[571.941753] Starting dynamic subtest: bcs0
[572.048951] Dynamic subtest bcs0: SUCCESS (0.143s)
[572.091160] Starting dynamic subtest: vcs0
[572.195775] Dynamic subtest vcs0: SUCCESS (0.127s)
[572.232817] Starting dynamic subtest: vecs0
[572.322974] Dynamic subtest vecs0: SUCCESS (0.120s)
[572.330646] Subtest implicit-read-write: SUCCESS (0.547s)
[572.669352] [140/142] (451s left) api_intel_bb (blit-reloc-purge-cache)
[572.834604] Starting subtest: blit-reloc-purge-cache
[572.853630] Subtest blit-reloc-purge-cache: SUCCESS (0.021s)
[572.959055] [141/142] (450s left) kms_psr (cursor_mmap_gtt)
[573.123679] Subtest cursor_mmap_gtt: SKIP (0.000s)
[573.177703] [142/142] (450s left) core_auth (getclient-master-drop)
[573.329490] Starting subtest: getclient-master-drop
[573.337328] Subtest getclient-master-drop: SUCCESS (0.004s)
[573.419248] Closing watchdogs
Done.