[38.864710] Initializing watchdogs
[38.865085]   /dev/watchdog0
[38.880866] [001/142] (960s left) prime_mmap (test_errors)
[39.107598] Starting subtest: test_errors
[39.108946] Starting dynamic subtest: test_errors-smem
[39.127401] Dynamic subtest test_errors-smem: SUCCESS (0.019s)
[39.129418] Subtest test_errors: SUCCESS (0.020s)
[39.228929] [002/142] (960s left) kms_flip (plain-flip-ts-check-interruptible)
[39.529583] Starting subtest: plain-flip-ts-check-interruptible
[39.533976] Starting dynamic subtest: A-DP1
[50.619372] Dynamic subtest A-DP1: SUCCESS (11.085s)
[50.634431] Starting dynamic subtest: B-DP1
[61.354409] Dynamic subtest B-DP1: SUCCESS (10.733s)
[61.368425] Starting dynamic subtest: C-DP1
[72.085407] Dynamic subtest C-DP1: SUCCESS (10.729s)
[72.091142] Subtest plain-flip-ts-check-interruptible: SUCCESS (32.558s)
[72.500335] [003/142] (926s left) kms_addfb_basic (small-bo)
[72.809874] Starting subtest: small-bo
[72.811215] Subtest small-bo: SUCCESS (0.000s)
[72.897950] [004/142] (926s left) v3d/v3d_wait_bo (bad-bo)
[73.150065] Subtest bad-bo: SKIP (0.000s)
[73.214232] [005/142] (926s left) gem_exec_schedule (preempt-self)
[73.458638] Starting subtest: preempt-self
[73.460052] Starting dynamic subtest: rcs0
[73.514880] Dynamic subtest rcs0: SUCCESS (0.056s)
[73.539397] Starting dynamic subtest: bcs0
[73.563628] Dynamic subtest bcs0: SUCCESS (0.048s)
[73.581476] Starting dynamic subtest: vcs0
[73.602878] Dynamic subtest vcs0: SUCCESS (0.038s)
[73.620737] Starting dynamic subtest: vecs0
[73.638917] Dynamic subtest vecs0: SUCCESS (0.036s)
[73.640784] Subtest preempt-self: SUCCESS (0.181s)
[73.983876] [006/142] (925s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[74.301563] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[76.531194] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.232s)
[76.665873] [007/142] (922s left) prime_vgem (fence-write-hang)
[76.963982] Subtest fence-write-hang: SKIP (0.000s)
[77.066036] [008/142] (922s left) gem_sync (basic-all)
[77.293871] Starting subtest: basic-all
[80.294889] Subtest basic-all: SUCCESS (3.000s)
[80.500393] [009/142] (919s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_mc_ccs)
[81.090232] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs
[81.092681] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[81.499144] [010/142] (918s left) syncobj_timeline (single-wait-available-submitted)
[81.703704] Starting subtest: single-wait-available-submitted
[81.705082] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[81.782468] [011/142] (917s left) gem_ctx_persistence (legacy-engines-hostile)
[81.993551] Starting subtest: legacy-engines-hostile
[81.996998] Starting dynamic subtest: render
[82.090970] Dynamic subtest render: SUCCESS (0.095s)
[82.106164] Starting dynamic subtest: bsd
[82.181982] Dynamic subtest bsd: SUCCESS (0.089s)
[82.199796] Starting dynamic subtest: blt
[82.271691] Dynamic subtest blt: SUCCESS (0.088s)
[82.289728] Starting dynamic subtest: vebox
[82.362610] Dynamic subtest vebox: SUCCESS (0.089s)
[82.363981] Subtest legacy-engines-hostile: SUCCESS (0.370s)
[82.449557] [012/142] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[82.760398] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[82.762948] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[82.849700] [013/142] (916s left) i915_pm_rpm (gem-idle)
[84.642795] Starting subtest: gem-idle
[90.121201] Subtest gem-idle: SUCCESS (5.476s)
[90.533453] [014/142] (909s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[90.915297] Starting subtest: disable-crc-after-crtc
[90.921764] Starting dynamic subtest: pipe-A-DP-1
[91.603425] Dynamic subtest pipe-A-DP-1: SUCCESS (0.685s)
[91.623945] Starting dynamic subtest: pipe-B-DP-1
[92.564376] Dynamic subtest pipe-B-DP-1: SUCCESS (0.956s)
[92.583205] Starting dynamic subtest: pipe-C-DP-1
[93.688826] Dynamic subtest pipe-C-DP-1: SUCCESS (1.117s)
[93.692266] Subtest disable-crc-after-crtc: SUCCESS (2.771s)
[94.012141] [015/142] (905s left) i915_query (test-query-geometry-subslices)
[94.213393] Starting subtest: test-query-geometry-subslices
[94.216061] Subtest test-query-geometry-subslices: SKIP (0.000s)
[94.296362] [016/142] (905s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[94.595575] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[94.596814] Starting dynamic subtest: pipe-A-valid-mode
[94.692733] Dynamic subtest pipe-A-valid-mode: SKIP (0.096s)
[94.695257] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.098s)
[95.001228] [017/142] (904s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[95.302571] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[95.305207] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[95.400241] [018/142] (904s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-25)
[95.703857] Starting subtest: plane-downscale-with-modifiers-factor-0-25
[95.705295] Starting dynamic subtest: pipe-A-DP-1
[95.746474] Dynamic subtest pipe-A-DP-1: SKIP (0.042s)
[95.764175] Starting dynamic subtest: pipe-B-DP-1
[95.843395] Dynamic subtest pipe-B-DP-1: SKIP (0.092s)
[95.858335] Starting dynamic subtest: pipe-C-DP-1
[95.934819] Dynamic subtest pipe-C-DP-1: SKIP (0.089s)
[95.937405] Subtest plane-downscale-with-modifiers-factor-0-25: SKIP (0.234s)
[96.033467] [019/142] (903s left) gem_exec_whisper (basic-queues-priority)
[96.259195] Starting subtest: basic-queues-priority
[110.602773] Subtest basic-queues-priority: SUCCESS (14.343s)
[110.802317] [020/142] (889s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs)
[111.518728] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[111.817274] [021/142] (888s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[112.021439] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[112.131342] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.109s)
[112.217664] [022/142] (887s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs)
[112.736845] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs
[112.739448] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[113.284611] [023/142] (886s left) gem_exec_schedule (u-semaphore-resolve)
[113.520449] Starting subtest: u-semaphore-resolve
[113.576727] Subtest u-semaphore-resolve: SUCCESS (0.055s)
[113.918544] [024/142] (886s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[114.229186] Starting subtest: fbc-farfromfence-mmap-gtt
[116.801348] Subtest fbc-farfromfence-mmap-gtt: SUCCESS (2.571s)
[116.984256] [025/142] (883s left) gem_exec_flush (basic-uc-ro-default)
[117.209988] Starting subtest: basic-uc-ro-default
[122.678460] Subtest basic-uc-ro-default: SUCCESS (5.469s)
[122.883896] [026/142] (877s left) kms_cursor_crc (cursor-random-512x512)
[123.192732] Starting subtest: cursor-random-512x512
[123.197240] Subtest cursor-random-512x512: SKIP (0.003s)
[123.300988] [027/142] (876s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_mc_ccs)
[123.890620] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs
[123.893200] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[124.305202] [028/142] (875s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[124.625526] Starting subtest: psr-shrfb-scaledprimary
[124.628476] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[124.723335] [029/142] (875s left) kms_vblank (pipe-a-ts-continuation-modeset-hang)
[125.027758] Starting subtest: pipe-A-ts-continuation-modeset-hang
[132.020491] Subtest pipe-A-ts-continuation-modeset-hang: SUCCESS (6.994s)
[132.357816] [030/142] (868s left) kms_lease (implicit-plane-lease)
[132.660204] Starting subtest: implicit-plane-lease
[132.663418] Subtest implicit-plane-lease: SUCCESS (0.006s)
[132.744438] [031/142] (867s left) kms_busy (basic)
[133.053826] Starting subtest: basic
[133.058250] Starting dynamic subtest: flip
[133.666640] Dynamic subtest flip: SUCCESS (0.609s)
[133.684236] Starting dynamic subtest: modeset
[135.061419] Dynamic subtest modeset: SUCCESS (1.394s)
[135.062727] Subtest basic: SUCCESS (2.008s)
[135.412512] [032/142] (865s left) kms_properties (get_properties-sanity-atomic)
[135.710896] Starting subtest: get_properties-sanity-atomic
[135.715699] Subtest get_properties-sanity-atomic: SUCCESS (0.005s)
[135.793726] [033/142] (864s left) kms_vblank (pipe-a-query-forked-hang)
[136.099591] Starting subtest: pipe-A-query-forked-hang
[142.968826] Subtest pipe-A-query-forked-hang: SUCCESS (6.871s)
[143.313799] [034/142] (857s left) gem_exec_reloc (basic-gtt-active)
[143.523497] Starting subtest: basic-gtt-active
[143.665993] Subtest basic-gtt-active: SUCCESS (0.142s)
[143.863372] [035/142] (856s left) gem_exec_whisper (basic-sync-all)
[144.090574] Starting subtest: basic-sync-all
[153.600535] Subtest basic-sync-all: SUCCESS (9.508s)
[153.795883] [036/142] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[154.111851] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[154.114442] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[154.214073] [037/142] (846s left) kms_cursor_edge_walk (128x128-top-bottom)
[154.512034] Starting subtest: 128x128-top-bottom
[154.517910] Starting dynamic subtest: pipe-A-DP-1
[158.164277] Dynamic subtest pipe-A-DP-1: SUCCESS (3.650s)
[158.188859] Starting dynamic subtest: pipe-C-DP-1
[161.662737] Dynamic subtest pipe-C-DP-1: SUCCESS (3.490s)
[161.664073] Subtest 128x128-top-bottom: SUCCESS (7.151s)
[161.969796] [038/142] (838s left) kms_atomic_transition (plane-all-transition-fencing)
[162.265242] Starting subtest: plane-all-transition-fencing
[162.270183] Starting dynamic subtest: pipe-A-DP-1
[166.262268] Dynamic subtest pipe-A-DP-1: SUCCESS (3.995s)
[166.383334] Starting dynamic subtest: pipe-B-DP-1
[170.705306] Dynamic subtest pipe-B-DP-1: SUCCESS (4.339s)
[170.806668] Subtest plane-all-transition-fencing: SUCCESS (8.542s)
[171.142277] [039/142] (829s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[171.352164] Starting subtest: multi-wait-for-submit-available-submitted
[171.356110] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.002s)
[171.441334] [040/142] (829s left) gem_render_copy (yf-tiled)
[171.665526] Starting subtest: yf-tiled
[171.667090] Starting dynamic subtest: smem
[172.050396] Dynamic subtest smem: SUCCESS (0.383s)
[172.051815] Subtest yf-tiled: SUCCESS (0.385s)
[172.259673] [041/142] (828s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[172.712483] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[172.715118] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[173.306208] [042/142] (827s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[173.615707] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[176.182818] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (2.570s)
[176.323445] [043/142] (824s left) syncobj_wait (wait-all-for-submit-complex)
[176.527376] Starting subtest: wait-all-for-submit-complex
[176.743412] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[176.823193] [044/142] (824s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[177.200631] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[177.472573] [045/142] (823s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[177.673342] Starting subtest: invalid-multi-wait-unsubmitted
[177.674683] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[177.767327] [046/142] (823s left) syncobj_basic (bad-pad-fd-to-handle)
[177.965283] Starting subtest: bad-pad-fd-to-handle
[177.966722] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[178.050261] [047/142] (822s left) gem_ringfill (legacy-basic)
[178.526794] Starting subtest: legacy-basic
[178.528160] Starting dynamic subtest: default
[178.551290] Dynamic subtest default: SUCCESS (0.023s)
[178.573862] Starting dynamic subtest: render
[178.577700] Dynamic subtest render: SUCCESS (0.023s)
[178.601245] Starting dynamic subtest: bsd
[178.605462] Dynamic subtest bsd: SUCCESS (0.024s)
[178.627674] Starting dynamic subtest: bsd1
[178.631892] Dynamic subtest bsd1: SUCCESS (0.024s)
[178.651968] Starting dynamic subtest: blt
[178.656071] Dynamic subtest blt: SUCCESS (0.024s)
[178.678896] Starting dynamic subtest: vebox
[178.683311] Dynamic subtest vebox: SUCCESS (0.023s)
[178.684943] Subtest legacy-basic: SUCCESS (0.155s)
[178.770826] [048/142] (822s left) gem_ctx_persistence (many-contexts)
[178.977846] Starting subtest: many-contexts
[211.759246] Subtest many-contexts: SUCCESS (32.781s)
[211.851363] [049/142] (789s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[212.260483] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[212.263506] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s)
[212.884660] [050/142] (788s left) v3d/v3d_perfmon (destroy-invalid-perfmon)
[213.144882] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[213.216547] [051/142] (787s left) vc4/vc4_wait_bo (bad-pad)
[213.478202] Subtest bad-pad: SKIP (0.000s)
[213.550299] [052/142] (787s left) kms_writeback (writeback-check-output)
[213.958743] Subtest writeback-check-output: SKIP (0.000s)
[214.018729] [053/142] (787s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[214.352434] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[215.742388] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.392s)
[215.883765] [054/142] (785s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[216.620378] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[216.625820] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.004s)
[216.933996] [055/142] (784s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[217.240532] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[219.643625] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.405s)
[219.767393] [056/142] (781s left) gem_eio (in-flight-contexts-immediate)
[219.998405] Starting subtest: in-flight-contexts-immediate
[231.227632] Subtest in-flight-contexts-immediate: SUCCESS (11.230s)
[231.417479] [057/142] (769s left) gem_caching (writes)
[231.625172] Starting subtest: writes
[246.187143] Subtest writes: SUCCESS (14.562s)
[246.300976] [058/142] (755s left) kms_content_protection (dp-mst-type-1)
[246.640279] Starting subtest: dp-mst-type-1
[246.643154] Subtest dp-mst-type-1: SKIP (0.001s)
[246.752472] [059/142] (754s left) gem_mmap_wc (write-wc-read-gtt)
[246.957084] Starting subtest: write-wc-read-gtt
[247.495589] Subtest write-wc-read-gtt: SUCCESS (0.538s)
[247.614981] [060/142] (753s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[247.812187] Starting subtest: write-cpu-read-wc-unflushed
[248.077622] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.265s)
[248.169520] [061/142] (753s left) kms_vblank (pipe-a-accuracy-idle)
[248.464119] Starting subtest: pipe-A-accuracy-idle
[250.741778] Subtest pipe-A-accuracy-idle: SUCCESS (2.279s)
[251.061630] [062/142] (750s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[251.377045] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[251.379878] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[251.479080] [063/142] (750s left) kms_chamelium_edid (dp-edid-resolution-list)
[251.872205] Subtest dp-edid-resolution-list: SKIP (0.000s)
[252.147426] [064/142] (749s left) gem_exec_reloc (basic-cpu-wc-active)
[252.357268] Starting subtest: basic-cpu-wc-active
[252.499273] Subtest basic-cpu-wc-active: SUCCESS (0.141s)
[252.690463] [065/142] (749s left) syncobj_wait (wait-any-snapshot)
[252.892305] Starting subtest: wait-any-snapshot
[252.974906] Subtest wait-any-snapshot: SUCCESS (0.082s)
[253.056908] [066/142] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[253.370841] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[253.373806] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[253.473623] [067/142] (748s left) kms_vblank (pipe-b-wait-busy-hang)
[253.778907] Starting subtest: pipe-B-wait-busy-hang
[260.971665] Subtest pipe-B-wait-busy-hang: SUCCESS (7.196s)
[261.295445] [068/142] (740s left) syncobj_timeline (invalid-wait-zero-handles)
[261.501460] Starting subtest: invalid-wait-zero-handles
[261.503259] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[261.594880] [069/142] (740s left) v3d/v3d_job_submission (threaded-job-submission)
[261.855485] Subtest threaded-job-submission: SKIP (0.000s)
[261.928640] [070/142] (739s left) syncobj_wait (invalid-reset-illegal-handle)
[262.131446] Starting subtest: invalid-reset-illegal-handle
[262.133462] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[262.227313] [071/142] (739s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[262.528706] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[262.529957] Starting dynamic subtest: pipe-A-valid-mode
[263.228437] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.701s)
[263.229655] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.705s)
[263.563425] [072/142] (738s left) gem_exec_fair (basic-pace)
[263.798608] Starting subtest: basic-pace
[263.800137] Starting dynamic subtest: rcs0
[268.632923] Dynamic subtest rcs0: SUCCESS (4.833s)
[268.654668] Starting dynamic subtest: bcs0
[268.657220] Dynamic subtest bcs0: SKIP (0.009s)
[268.676436] Starting dynamic subtest: vcs0
[273.439241] Dynamic subtest vcs0: SUCCESS (4.791s)
[273.459142] Starting dynamic subtest: vecs0
[278.252526] Dynamic subtest vecs0: SUCCESS (4.812s)
[278.254241] Subtest basic-pace: SUCCESS (14.455s)
[278.463344] [073/142] (723s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf)
[278.665998] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[278.711926] [074/142] (723s left) kms_atomic (test-only)
[279.139578] Starting subtest: test-only
[280.053897] Subtest test-only: SUCCESS (0.910s)
[280.392380] [075/142] (721s left) kms_psr2_su (page_flip-xrgb8888)
[280.597189] Subtest page_flip-XRGB8888: SKIP (0.000s)
[280.656743] [076/142] (721s left) i915_pm_backlight (basic-brightness)
[280.958469] Subtest basic-brightness: SKIP (0.000s)
[281.007138] [077/142] (721s left) kms_plane (pixel-format)
[281.314853] Starting subtest: pixel-format
[281.316432] Starting dynamic subtest: pipe-A-planes
[287.998344] Dynamic subtest pipe-A-planes: SUCCESS (6.682s)
[288.023451] Starting dynamic subtest: pipe-B-planes
[294.964516] Dynamic subtest pipe-B-planes: SUCCESS (6.957s)
[294.966100] Subtest pixel-format: SUCCESS (13.652s)
[295.307655] [078/142] (706s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[295.526357] Starting subtest: writes-after-reads-uncached
[316.437252] Subtest writes-after-reads-uncached: SUCCESS (20.911s)
[316.555966] [079/142] (685s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[316.871194] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[316.873973] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[316.974424] [080/142] (685s left) gem_create (busy-create)
[317.188177] Starting subtest: busy-create
[317.192564] Starting dynamic subtest: smem0
[349.456715] Dynamic subtest smem0: SUCCESS (32.266s)
[349.458410] Subtest busy-create: SUCCESS (32.269s)
[349.658538] [081/142] (652s left) kms_setmode (clone-exclusive-crtc)
[349.858972] Starting subtest: clone-exclusive-crtc
[349.863391] Subtest clone-exclusive-crtc: SKIP (0.000s)
[349.955629] [082/142] (652s left) gem_pxp (create-regular-buffer)
[352.682494] Subtest create-regular-buffer: SKIP (0.000s)
[352.773395] [083/142] (649s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[353.074863] Starting subtest: fbc-modesetfrombusy
[354.293586] Subtest fbc-modesetfrombusy: SUCCESS (1.221s)
[354.403904] [084/142] (648s left) gem_cs_tlb (engines)
[354.610510] Starting subtest: engines
[354.612087] Starting dynamic subtest: rcs0
[356.776650] Dynamic subtest rcs0: SUCCESS (2.162s)
[356.796165] Starting dynamic subtest: bcs0
[358.943648] Dynamic subtest bcs0: SUCCESS (2.165s)
[358.963303] Starting dynamic subtest: vcs0
[361.108986] Dynamic subtest vcs0: SUCCESS (2.162s)
[361.128870] Starting dynamic subtest: vecs0
[363.273621] Dynamic subtest vecs0: SUCCESS (2.161s)
[363.275191] Subtest engines: SUCCESS (8.662s)
[363.385971] [085/142] (639s left) kms_rotation_crc (primary-rotation-180)
[363.682902] Starting subtest: primary-rotation-180
[368.037305] Subtest primary-rotation-180: SUCCESS (4.358s)
[368.458863] [086/142] (634s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[368.769737] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[368.772349] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[368.874804] [087/142] (633s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[369.178888] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[369.181446] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[369.274919] [088/142] (633s left) gem_render_copy (y-tiled-ccs-to-linear)
[369.491950] Starting subtest: y-tiled-ccs-to-linear
[369.493560] Starting dynamic subtest: smem
[369.760166] Dynamic subtest smem: SUCCESS (0.266s)
[369.761679] Subtest y-tiled-ccs-to-linear: SUCCESS (0.269s)
[369.958896] [089/142] (632s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[370.274624] Starting subtest: yf-tiled-32bpp-rotate-270
[375.299669] Subtest yf-tiled-32bpp-rotate-270: SUCCESS (5.024s)
[375.875450] [090/142] (626s left) kms_big_joiner (basic)
[376.180361] Subtest basic: SKIP (0.000s)
[376.240316] [091/142] (626s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_ccs)
[376.958423] Subtest pipe-D-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[377.274369] [092/142] (625s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[377.475381] Starting subtest: addfb25-x-tiled-mismatch-legacy
[377.476902] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[377.674441] [093/142] (625s left) perf_pmu (cpu-hotplug)
[377.882769] Starting subtest: cpu-hotplug
[382.433640] Subtest cpu-hotplug: SUCCESS (4.550s)
[382.558657] [094/142] (620s left) gem_mmap_gtt (basic-read)
[382.762860] Starting subtest: basic-read
[382.847089] Subtest basic-read: SUCCESS (0.083s)
[382.974376] [095/142] (619s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[383.291504] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[383.294849] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[383.392516] [096/142] (619s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[383.692115] Starting subtest: primary-4-tiled-reflect-x-180
[383.694668] Subtest primary-4-tiled-reflect-x-180: SKIP (0.003s)
[383.792105] [097/142] (619s left) gem_exec_fence (syncobj-channel)
[384.467594] Starting subtest: syncobj-channel
[385.532341] Subtest syncobj-channel: SUCCESS (1.064s)
[385.891887] [098/142] (617s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[386.189877] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[386.191234] Starting dynamic subtest: pipe-A-DP-1
[386.527561] Dynamic subtest pipe-A-DP-1: SUCCESS (0.336s)
[386.556329] Starting dynamic subtest: pipe-B-DP-1
[386.914270] Dynamic subtest pipe-B-DP-1: SUCCESS (0.382s)
[386.948402] Starting dynamic subtest: pipe-C-DP-1
[387.323713] Dynamic subtest pipe-C-DP-1: SUCCESS (0.403s)
[387.325302] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (1.140s)
[387.744107] [099/142] (615s left) perf_pmu (most-busy-idle-check-all)
[387.950383] Starting subtest: most-busy-idle-check-all
[387.951954] Starting dynamic subtest: rcs0
[388.580807] Dynamic subtest rcs0: SUCCESS (0.629s)
[388.610521] Starting dynamic subtest: bcs0
[389.206859] Dynamic subtest bcs0: SUCCESS (0.623s)
[389.235922] Starting dynamic subtest: vcs0
[389.832920] Dynamic subtest vcs0: SUCCESS (0.623s)
[389.861834] Starting dynamic subtest: vecs0
[390.455829] Dynamic subtest vecs0: SUCCESS (0.620s)
[390.457591] Subtest most-busy-idle-check-all: SUCCESS (2.507s)
[390.561488] [100/142] (612s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-b)
[390.865405] Starting subtest: universal-plane-pageflip-windowed-pipe-B
[391.657419] Subtest universal-plane-pageflip-windowed-pipe-B: SUCCESS (0.794s)
[391.974197] [101/142] (611s left) perf_pmu (faulting-read)
[392.178718] Starting subtest: faulting-read
[392.180625] Starting dynamic subtest: gtt
[392.184820] Dynamic subtest gtt: SUCCESS (0.005s)
[392.216504] Starting dynamic subtest: wb
[392.217784] Dynamic subtest wb: SUCCESS (0.002s)
[392.240431] Starting dynamic subtest: wc
[392.241739] Dynamic subtest wc: SUCCESS (0.002s)
[392.263200] Starting dynamic subtest: uc
[392.264435] Dynamic subtest uc: SUCCESS (0.001s)
[392.265629] Subtest faulting-read: SUCCESS (0.021s)
[392.307799] [102/142] (610s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[393.023598] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[393.323969] [103/142] (609s left) gem_exec_balancer (bonded-chain)
[393.552090] Starting subtest: bonded-chain
[397.227290] Subtest bonded-chain: SUCCESS (3.676s)
[401.089525] [104/142] (602s left) sw_sync (sync_busy)
[401.286825] Starting subtest: sync_busy
[401.294258] Subtest sync_busy: SUCCESS (0.007s)
[401.372606] [105/142] (601s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[401.667699] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[401.672970] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.004s)
[401.774351] [106/142] (601s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[402.082386] Starting subtest: cursorA-vs-flipB-varying-size
[402.085584] Subtest cursorA-vs-flipB-varying-size: SKIP (0.003s)
[402.173965] [107/142] (601s left) feature_discovery (psr2)
[402.478285] Starting subtest: psr2
[402.481095] Subtest psr2: SKIP (0.000s)
[402.573500] [108/142] (600s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[402.876909] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[402.879742] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[402.989964] [109/142] (600s left) syncobj_basic (bad-pad-handle-to-fd)
[403.187116] Starting subtest: bad-pad-handle-to-fd
[403.188773] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[403.273456] [110/142] (600s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[403.942718] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[403.948093] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.002s)
[404.348539] [111/142] (599s left) v3d/v3d_submit_csd (valid-multisync-submission)
[404.604716] Subtest valid-multisync-submission: SKIP (0.000s)
[404.680347] [112/142] (598s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[405.003624] Starting subtest: x-tiled-32bpp-rotate-0
[410.136271] Subtest x-tiled-32bpp-rotate-0: SUCCESS (5.135s)
[410.713798] [113/142] (592s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs)
[411.429307] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[411.748971] [114/142] (591s left) vc4/vc4_wait_bo (bad-bo)
[412.005929] Subtest bad-bo: SKIP (0.000s)
[412.081504] [115/142] (591s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[412.390057] Starting subtest: fbcpsr-tiling-linear
[412.393149] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[412.499267] [116/142] (591s left) sw_sync (sync_merge)
[412.695349] Starting subtest: sync_merge
[412.697152] Subtest sync_merge: SUCCESS (0.001s)
[412.764888] [117/142] (591s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[413.308466] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[413.311089] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[413.820379] [118/142] (590s left) drm_fdinfo (basics)
[414.022597] Starting subtest: basics
[414.024159] Subtest basics: SUCCESS (0.000s)
[414.119503] [119/142] (589s left) kms_flip (2x-nonexisting-fb)
[414.402299] Starting subtest: 2x-nonexisting-fb
[414.410662] Subtest 2x-nonexisting-fb: SKIP (0.003s)
[414.536716] [120/142] (589s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[414.845041] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[414.847669] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[414.952794] [121/142] (589s left) gen9_exec_parse (batch-zero-length)
[415.174762] Starting subtest: batch-zero-length
[415.179407] Subtest batch-zero-length: SUCCESS (0.003s)
[415.403444] [122/142] (588s left) gem_mmap_gtt (fault-concurrent-x)
[415.599962] Starting subtest: fault-concurrent-X
[418.912959] Subtest fault-concurrent-X: SUCCESS (3.311s)
[419.102752] [123/142] (585s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[419.411172] Starting subtest: cursor-rapid-movement-32x32
[419.533658] Subtest cursor-rapid-movement-32x32: SKIP (0.120s)
[419.669786] [124/142] (584s left) kms_universal_plane (universal-plane-pipe-b-sanity)
[419.967207] Starting subtest: universal-plane-pipe-B-sanity
[420.773750] Subtest universal-plane-pipe-B-sanity: SUCCESS (0.808s)
[421.079334] [125/142] (583s left) i915_pm_rc6_residency (rc6-fence)
[421.276227] Starting subtest: rc6-fence
[436.530858] Subtest rc6-fence: SUCCESS (15.254s)
[436.794843] [126/142] (567s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[436.993710] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[437.099367] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[437.196413] [127/142] (567s left) gem_exec_capture (capture)
[437.408426] Starting subtest: capture
[437.410493] Starting dynamic subtest: rcs0-smem
[438.693274] Dynamic subtest rcs0-smem: SUCCESS (1.284s)
[438.715792] Starting dynamic subtest: bcs0-smem
[439.979934] Dynamic subtest bcs0-smem: SUCCESS (1.284s)
[440.005102] Starting dynamic subtest: vcs0-smem
[441.264912] Dynamic subtest vcs0-smem: SUCCESS (1.284s)
[441.293267] Starting dynamic subtest: vecs0-smem
[442.545400] Dynamic subtest vecs0-smem: SUCCESS (1.277s)
[442.546980] Subtest capture: SUCCESS (5.139s)
[442.662541] [128/142] (561s left) gem_vm_create (execbuf)
[442.870195] Starting subtest: execbuf
[442.879142] Subtest execbuf: SUCCESS (0.009s)
[442.996076] [129/142] (561s left) gem_spin_batch (legacy-resubmit-new)
[443.219880] Starting subtest: legacy-resubmit-new
[443.224364] Starting dynamic subtest: default
[443.231363] Dynamic subtest default: SUCCESS (0.009s)
[443.262589] Starting dynamic subtest: render
[443.264892] Dynamic subtest render: SUCCESS (0.008s)
[443.291828] Starting dynamic subtest: bsd
[443.293244] Dynamic subtest bsd: SUCCESS (0.008s)
[443.314542] Starting dynamic subtest: bsd1
[443.315827] Dynamic subtest bsd1: SUCCESS (0.006s)
[443.336723] Starting dynamic subtest: blt
[443.338051] Dynamic subtest blt: SUCCESS (0.008s)
[443.358357] Starting dynamic subtest: vebox
[443.359596] Dynamic subtest vebox: SUCCESS (0.007s)
[443.360962] Subtest legacy-resubmit-new: SUCCESS (0.067s)
[443.512106] [130/142] (560s left) kms_chamelium_frames (vga-frame-dump)
[443.902030] Subtest vga-frame-dump: SKIP (0.000s)
[444.191228] [131/142] (560s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[444.481982] Starting subtest: basic-busy-flip-before-cursor-legacy
[444.484603] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[444.568918] [132/142] (559s left) gem_render_copy (x-tiled)
[444.785996] Starting subtest: x-tiled
[444.790438] Starting dynamic subtest: smem
[445.064716] Dynamic subtest smem: SUCCESS (0.276s)
[445.066284] Subtest x-tiled: SUCCESS (0.279s)
[445.270979] [133/142] (559s left) gem_ctx_param (set-priority-invalid-size)
[445.470788] Starting subtest: set-priority-invalid-size
[445.472181] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[445.569134] [134/142] (559s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf_tiled_ccs)
[446.038891] Starting subtest: pipe-A-crc-sprite-planes-basic-yf_tiled_ccs
[446.558984] Subtest pipe-A-crc-sprite-planes-basic-yf_tiled_ccs: SUCCESS (0.520s)
[447.270195] [135/142] (557s left) kms_universal_plane (universal-plane-pipe-a-functional)
[447.566272] Starting subtest: universal-plane-pipe-A-functional
[450.040988] Subtest universal-plane-pipe-A-functional: SUCCESS (2.474s)
[450.364880] [136/142] (554s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[450.681646] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[450.684803] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[450.797889] [137/142] (553s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[451.125519] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[451.128650] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[451.231554] [138/142] (553s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_ccs)
[451.800790] Starting subtest: pipe-B-bad-aux-stride-y_tiled_ccs
[451.805654] Subtest pipe-B-bad-aux-stride-y_tiled_ccs: SUCCESS (0.003s)
[452.255977] [139/142] (552s left) gem_exec_schedule (implicit-read-write)
[452.485833] Starting subtest: implicit-read-write
[452.490379] Starting dynamic subtest: rcs0
[452.638358] Dynamic subtest rcs0: SUCCESS (0.149s)
[452.674373] Starting dynamic subtest: bcs0
[452.782460] Dynamic subtest bcs0: SUCCESS (0.140s)
[452.811132] Starting dynamic subtest: vcs0
[452.915791] Dynamic subtest vcs0: SUCCESS (0.129s)
[452.943856] Starting dynamic subtest: vecs0
[453.042875] Dynamic subtest vecs0: SUCCESS (0.124s)
[453.045627] Subtest implicit-read-write: SUCCESS (0.556s)
[453.406609] [140/142] (551s left) api_intel_bb (blit-reloc-purge-cache)
[453.608401] Starting subtest: blit-reloc-purge-cache
[453.629706] Subtest blit-reloc-purge-cache: SUCCESS (0.021s)
[453.739474] [141/142] (551s left) kms_psr (cursor_mmap_gtt)
[453.941584] Subtest cursor_mmap_gtt: SKIP (0.000s)
[454.005842] [142/142] (550s left) core_auth (getclient-master-drop)
[454.199939] Starting subtest: getclient-master-drop
[454.207332] Subtest getclient-master-drop: SUCCESS (0.005s)
[454.302317] Closing watchdogs
Done.