[39.289656] Initializing watchdogs
[39.289868]   /dev/watchdog0
[39.303961] [001/142] (960s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[39.502152] Starting subtest: basic-flip-before-cursor-legacy
[41.014459] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.509s)
[41.276479] [002/142] (958s left) kms_chamelium_frames (dp-crc-fast)
[41.883864] Subtest dp-crc-fast: SKIP (0.000s)
[42.087236] [003/142] (957s left) gem_exec_schedule (u-semaphore-noskip)
[42.231204] Starting subtest: u-semaphore-noskip
[42.454950] Subtest u-semaphore-noskip: SUCCESS (0.223s)
[42.782970] [004/142] (957s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[42.890220] Starting subtest: single-wait-all-for-submit-signaled
[42.892597] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.002s)
[42.974463] [005/142] (956s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[43.155281] Starting subtest: primary-yf-tiled-reflect-x-180
[43.162725] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.005s)
[43.238991] [006/142] (956s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_mc_ccs)
[43.990309] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[44.185289] [007/142] (955s left) syncobj_basic (bad-pad-handle-to-fd)
[44.290077] Starting subtest: bad-pad-handle-to-fd
[44.291241] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[44.367781] [008/142] (955s left) i915_pm_freq_mult (media-freq)
[44.505841] Starting subtest: media-freq
[44.508813] Starting dynamic subtest: gt0
[44.512218] Dynamic subtest gt0: SKIP (0.000s)
[44.515915] Subtest media-freq: SKIP (0.001s)
[44.604428] [009/142] (955s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[44.788563] Starting subtest: cursorB-vs-flipA-atomic
[56.160910] Subtest cursorB-vs-flipA-atomic: SUCCESS (11.375s)
[56.443942] [010/142] (943s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[56.653465] Starting subtest: psr-rgb565-draw-pwrite
[56.657286] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[56.739973] [011/142] (943s left) kms_fbcon_fbt (fbc)
[56.853725] Starting subtest: fbc
[60.961905] Subtest fbc: SUCCESS (4.105s)
[61.006395] [012/142] (939s left) kms_cursor_crc (cursor-alpha-transparent)
[61.192612] Starting subtest: cursor-alpha-transparent
[61.193726] Starting dynamic subtest: pipe-A-HDMI-A-1
[62.080959] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.887s)
[62.099137] Starting dynamic subtest: pipe-C-HDMI-A-1
[62.639025] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.556s)
[62.640813] Subtest cursor-alpha-transparent: SUCCESS (1.452s)
[62.892284] [013/142] (937s left) gem_flink_basic (basic)
[62.996208] Starting subtest: basic
[62.997317] Subtest basic: SUCCESS (0.001s)
[63.073206] [014/142] (937s left) sw_sync (sync_multi_consumer)
[63.172858] Starting subtest: sync_multi_consumer
[63.708933] Subtest sync_multi_consumer: SUCCESS (0.534s)
[63.777870] [015/142] (936s left) gem_exec_whisper (basic-fds-all)
[63.904634] Starting subtest: basic-fds-all
[83.504578] Subtest basic-fds-all: SUCCESS (19.601s)
[83.696108] [016/142] (916s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[83.894143] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[84.777971] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.883s)
[85.024916] [017/142] (915s left) kms_cdclk (plane-scaling)
[85.132545] Subtest plane-scaling: SKIP (0.000s)
[85.178692] [018/142] (915s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[85.374784] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[85.376936] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[85.456605] [019/142] (914s left) kms_rotation_crc (cursor-rotation-180)
[85.640797] Starting subtest: cursor-rotation-180
[87.547240] Subtest cursor-rotation-180: SUCCESS (1.903s)
[87.718829] [020/142] (912s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[87.900825] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[87.907684] Starting dynamic subtest: pipe-A-HDMI-A-1
[88.230195] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.319s)
[88.253586] Starting dynamic subtest: pipe-B-HDMI-A-1
[88.611178] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.378s)
[88.636244] Starting dynamic subtest: pipe-C-HDMI-A-1
[88.725659] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.113s)
[88.726794] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.825s)
[89.106513] [021/142] (911s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[89.302365] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[89.305633] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[89.386098] [022/142] (910s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[89.583953] Starting subtest: yf-tiled-8bpp-rotate-0
[89.587051] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[89.668937] [023/142] (910s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[90.313730] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[90.315941] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[90.923595] [024/142] (909s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled)
[91.120913] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled
[91.122223] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[91.214132] [025/142] (909s left) perf_pmu (busy-accuracy-98)
[91.339656] Starting subtest: busy-accuracy-98
[91.340838] Starting dynamic subtest: rcs0
[94.395064] Dynamic subtest rcs0: SUCCESS (3.052s)
[94.406445] Starting dynamic subtest: bcs0
[97.446117] Dynamic subtest bcs0: SUCCESS (3.052s)
[97.457967] Starting dynamic subtest: vcs0
[100.496797] Dynamic subtest vcs0: SUCCESS (3.049s)
[100.509993] Starting dynamic subtest: vecs0
[103.550605] Dynamic subtest vecs0: SUCCESS (3.051s)
[103.551833] Subtest busy-accuracy-98: SUCCESS (12.208s)
[103.631232] [026/142] (896s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[103.734368] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[103.840278] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[103.914173] [027/142] (896s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[104.110209] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[104.112393] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[104.195098] [028/142] (896s left) kms_plane (plane-position-hole-dpms)
[104.378234] Starting subtest: plane-position-hole-dpms
[104.384049] Starting dynamic subtest: pipe-A-planes
[107.536823] Dynamic subtest pipe-A-planes: SUCCESS (3.154s)
[107.552923] Starting dynamic subtest: pipe-B-planes
[110.434781] Dynamic subtest pipe-B-planes: SUCCESS (2.886s)
[110.438546] Subtest plane-position-hole-dpms: SUCCESS (6.050s)
[110.682473] [029/142] (889s left) gem_exec_balancer (nohangcheck)
[113.726482] Starting subtest: nohangcheck
[116.525886] Subtest nohangcheck: SUCCESS (2.798s)
[116.603701] [030/142] (884s left) i915_power (sanity)
[116.711732] Starting subtest: sanity
[120.738473] Subtest sanity: SUCCESS (4.020s)
[120.832584] [031/142] (879s left) syncobj_timeline (multi-wait-for-submit-signaled)
[120.938445] Starting subtest: multi-wait-for-submit-signaled
[120.940274] Subtest multi-wait-for-submit-signaled: SUCCESS (0.002s)
[121.019376] [032/142] (879s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[121.217449] Starting subtest: y-tiled-64bpp-rotate-0
[124.870234] Subtest y-tiled-64bpp-rotate-0: SUCCESS (3.648s)
[125.443242] [033/142] (875s left) api_intel_bb (object-noreloc-keep-cache-simple)
[125.575870] Starting subtest: object-noreloc-keep-cache-simple
[125.584818] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.009s)
[125.687762] [034/142] (875s left) gem_unfence_active_buffers
[126.020975] [035/142] (874s left) gem_basic (create-fd-close)
[126.129321] Starting subtest: create-fd-close
[126.131478] Subtest create-fd-close: SUCCESS (0.000s)
[126.215838] [036/142] (874s left) api_intel_bb (simple-bb)
[126.320315] Starting subtest: simple-bb
[126.325914] Subtest simple-bb: SUCCESS (0.006s)
[126.404497] [037/142] (874s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[126.591933] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[126.593661] Starting dynamic subtest: pipe-A-HDMI-A-1
[126.918568] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.324s)
[126.944924] Starting dynamic subtest: pipe-B-HDMI-A-1
[127.299758] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.374s)
[127.326206] Starting dynamic subtest: pipe-C-HDMI-A-1
[127.394136] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.088s)
[127.396149] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.805s)
[127.761599] [038/142] (873s left) kms_vblank (pipe-c-ts-continuation-modeset-rpm)
[127.950742] Starting subtest: pipe-C-ts-continuation-modeset-rpm
[131.592572] Subtest pipe-C-ts-continuation-modeset-rpm: SUCCESS (3.646s)
[131.943462] [039/142] (868s left) gem_unref_active_buffers
[132.262132] [040/142] (868s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[132.448257] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[132.454577] Starting dynamic subtest: pipe-A-valid-mode
[132.881765] Dynamic subtest pipe-A-valid-mode: SKIP (0.425s)
[132.884864] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.431s)
[133.162199] [041/142] (867s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[133.359746] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[133.363191] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[133.446234] [042/142] (867s left) kms_flip (flip-vs-rmfb)
[133.620077] Starting subtest: flip-vs-rmfb
[133.624142] Starting dynamic subtest: A-HDMI-A1
[139.286604] Dynamic subtest A-HDMI-A1: SUCCESS (5.662s)
[139.302783] Starting dynamic subtest: B-HDMI-A1
[144.653769] Dynamic subtest B-HDMI-A1: SUCCESS (5.364s)
[144.671697] Starting dynamic subtest: C-HDMI-A1
[150.013811] Dynamic subtest C-HDMI-A1: SUCCESS (5.354s)
[150.032424] Starting dynamic subtest: A-HDMI-A2
[155.416294] Dynamic subtest A-HDMI-A2: SUCCESS (5.393s)
[155.429332] Starting dynamic subtest: B-HDMI-A2
[160.792316] Dynamic subtest B-HDMI-A2: SUCCESS (5.373s)
[160.805724] Starting dynamic subtest: C-HDMI-A2
[166.173823] Dynamic subtest C-HDMI-A2: SUCCESS (5.378s)
[166.175068] Subtest flip-vs-rmfb: SUCCESS (32.557s)
[166.587481] [043/142] (834s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[166.779869] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[166.787178] Starting dynamic subtest: pipe-A-valid-mode
[167.221223] Dynamic subtest pipe-A-valid-mode: SKIP (0.432s)
[167.223764] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.440s)
[167.451026] [044/142] (833s left) gem_wait (invalid-buf)
[167.566364] Starting subtest: invalid-buf
[167.567808] Subtest invalid-buf: SUCCESS (0.000s)
[167.819848] [045/142] (833s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[168.018980] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[168.021273] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[168.111334] [046/142] (832s left) gen9_exec_parse (bb-secure)
[168.236732] Starting subtest: bb-secure
[168.242149] Subtest bb-secure: SUCCESS (0.003s)
[168.454950] [047/142] (832s left) gem_create (create-ext-placement-all)
[168.686763] Starting subtest: create-ext-placement-all
[168.688672] Subtest create-ext-placement-all: SUCCESS (0.000s)
[168.769434] [048/142] (832s left) drm_fdinfo (idle)
[168.882772] Starting subtest: idle
[168.884107] Starting dynamic subtest: rcs0
[169.391160] Dynamic subtest rcs0: SUCCESS (0.506s)
[169.404392] Starting dynamic subtest: bcs0
[169.899953] Dynamic subtest bcs0: SUCCESS (0.504s)
[169.912244] Starting dynamic subtest: vcs0
[170.410895] Dynamic subtest vcs0: SUCCESS (0.504s)
[170.423353] Starting dynamic subtest: vecs0
[170.917940] Dynamic subtest vecs0: SUCCESS (0.505s)
[170.919088] Subtest idle: SUCCESS (2.035s)
[171.003589] [049/142] (830s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[171.223165] Starting subtest: cursor-rapid-movement-512x170
[171.229200] Subtest cursor-rapid-movement-512x170: SKIP (0.005s)
[171.318355] [050/142] (829s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[171.426838] Starting subtest: multi-wait-all-for-submit-unsubmitted
[171.536544] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[171.619740] [051/142] (829s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[171.726578] Starting subtest: multi-wait-for-submit-unsubmitted
[171.833039] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[171.918796] [052/142] (829s left) kms_lease (lease_again)
[172.111090] Starting subtest: lease_again
[172.112422] Starting dynamic subtest: pipe-A-HDMI-A-1
[172.124900] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.010s)
[172.159076] Starting dynamic subtest: pipe-A-HDMI-A-2
[172.160139] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[172.189738] Starting dynamic subtest: pipe-B-HDMI-A-1
[172.190893] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[172.218926] Starting dynamic subtest: pipe-B-HDMI-A-2
[172.220085] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.005s)
[172.233681] Starting dynamic subtest: pipe-C-HDMI-A-1
[172.234757] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.005s)
[172.246237] Starting dynamic subtest: pipe-C-HDMI-A-2
[172.248391] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.004s)
[172.250776] Subtest lease_again: SUCCESS (0.073s)
[172.281422] [053/142] (829s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[172.491556] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[172.495443] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[172.584256] [054/142] (828s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[172.762578] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[172.765998] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[175.141930] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (2.369s)
[175.156139] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[177.048619] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.899s)
[177.060451] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[178.858309] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.801s)
[178.859400] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (6.091s)
[179.132622] [055/142] (822s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[179.344244] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[179.346740] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[179.432627] [056/142] (821s left) kms_vblank (pipe-d-accuracy-idle)
[179.623907] Subtest pipe-D-accuracy-idle: SKIP (0.000s)
[179.696983] [057/142] (821s left) perf (create-destroy-userspace-config)
[179.925812] Starting subtest: create-destroy-userspace-config
[179.968315] Subtest create-destroy-userspace-config: SUCCESS (0.044s)
[180.016814] [058/142] (821s left) gem_exec_fence (syncobj-channel)
[180.600374] Starting subtest: syncobj-channel
[181.660200] Subtest syncobj-channel: SUCCESS (1.059s)
[181.984111] [059/142] (819s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[182.188912] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[184.317055] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SUCCESS (2.130s)
[184.466170] [060/142] (817s left) kms_concurrent (pipe-b)
[184.660096] Starting subtest: pipe-B
[184.664825] Starting dynamic subtest: HDMI-A-1
[185.671862] Dynamic subtest HDMI-A-1: SUCCESS (1.008s)
[185.700063] Starting dynamic subtest: HDMI-A-2
[186.437628] Dynamic subtest HDMI-A-2: SUCCESS (0.751s)
[186.440025] Subtest pipe-B: SUCCESS (1.775s)
[186.713877] [061/142] (814s left) kms_pm_lpsp (screens-disabled)
[187.908403] Starting subtest: screens-disabled
[187.911773] Subtest screens-disabled: SKIP (0.000s)
[188.080898] [062/142] (813s left) gem_linear_blits (basic)
[189.189303] Starting subtest: basic
[189.200464] Subtest basic: SUCCESS (0.013s)
[189.324672] [063/142] (812s left) kms_color (ctm-0-75)
[189.620824] Starting subtest: ctm-0-75
[189.622589] Starting dynamic subtest: pipe-A
[192.226653] Dynamic subtest pipe-A: SUCCESS (2.601s)
[192.244106] Starting dynamic subtest: pipe-B
[194.535680] Dynamic subtest pipe-B: SUCCESS (2.301s)
[194.553782] Starting dynamic subtest: pipe-C
[196.852798] Dynamic subtest pipe-C: SUCCESS (2.315s)
[196.856086] Subtest ctm-0-75: SUCCESS (7.231s)
[197.124552] [064/142] (804s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[197.325589] Starting subtest: cursor-vs-flip-varying-size
[234.612596] Subtest cursor-vs-flip-varying-size: SUCCESS (37.291s)
[234.887874] [065/142] (766s left) gem_exec_fence (parallel)
[235.143676] Starting subtest: parallel
[235.144898] Starting dynamic subtest: rcs0
[237.299607] Dynamic subtest rcs0: SUCCESS (2.152s)
[237.317947] Starting dynamic subtest: bcs0
[239.455887] Dynamic subtest bcs0: SUCCESS (2.154s)
[239.475438] Starting dynamic subtest: vcs0
[241.613262] Dynamic subtest vcs0: SUCCESS (2.155s)
[241.629211] Starting dynamic subtest: vecs0
[243.770515] Dynamic subtest vecs0: SUCCESS (2.152s)
[243.771670] Subtest parallel: SUCCESS (8.626s)
[244.373747] [066/142] (757s left) kms_psr (sprite_blt)
[244.488160] Subtest sprite_blt: SKIP (0.000s)
[244.535555] [067/142] (757s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[244.656618] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[244.659916] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[244.855587] [068/142] (756s left) kms_cursor_crc (cursor-sliding-512x512)
[245.071591] Starting subtest: cursor-sliding-512x512
[245.079465] Subtest cursor-sliding-512x512: SKIP (0.004s)
[245.170247] [069/142] (756s left) gem_ctx_persistence (engines-mixed-process)
[245.287555] Starting subtest: engines-mixed-process
[245.288691] Starting dynamic subtest: rcs0
[245.622401] Dynamic subtest rcs0: SUCCESS (0.337s)
[245.681621] Starting dynamic subtest: bcs0
[245.962872] Dynamic subtest bcs0: SUCCESS (0.332s)
[245.992401] Starting dynamic subtest: vcs0
[246.293769] Dynamic subtest vcs0: SUCCESS (0.330s)
[246.327905] Starting dynamic subtest: vecs0
[246.635076] Dynamic subtest vecs0: SUCCESS (0.331s)
[246.636465] Subtest engines-mixed-process: SUCCESS (1.352s)
[246.733311] [070/142] (755s left) kms_atomic (crtc-invalid-params-fence)
[247.022266] Starting subtest: crtc-invalid-params-fence
[247.399200] Subtest crtc-invalid-params-fence: SUCCESS (0.379s)
[247.899704] [071/142] (753s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[248.106331] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[248.108489] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[248.197913] [072/142] (753s left) kms_vblank (pipe-d-wait-idle)
[248.387866] Subtest pipe-D-wait-idle: SKIP (0.000s)
[248.476259] [073/142] (753s left) v3d/v3d_submit_cl (bad-bo)
[248.637346] Subtest bad-bo: SKIP (0.000s)
[248.700972] [074/142] (753s left) kms_getfb (getfb-handle-not-fb)
[248.804027] Starting subtest: getfb-handle-not-fb
[248.891444] Subtest getfb-handle-not-fb: SUCCESS (0.087s)
[248.981082] [075/142] (753s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_mc_ccs)
[249.662637] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs
[249.668063] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[249.911988] [076/142] (752s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[250.640722] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[250.642876] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[250.880460] [077/142] (751s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs)
[251.616943] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[251.832998] [078/142] (750s left) kms_vblank (pipe-c-query-forked)
[252.025791] Starting subtest: pipe-C-query-forked
[257.427973] Subtest pipe-C-query-forked: SUCCESS (5.400s)
[257.634460] [079/142] (744s left) kms_hdr (bpc-switch)
[257.830054] Starting subtest: bpc-switch
[284.760761] Subtest bpc-switch: SKIP (26.930s)
[285.158514] [080/142] (717s left) gem_exec_flush (basic-wb-prw-default)
[285.304892] Starting subtest: basic-wb-prw-default
[290.715652] Subtest basic-wb-prw-default: SUCCESS (5.413s)
[290.910640] [081/142] (711s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged)
[291.093466] Subtest mark-unpurgeable-purged: SKIP (0.000s)
[291.160559] [082/142] (711s left) gem_eio (wait-wedge-1us)
[291.293439] Starting subtest: wait-wedge-1us
[291.379424] Subtest wait-wedge-1us: SUCCESS (0.085s)
[291.559378] [083/142] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[291.761759] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[291.764398] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[291.853780] [084/142] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[292.062916] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[292.066282] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[292.154290] [085/142] (710s left) gen7_exec_parse (oacontrol-tracking)
[292.269027] Subtest oacontrol-tracking: SKIP (0.000s)
[292.325434] [086/142] (710s left) gem_pipe_control_store_loop (reused-buffer)
[292.438300] Starting subtest: reused-buffer
[294.594748] Subtest reused-buffer: SUCCESS (2.154s)
[294.694934] [087/142] (707s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[295.355893] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[295.362193] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.006s)
[295.674902] [088/142] (706s left) kms_psr (psr2_primary_mmap_gtt)
[295.781622] Subtest psr2_primary_mmap_gtt: SKIP (0.000s)
[295.828489] [089/142] (706s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[295.932277] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[295.933486] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[296.010440] [090/142] (706s left) gem_lmem_swapping (massive)
[296.127311] Subtest massive: SKIP (0.000s)
[296.179933] [091/142] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[296.387664] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[296.390800] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[296.476059] [092/142] (706s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[296.681802] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[298.813069] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SUCCESS (2.131s)
[298.944672] [093/142] (703s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[299.642371] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[299.644541] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[299.929657] [094/142] (702s left) kms_flip (plain-flip-ts-check-interruptible)
[300.122249] Starting subtest: plain-flip-ts-check-interruptible
[300.129247] Starting dynamic subtest: A-HDMI-A1
[306.100213] Dynamic subtest A-HDMI-A1: SUCCESS (5.966s)
[306.117409] Starting dynamic subtest: B-HDMI-A1
[311.781124] Dynamic subtest B-HDMI-A1: SUCCESS (5.676s)
[311.796764] Starting dynamic subtest: C-HDMI-A1
[317.429913] Dynamic subtest C-HDMI-A1: SUCCESS (5.651s)
[317.449848] Starting dynamic subtest: A-HDMI-A2
[323.101695] Dynamic subtest A-HDMI-A2: SUCCESS (5.666s)
[323.123962] Starting dynamic subtest: B-HDMI-A2
[328.761678] Dynamic subtest B-HDMI-A2: SUCCESS (5.654s)
[328.778453] Starting dynamic subtest: C-HDMI-A2
[334.411601] Dynamic subtest C-HDMI-A2: SUCCESS (5.643s)
[334.413594] Subtest plain-flip-ts-check-interruptible: SUCCESS (34.286s)
[334.870588] [095/142] (667s left) kms_getfb (getfb-handle-zero)
[334.976170] Starting subtest: getfb-handle-zero
[334.977962] Subtest getfb-handle-zero: SUCCESS (0.000s)
[335.069665] [096/142] (667s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs)
[335.826918] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[336.047454] [097/142] (666s left) kms_psr (psr2_cursor_plane_onoff)
[336.152606] Subtest psr2_cursor_plane_onoff: SKIP (0.000s)
[336.201372] [098/142] (666s left) gem_mmap_gtt (cpuset-big-copy-odd)
[336.302138] Starting subtest: cpuset-big-copy-odd
[355.104060] Subtest cpuset-big-copy-odd: SUCCESS (18.796s)
[355.218164] [099/142] (647s left) kms_color (ctm-blue-to-red)
[355.516137] Starting subtest: ctm-blue-to-red
[355.517221] Starting dynamic subtest: pipe-A
[356.416615] Dynamic subtest pipe-A: SUCCESS (0.899s)
[356.434052] Starting dynamic subtest: pipe-B
[357.018108] Dynamic subtest pipe-B: SUCCESS (0.601s)
[357.050087] Starting dynamic subtest: pipe-C
[357.637115] Dynamic subtest pipe-C: SUCCESS (0.606s)
[357.638261] Subtest ctm-blue-to-red: SUCCESS (2.125s)
[357.858932] [100/142] (644s left) gem_exec_schedule (preempt-contexts)
[358.013602] Starting subtest: preempt-contexts
[358.019152] Starting dynamic subtest: rcs0
[358.093966] Dynamic subtest rcs0: SUCCESS (0.076s)
[358.124157] Starting dynamic subtest: bcs0
[358.205186] Dynamic subtest bcs0: SUCCESS (0.108s)
[358.235327] Starting dynamic subtest: vcs0
[358.289125] Dynamic subtest vcs0: SUCCESS (0.077s)
[358.310747] Starting dynamic subtest: vecs0
[358.374608] Dynamic subtest vecs0: SUCCESS (0.087s)
[358.377908] Subtest preempt-contexts: SUCCESS (0.360s)
[358.713781] [101/142] (644s left) kms_vblank (pipe-a-wait-busy-hang)
[358.907612] Starting subtest: pipe-A-wait-busy-hang
[372.903053] Subtest pipe-A-wait-busy-hang: SUCCESS (13.995s)
[373.112920] [102/142] (629s left) sw_sync (alloc_fence)
[373.217809] Starting subtest: alloc_fence
[373.220240] Subtest alloc_fence: SUCCESS (0.001s)
[373.290134] [103/142] (629s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[374.049498] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[374.051722] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[374.282210] [104/142] (628s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[374.488383] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[374.490562] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[374.576882] [105/142] (628s left) gem_exec_balancer (parallel-contexts)
[377.622118] Subtest parallel-contexts: SKIP (0.000s)
[377.712135] [106/142] (625s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[377.917063] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[378.994610] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.077s)
[379.251166] [107/142] (623s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted-sign
[379.361707] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted-signaled
[379.362882] Subtest invalid-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[379.449698] [108/142] (623s left) gem_mmap (basic-small-bo)
[379.557249] Starting subtest: basic-small-bo
[379.784629] Subtest basic-small-bo: SUCCESS (0.230s)
[379.902975] [109/142] (623s left) kms_ccs (pipe-a-bad-pixel-format-yf_tiled_ccs)
[380.204253] Starting subtest: pipe-A-bad-pixel-format-yf_tiled_ccs
[380.205403] Subtest pipe-A-bad-pixel-format-yf_tiled_ccs: SUCCESS (0.001s)
[380.999096] [110/142] (622s left) vc4/vc4_wait_bo (used-bo)
[381.179789] Subtest used-bo: SKIP (0.000s)
[381.249634] [111/142] (621s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[381.895627] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[381.897987] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[382.287855] [112/142] (620s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[382.486216] Starting subtest: addfb25-y-tiled-small-legacy
[382.487297] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[382.572869] [113/142] (620s left) kms_flip (2x-plain-flip-ts-check)
[382.760107] Starting subtest: 2x-plain-flip-ts-check
[382.769087] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[393.957603] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.186s)
[393.978896] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[404.962427] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.000s)
[404.986542] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[415.949139] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.975s)
[415.950813] Subtest 2x-plain-flip-ts-check: SUCCESS (33.181s)
[416.472948] [114/142] (586s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[416.665854] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[420.331075] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.655s)
[420.584463] [115/142] (582s left) perf (invalid-open-flags)
[420.798567] Starting subtest: invalid-open-flags
[420.799696] Subtest invalid-open-flags: SUCCESS (0.001s)
[420.850409] [116/142] (582s left) gem_mmap_offset (clear)
[420.957701] Starting subtest: clear
[420.958942] Starting dynamic subtest: smem0
[442.651045] Dynamic subtest smem0: SUCCESS (21.685s)
[442.652064] Subtest clear: SUCCESS (21.688s)
[442.748283] [117/142] (560s left) gem_pxp (reject-modify-context-protection-off-2)
[445.405413] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[445.485404] [118/142] (557s left) gem_vm_create (create-ext)
[445.595984] Starting subtest: create-ext
[445.600886] Subtest create-ext: SUCCESS (0.004s)
[445.699410] [119/142] (557s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[445.908726] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[445.912961] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[445.999732] [120/142] (557s left) kms_cursor_legacy (single-move)
[446.182850] Starting subtest: single-move
[446.186166] Starting dynamic subtest: pipe-A
[451.590188] Dynamic subtest pipe-A: SUCCESS (5.401s)
[451.615828] Starting dynamic subtest: pipe-B
[456.987787] Dynamic subtest pipe-B: SUCCESS (5.398s)
[457.004290] Starting dynamic subtest: pipe-C
[462.388512] Dynamic subtest pipe-C: SUCCESS (5.396s)
[462.405036] Starting dynamic subtest: all-pipes
[467.786862] Dynamic subtest all-pipes: SUCCESS (5.397s)
[467.789076] Subtest single-move: SUCCESS (21.603s)
[467.885219] [121/142] (535s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_mc_ccs)
[468.636635] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[468.858218] [122/142] (534s left) gem_softpin (allocator-fork)
[468.972923] Starting subtest: allocator-fork
[471.326077] Subtest allocator-fork: SUCCESS (2.352s)
[471.427666] [123/142] (532s left) gem_mmap_gtt (basic)
[471.533326] Starting subtest: basic
[471.534618] Subtest basic: SUCCESS (0.001s)
[471.614590] [124/142] (531s left) kms_plane_alpha_blend (alpha-transparent-fb)
[471.807646] Starting subtest: alpha-transparent-fb
[471.977694] Starting dynamic subtest: pipe-A-HDMI-A-1
[472.889837] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.571s)
[472.905661] Starting dynamic subtest: pipe-C-HDMI-A-1
[473.556308] Dynamic subtest pipe-C-HDMI-A-1: FAIL (0.593s)
[473.559807] Subtest alpha-transparent-fb: FAIL (1.339s)
[473.607612] [125/142] (530s left) gem_mmap_gtt (basic-small-copy-odd)
[473.716586] Starting subtest: basic-small-copy-odd
[476.144785] Subtest basic-small-copy-odd: SUCCESS (2.426s)
[476.230180] [126/142] (527s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[476.539230] Starting subtest: x-tiled-8bpp-rotate-270
[476.835108] Subtest x-tiled-8bpp-rotate-270: SKIP (0.289s)
[477.043790] [127/142] (526s left) v3d/v3d_perfmon (create-perfmon-0)
[477.225808] Subtest create-perfmon-0: SKIP (0.000s)
[477.292561] [128/142] (526s left) gem_ctx_sseu (invalid-sseu)
[477.407287] Subtest invalid-sseu: SKIP (0.000s)
[477.464886] [129/142] (526s left) gem_ppgtt (flink-and-close-vma-leak)
[477.578954] Starting subtest: flink-and-close-vma-leak
[477.587829] Subtest flink-and-close-vma-leak: SUCCESS (0.011s)
[477.694351] [130/142] (526s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[477.883744] Starting subtest: flip-vs-cursor-crc-legacy
[478.920898] Subtest flip-vs-cursor-crc-legacy: SUCCESS (1.039s)
[479.236969] [131/142] (524s left) gem_ctx_persistence (engines-hang)
[479.351775] Starting subtest: engines-hang
[479.355283] Starting dynamic subtest: rcs0
[479.395494] Dynamic subtest rcs0: SUCCESS (0.040s)
[479.417170] Starting dynamic subtest: bcs0
[479.420165] Dynamic subtest bcs0: SKIP (0.005s)
[479.437260] Starting dynamic subtest: vcs0
[479.438344] Dynamic subtest vcs0: SUCCESS (0.028s)
[479.455990] Starting dynamic subtest: vecs0
[479.459645] Dynamic subtest vecs0: SUCCESS (0.022s)
[479.462616] Subtest engines-hang: SUCCESS (0.109s)
[479.560546] [132/142] (524s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[479.722318] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[479.792742] [133/142] (524s left) perf_pmu (most-busy-idle-check-all)
[479.908960] Starting subtest: most-busy-idle-check-all
[479.910236] Starting dynamic subtest: rcs0
[480.526209] Dynamic subtest rcs0: SUCCESS (0.619s)
[480.546388] Starting dynamic subtest: bcs0
[481.148383] Dynamic subtest bcs0: SUCCESS (0.615s)
[481.164147] Starting dynamic subtest: vcs0
[481.766926] Dynamic subtest vcs0: SUCCESS (0.617s)
[481.782279] Starting dynamic subtest: vecs0
[482.381564] Dynamic subtest vecs0: SUCCESS (0.616s)
[482.382762] Subtest most-busy-idle-check-all: SUCCESS (2.476s)
[482.476652] [134/142] (521s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[482.681368] Starting subtest: fbcpsr-tiling-4
[482.684948] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[482.773822] [135/142] (521s left) gem_render_copy_redux (normal)
[482.889242] Starting subtest: normal
[484.385673] Subtest normal: SUCCESS (1.493s)
[484.493742] [136/142] (519s left) i915_pm_rpm (i2c)
[486.421756] Starting subtest: i2c
[489.183451] Subtest i2c: SUCCESS (2.758s)
[489.493697] [137/142] (514s left) sysfs_preempt_timeout (timeout)
[489.608315] Starting subtest: timeout
[489.611921] Starting dynamic subtest: vecs0
[490.426595] Dynamic subtest vecs0: SUCCESS (0.813s)
[490.446221] Starting dynamic subtest: vcs0
[491.247237] Dynamic subtest vcs0: SUCCESS (0.817s)
[491.267212] Starting dynamic subtest: bcs0
[492.072291] Dynamic subtest bcs0: SUCCESS (0.821s)
[492.090155] Starting dynamic subtest: rcs0
[492.892669] Dynamic subtest rcs0: SUCCESS (0.820s)
[492.893884] Subtest timeout: SUCCESS (3.285s)
[492.980679] [138/142] (511s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[493.683364] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs
[493.685534] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[493.965790] [139/142] (510s left) kms_vblank (pipe-b-ts-continuation-modeset)
[494.161782] Starting subtest: pipe-B-ts-continuation-modeset
[496.059130] Subtest pipe-B-ts-continuation-modeset: SUCCESS (1.895s)
[496.338589] [140/142] (507s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[497.034695] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[497.041652] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.003s)
[497.359052] [141/142] (506s left) gem_ccs (block-copy-compressed)
[497.475181] Subtest block-copy-compressed: SKIP (0.000s)
[497.529103] [142/142] (506s left) gem_exec_schedule (lateslice)
[497.664163] Starting subtest: lateslice
[497.665333] Starting dynamic subtest: rcs0
[497.692168] Dynamic subtest rcs0: SUCCESS (0.029s)
[497.713631] Starting dynamic subtest: bcs0
[497.723316] Dynamic subtest bcs0: SUCCESS (0.027s)
[497.747183] Starting dynamic subtest: vcs0
[497.753787] Dynamic subtest vcs0: SUCCESS (0.022s)
[497.774810] Starting dynamic subtest: vecs0
[497.776145] Dynamic subtest vecs0: SUCCESS (0.021s)
[497.777374] Subtest lateslice: SUCCESS (0.112s)
[498.100805] Closing watchdogs
Done.