[42.795719] Initializing watchdogs
[42.796115]   /dev/watchdog0
[42.812327] [001/142] (960s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[43.045412] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[43.156772] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.110s)
[43.242333] [002/142] (960s left) i915_pm_rps (thresholds)
[43.477435] Starting subtest: thresholds
[43.479110] Starting dynamic subtest: gt0
[43.494407] Dynamic subtest gt0: SKIP (0.013s)
[43.497481] Subtest thresholds: SKIP (0.014s)
[43.588758] [003/142] (959s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[44.268814] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[44.585120] [004/142] (958s left) perf (oa-exponents)
[44.940927] Starting subtest: oa-exponents
[44.942787] Starting dynamic subtest: 0-rcs0
[49.038164] Dynamic subtest 0-rcs0: SUCCESS (4.094s)
[49.039447] Subtest oa-exponents: SUCCESS (4.095s)
[49.093438] [005/142] (954s left) syncobj_basic (test-valid-cycle)
[49.297242] Starting subtest: test-valid-cycle
[49.298878] Subtest test-valid-cycle: SUCCESS (0.000s)
[49.389779] [006/142] (954s left) gem_mmap_gtt (basic-short)
[49.604508] Starting subtest: basic-short
[49.658712] Subtest basic-short: SUCCESS (0.055s)
[49.769083] [007/142] (953s left) gem_eio (wait-10ms)
[50.006403] Starting subtest: wait-10ms
[50.103564] Subtest wait-10ms: SUCCESS (0.097s)
[50.307158] [008/142] (953s left) kms_universal_plane (universal-plane-pipe-d-sanity)
[50.617200] Subtest universal-plane-pipe-D-sanity: SKIP (0.000s)
[50.704168] [009/142] (952s left) i915_pciid
[50.986770] [010/142] (952s left) gem_exec_capture (pi)
[51.206368] Starting subtest: pi
[51.207898] Starting dynamic subtest: rcs0
[81.588573] Dynamic subtest rcs0: SUCCESS (30.383s)
[81.607460] Starting dynamic subtest: bcs0
[112.217441] Dynamic subtest bcs0: SUCCESS (30.629s)
[112.236973] Starting dynamic subtest: vcs0
[141.653989] Dynamic subtest vcs0: SUCCESS (29.435s)
[141.670578] Starting dynamic subtest: vecs0
[171.536148] Dynamic subtest vecs0: SUCCESS (29.882s)
[171.537594] Subtest pi: SUCCESS (120.331s)
[171.625981] [011/142] (832s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_ccs)
[172.062911] Starting subtest: pipe-A-bad-pixel-format-y_tiled_ccs
[172.064623] Subtest pipe-A-bad-pixel-format-y_tiled_ccs: SUCCESS (0.001s)
[172.776749] [012/142] (830s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[173.098654] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[173.101525] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[173.192585] [013/142] (830s left) gem_userptr_blits (stress-mm-invalidate-close)
[173.445465] Starting subtest: stress-mm-invalidate-close
[175.595395] Subtest stress-mm-invalidate-close: SUCCESS (2.149s)
[175.741891] [014/142] (828s left) kms_properties (connector-properties-legacy)
[176.043291] Starting subtest: connector-properties-legacy
[178.571995] Subtest connector-properties-legacy: SUCCESS (2.530s)
[178.887555] [015/142] (824s left) gem_partial_pwrite_pread (writes-after-reads-display)
[179.108174] Starting subtest: writes-after-reads-display
[199.720584] Subtest writes-after-reads-display: SUCCESS (20.613s)
[199.834964] [016/142] (804s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[200.148651] Starting subtest: cursorB-vs-flipB-atomic-transitions
[200.152175] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.003s)
[200.236296] [017/142] (803s left) perf (low-oa-exponent-permissions)
[200.574054] Starting subtest: low-oa-exponent-permissions
[200.720535] Subtest low-oa-exponent-permissions: SUCCESS (0.148s)
[200.769308] [018/142] (803s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[201.421718] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[201.426102] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[201.770993] [019/142] (802s left) kms_plane (plane-position-covered)
[202.075738] Starting subtest: plane-position-covered
[202.077224] Starting dynamic subtest: pipe-A-planes
[203.557073] Dynamic subtest pipe-A-planes: SUCCESS (1.482s)
[203.576224] Starting dynamic subtest: pipe-B-planes
[205.385452] Dynamic subtest pipe-B-planes: SUCCESS (1.825s)
[205.386954] Subtest plane-position-covered: SUCCESS (3.313s)
[205.718208] [020/142] (798s left) kms_setmode (invalid-clone-single-crtc-stealing)
[205.923742] Starting subtest: invalid-clone-single-crtc-stealing
[205.929677] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[206.001405] [021/142] (798s left) gem_partial_pwrite_pread (write-display)
[206.210824] Starting subtest: write-display
[220.540996] Subtest write-display: SUCCESS (14.330s)
[220.650439] [022/142] (783s left) gem_ctx_persistence (engines-hang)
[220.870166] Starting subtest: engines-hang
[220.871894] Starting dynamic subtest: rcs0
[220.913201] Dynamic subtest rcs0: SUCCESS (0.042s)
[220.931275] Starting dynamic subtest: bcs0
[220.936936] Dynamic subtest bcs0: SKIP (0.005s)
[220.953829] Starting dynamic subtest: vcs0
[220.959904] Dynamic subtest vcs0: SUCCESS (0.041s)
[220.979987] Starting dynamic subtest: vecs0
[221.000363] Dynamic subtest vecs0: SUCCESS (0.039s)
[221.001974] Subtest engines-hang: SUCCESS (0.129s)
[221.089565] [023/142] (783s left) gem_exec_params (invalid-batch-start-offset)
[221.305208] Starting subtest: invalid-batch-start-offset
[221.316122] Subtest invalid-batch-start-offset: SUCCESS (0.009s)
[221.417625] [024/142] (782s left) gem_exec_fence (syncobj-timeline-wait)
[222.301413] Starting subtest: syncobj-timeline-wait
[222.337966] Subtest syncobj-timeline-wait: SUCCESS (0.037s)
[222.550839] [025/142] (781s left) kms_psr (psr2_cursor_plane_move)
[222.758209] Subtest psr2_cursor_plane_move: SKIP (0.000s)
[222.815960] [026/142] (781s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[223.120628] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[223.123371] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[223.218573] [027/142] (781s left) gem_mmap_gtt (fault-concurrent)
[223.424885] Starting subtest: fault-concurrent
[226.839394] Subtest fault-concurrent: SUCCESS (3.415s)
[227.086243] [028/142] (777s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[227.549554] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[227.552530] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[228.115310] [029/142] (776s left) syncobj_basic (illegal-fd-to-handle)
[228.322488] Starting subtest: illegal-fd-to-handle
[228.324018] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[228.414854] [030/142] (775s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[229.032811] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[229.035759] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[229.420231] [031/142] (774s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[229.726999] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[229.729598] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[229.837040] [032/142] (774s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[230.153332] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[230.156126] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[230.253511] [033/142] (774s left) kms_flip (2x-wf_vblank-ts-check)
[230.548177] Starting subtest: 2x-wf_vblank-ts-check
[230.551098] Subtest 2x-wf_vblank-ts-check: SKIP (0.003s)
[230.654286] [034/142] (773s left) gem_busy (parallel)
[231.024504] Starting subtest: parallel
[231.025985] Starting dynamic subtest: rcs0
[231.072186] Dynamic subtest rcs0: SUCCESS (0.049s)
[231.101782] Starting dynamic subtest: bcs0
[231.113216] Dynamic subtest bcs0: SUCCESS (0.040s)
[231.132323] Starting dynamic subtest: vcs0
[231.158045] Dynamic subtest vcs0: SUCCESS (0.044s)
[231.186456] Starting dynamic subtest: vecs0
[231.197718] Dynamic subtest vecs0: SUCCESS (0.039s)
[231.199233] Subtest parallel: SUCCESS (0.176s)
[231.438161] [035/142] (773s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[231.752497] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[231.755259] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[231.836822] [036/142] (772s left) perf_pmu (module-unload)
[232.065267] Starting subtest: module-unload
[270.431127] Subtest module-unload: SUCCESS (38.366s)
[270.464250] [037/142] (734s left) kms_atomic (plane-invalid-params-fence)
[273.939962] Starting subtest: plane-invalid-params-fence
[274.059986] Subtest plane-invalid-params-fence: SUCCESS (0.122s)
[274.611959] [038/142] (730s left) perf (disabled-read-error)
[274.953436] Starting subtest: disabled-read-error
[275.058929] Subtest disabled-read-error: SUCCESS (0.102s)
[275.113366] [039/142] (729s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_rc_ccs)
[275.566494] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs
[275.569302] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[275.989302] [040/142] (728s left) gem_userptr_blits (unsync-unmap-after-close)
[276.213950] Subtest unsync-unmap-after-close: SKIP (0.000s)
[276.373279] [041/142] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[276.685141] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[276.688028] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[276.788595] [042/142] (728s left) gem_mmap_offset (ptrace)
[276.995514] Starting subtest: ptrace
[277.009659] Starting dynamic subtest: smem0-gtt
[277.094361] Dynamic subtest smem0-gtt: SUCCESS (0.085s)
[277.112445] Starting dynamic subtest: smem0-wb
[277.175480] Dynamic subtest smem0-wb: SUCCESS (0.079s)
[277.193704] Starting dynamic subtest: smem0-wc
[277.253411] Dynamic subtest smem0-wc: SUCCESS (0.077s)
[277.274043] Starting dynamic subtest: smem0-uc
[277.334969] Dynamic subtest smem0-uc: SUCCESS (0.078s)
[277.336506] Subtest ptrace: SUCCESS (0.341s)
[277.456417] [043/142] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[277.776454] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[277.779499] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[277.872864] [044/142] (727s left) v3d/v3d_submit_cl (bad-multisync-out-sync)
[278.134644] Subtest bad-multisync-out-sync: SKIP (0.000s)
[278.204604] [045/142] (726s left) kms_color (ctm-max)
[278.505238] Starting subtest: ctm-max
[278.506638] Starting dynamic subtest: pipe-A
[279.032164] Dynamic subtest pipe-A: SUCCESS (0.527s)
[279.052609] Starting dynamic subtest: pipe-B
[279.871687] Dynamic subtest pipe-B: SUCCESS (0.835s)
[279.896524] Starting dynamic subtest: pipe-C
[280.860149] Dynamic subtest pipe-C: SUCCESS (0.991s)
[280.861812] Subtest ctm-max: SUCCESS (2.358s)
[281.198925] [046/142] (723s left) vc4/vc4_wait_bo (unused-bo-1ns)
[281.460197] Subtest unused-bo-1ns: SKIP (0.000s)
[281.531448] [047/142] (723s left) kms_rotation_crc (primary-rotation-270)
[281.839978] Starting subtest: primary-rotation-270
[288.027452] Subtest primary-rotation-270: SUCCESS (6.190s)
[288.438586] [048/142] (716s left) kms_big_fb (linear-16bpp-rotate-270)
[288.764082] Starting subtest: linear-16bpp-rotate-270
[288.855959] Subtest linear-16bpp-rotate-270: SKIP (0.090s)
[288.972187] [049/142] (716s left) kms_color (invalid-ctm-matrix-sizes)
[289.281240] Starting subtest: invalid-ctm-matrix-sizes
[289.282628] Starting dynamic subtest: pipe-A
[289.286215] Dynamic subtest pipe-A: SUCCESS (0.007s)
[289.304685] Starting dynamic subtest: pipe-B
[289.306117] Dynamic subtest pipe-B: SUCCESS (0.010s)
[289.324969] Starting dynamic subtest: pipe-C
[289.326596] Dynamic subtest pipe-C: SUCCESS (0.013s)
[289.328030] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.035s)
[289.406278] [050/142] (715s left) gem_pwrite (basic-random)
[289.615262] Starting subtest: basic-random
[296.397614] Subtest basic-random: SUCCESS (6.782s)
[296.530123] [051/142] (708s left) kms_frontbuffer_tracking (fbc-tiling-y)
[296.987077] Starting subtest: fbc-tiling-y
[299.213890] Subtest fbc-tiling-y: SUCCESS (2.230s)
[299.338990] [052/142] (705s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[299.670321] Starting subtest: y-tiled-8bpp-rotate-270
[299.755934] Subtest y-tiled-8bpp-rotate-270: SKIP (0.084s)
[299.871797] [053/142] (705s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[300.178653] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[300.181466] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[300.272438] [054/142] (705s left) kms_addfb_basic (basic-x-tiled-legacy)
[300.482634] Starting subtest: basic-x-tiled-legacy
[300.484104] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[300.672229] [055/142] (704s left) gem_fenced_exec_thrash (2-spare-fences)
[300.891675] Starting subtest: 2-spare-fences
[303.058049] Subtest 2-spare-fences: SUCCESS (2.164s)
[303.221573] [056/142] (702s left) kms_draw_crc (draw-method-blt)
[303.534945] Starting subtest: draw-method-blt
[303.536600] Starting dynamic subtest: xrgb8888-untiled
[303.863465] Dynamic subtest xrgb8888-untiled: SUCCESS (0.329s)
[303.883146] Starting dynamic subtest: rgb565-untiled
[304.163091] Dynamic subtest rgb565-untiled: SUCCESS (0.298s)
[304.184321] Starting dynamic subtest: xrgb2101010-untiled
[304.480364] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.315s)
[304.502155] Starting dynamic subtest: xrgb8888-xtiled
[304.663239] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.181s)
[304.686053] Starting dynamic subtest: rgb565-xtiled
[304.829818] Dynamic subtest rgb565-xtiled: SUCCESS (0.165s)
[304.850956] Starting dynamic subtest: xrgb2101010-xtiled
[305.015165] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.182s)
[305.034324] Starting dynamic subtest: xrgb8888-ytiled
[305.213523] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.198s)
[305.233804] Starting dynamic subtest: rgb565-ytiled
[305.379791] Dynamic subtest rgb565-ytiled: SUCCESS (0.165s)
[305.399130] Starting dynamic subtest: xrgb2101010-ytiled
[305.563803] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.182s)
[305.565650] Subtest draw-method-blt: SUCCESS (2.031s)
[305.688392] [057/142] (699s left) gem_exec_balancer (bonded-semaphore)
[305.921112] Starting subtest: bonded-semaphore
[309.538255] Subtest bonded-semaphore: SUCCESS (3.616s)
[313.471357] [058/142] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[313.783253] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[316.380840] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.600s)
[316.521907] [059/142] (688s left) gem_exec_schedule (promotion)
[316.778290] Starting subtest: promotion
[316.780124] Starting dynamic subtest: rcs0
[316.941689] Dynamic subtest rcs0: SUCCESS (0.161s)
[316.967203] Starting dynamic subtest: bcs0
[317.105111] Dynamic subtest bcs0: SUCCESS (0.162s)
[317.130149] Starting dynamic subtest: vcs0
[317.249768] Dynamic subtest vcs0: SUCCESS (0.141s)
[317.273496] Starting dynamic subtest: vecs0
[317.391655] Dynamic subtest vecs0: SUCCESS (0.142s)
[317.393363] Subtest promotion: SUCCESS (0.614s)
[317.757412] [060/142] (687s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[318.073184] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[318.076082] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[318.172664] [061/142] (687s left) core_setmaster_vs_auth
[318.472466] [062/142] (687s left) api_intel_bb (intel-bb-blit-y)
[318.680482] Starting subtest: intel-bb-blit-y
[321.931670] Subtest intel-bb-blit-y: SUCCESS (3.252s)
[322.055689] [063/142] (683s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[322.466732] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[322.754702] [064/142] (682s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[323.228182] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[323.233760] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.005s)
[323.754388] [065/142] (681s left) perf_pmu (busy-accuracy-98)
[323.970337] Starting subtest: busy-accuracy-98
[323.971927] Starting dynamic subtest: rcs0
[327.027759] Dynamic subtest rcs0: SUCCESS (3.055s)
[327.046652] Starting dynamic subtest: bcs0
[330.092050] Dynamic subtest bcs0: SUCCESS (3.063s)
[330.111024] Starting dynamic subtest: vcs0
[333.152309] Dynamic subtest vcs0: SUCCESS (3.057s)
[333.171290] Starting dynamic subtest: vecs0
[336.210649] Dynamic subtest vecs0: SUCCESS (3.056s)
[336.212157] Subtest busy-accuracy-98: SUCCESS (12.239s)
[336.304531] [066/142] (669s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[336.614754] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[336.617951] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[336.721782] [067/142] (669s left) gem_ctx_engines (execute-one)
[336.953632] Starting subtest: execute-one
[340.000901] Subtest execute-one: SUCCESS (3.047s)
[340.222671] [068/142] (665s left) syncobj_timeline (wait-delayed-signal)
[340.433038] Starting subtest: wait-delayed-signal
[340.537326] Subtest wait-delayed-signal: SUCCESS (0.103s)
[340.621395] [069/142] (665s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_rc_ccs)
[341.091089] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs
[341.094375] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[341.625582] [070/142] (664s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[341.834661] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[341.939494] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[342.025727] [071/142] (663s left) kms_cursor_crc (cursor-offscreen-256x85)
[342.354675] Starting subtest: cursor-offscreen-256x85
[342.366567] Starting dynamic subtest: pipe-A-DP-1
[345.048673] Dynamic subtest pipe-A-DP-1: SUCCESS (2.683s)
[345.140805] Starting dynamic subtest: pipe-C-DP-1
[347.953822] Dynamic subtest pipe-C-DP-1: SUCCESS (2.832s)
[347.955365] Subtest cursor-offscreen-256x85: SUCCESS (5.599s)
[348.314414] [072/142] (657s left) gem_exec_reloc (basic-cpu-read-active)
[348.533198] Starting subtest: basic-cpu-read-active
[348.676778] Subtest basic-cpu-read-active: SUCCESS (0.143s)
[348.878126] [073/142] (657s left) gem_mmap_gtt (fault-concurrent-x)
[349.084759] Starting subtest: fault-concurrent-X
[352.483194] Subtest fault-concurrent-X: SUCCESS (3.398s)
[352.727843] [074/142] (653s left) syncobj_timeline (wait-any-complex)
[352.938402] Starting subtest: wait-any-complex
[353.004248] Subtest wait-any-complex: SUCCESS (0.065s)
[353.093857] [075/142] (653s left) i915_pm_rpm (modeset-non-lpsp-stress-no-wait)
[354.989874] Starting subtest: modeset-non-lpsp-stress-no-wait
[360.179040] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (5.189s)
[360.402736] [076/142] (645s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[360.942566] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[360.945560] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[361.399915] [077/142] (644s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[361.734371] Starting subtest: yf-tiled-addfb-size-overflow
[361.738779] Subtest yf-tiled-addfb-size-overflow: SUCCESS (0.002s)
[361.834404] [078/142] (644s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[362.152817] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[362.154316] Starting dynamic subtest: pipe-A-valid-mode
[362.259096] Dynamic subtest pipe-A-valid-mode: SKIP (0.105s)
[362.263195] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.109s)
[362.590091] [079/142] (643s left) kms_cursor_crc (cursor-sliding-32x10)
[362.904074] Starting subtest: cursor-sliding-32x10
[363.033266] Subtest cursor-sliding-32x10: SKIP (0.127s)
[363.156584] [080/142] (643s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[363.844879] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[364.173721] [081/142] (642s left) vc4/vc4_create_bo (create-bo-zeroed)
[364.431929] Subtest create-bo-zeroed: SKIP (0.000s)
[364.506793] [082/142] (641s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[364.826134] Starting subtest: psr-rgb101010-draw-mmap-wc
[364.829892] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[364.923953] [083/142] (641s left) kms_vblank (pipe-b-query-forked-busy-hang)
[365.226850] Starting subtest: pipe-B-query-forked-busy-hang
[373.016713] Subtest pipe-B-query-forked-busy-hang: SUCCESS (7.790s)
[373.357299] [084/142] (633s left) syncobj_timeline (reset-during-wait-for-submit)
[373.565993] Starting subtest: reset-during-wait-for-submit
[373.670465] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[373.767176] [085/142] (632s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs)
[374.418909] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs
[374.421858] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[374.755918] [086/142] (631s left) prime_mmap (test_map_unmap)
[374.965599] Starting subtest: test_map_unmap
[374.967196] Starting dynamic subtest: test_map_unmap-smem
[374.975075] Dynamic subtest test_map_unmap-smem: SUCCESS (0.007s)
[374.976573] Subtest test_map_unmap: SUCCESS (0.010s)
[375.072189] [087/142] (631s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[375.390554] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[375.394184] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[375.505950] [088/142] (631s left) gem_userptr_blits (probe)
[375.781778] Starting subtest: probe
[377.048805] Subtest probe: SUCCESS (1.267s)
[377.156595] [089/142] (629s left) gem_render_copy (yf-tiled)
[377.384993] Starting subtest: yf-tiled
[377.386661] Starting dynamic subtest: smem
[377.764973] Dynamic subtest smem: SUCCESS (0.379s)
[377.767184] Subtest yf-tiled: SUCCESS (0.382s)
[377.974293] [090/142] (628s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[378.492102] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[378.494880] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[378.973388] [091/142] (627s left) gem_mmap_gtt (big-bo-tiledy)
[379.178184] Starting subtest: big-bo-tiledY
[380.124369] Subtest big-bo-tiledY: SUCCESS (0.947s)
[380.352131] [092/142] (626s left) prime_vgem (wait)
[380.711752] Starting subtest: wait
[380.714036] Starting dynamic subtest: rcs0
[380.735039] Dynamic subtest rcs0: SUCCESS (0.022s)
[380.761401] Starting dynamic subtest: vcs0
[380.762960] Dynamic subtest vcs0: SUCCESS (0.021s)
[380.784340] Starting dynamic subtest: vecs0
[380.785824] Dynamic subtest vecs0: SUCCESS (0.017s)
[380.787367] Subtest wait: SUCCESS (0.069s)
[380.890087] [093/142] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[381.206165] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[381.209143] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[381.323403] [094/142] (625s left) gem_bad_reloc (negative-reloc)
[381.542495] Starting subtest: negative-reloc
[381.549053] Subtest negative-reloc: SUCCESS (0.002s)
[381.656336] [095/142] (625s left) api_intel_bb (offset-control)
[381.864244] Starting subtest: offset-control
[381.880876] Subtest offset-control: SUCCESS (0.018s)
[381.989932] [096/142] (625s left) gem_exec_whisper (basic-normal-all)
[382.222528] Starting subtest: basic-normal-all
[392.442446] Subtest basic-normal-all: SUCCESS (10.219s)
[392.657626] [097/142] (614s left) gem_exec_balancer (semaphore)
[392.891299] Starting subtest: semaphore
[397.069214] Subtest semaphore: SUCCESS (4.178s)
[401.024265] [098/142] (606s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[401.329267] Starting subtest: cursor-vs-flip-toggle
[443.229133] Subtest cursor-vs-flip-toggle: SUCCESS (41.901s)
[443.561908] [099/142] (563s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[443.894118] Starting subtest: x-tiled-64bpp-rotate-0
[451.348954] Subtest x-tiled-64bpp-rotate-0: SUCCESS (7.453s)
[452.278155] [100/142] (554s left) kms_cursor_edge_walk (128x128-right-edge)
[452.594735] Starting subtest: 128x128-right-edge
[452.599643] Starting dynamic subtest: pipe-A-DP-1
[456.264644] Dynamic subtest pipe-A-DP-1: SUCCESS (3.666s)
[456.291751] Starting dynamic subtest: pipe-C-DP-1
[459.756143] Dynamic subtest pipe-C-DP-1: SUCCESS (3.486s)
[459.757685] Subtest 128x128-right-edge: SUCCESS (7.163s)
[460.083202] [101/142] (547s left) prime_mmap_coherency (read)
[460.300836] Starting subtest: read
[465.680688] Subtest read: SUCCESS (5.376s)
[465.799666] [102/142] (541s left) v3d/v3d_submit_cl (bad-in-sync)
[466.089894] Subtest bad-in-sync: SKIP (0.000s)
[466.164268] [103/142] (541s left) kms_big_fb (4-tiled-addfb-size-overflow)
[466.499297] Starting subtest: 4-tiled-addfb-size-overflow
[466.502813] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[466.616502] [104/142] (540s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs)
[467.102030] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs
[467.107467] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.001s)
[467.593266] [105/142] (539s left) syncobj_wait (single-wait-all-for-submit-signaled)
[467.805489] Starting subtest: single-wait-all-for-submit-signaled
[467.807416] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[467.892248] [106/142] (539s left) i915_hangman (engine-error-state-capture)
[468.120907] Starting subtest: engine-error-state-capture
[468.122871] Starting dynamic subtest: rcs0
[471.770374] Dynamic subtest rcs0: SUCCESS (3.648s)
[471.794504] Starting dynamic subtest: bcs0
[475.797612] Dynamic subtest bcs0: SUCCESS (4.024s)
[475.821853] Starting dynamic subtest: vcs0
[479.764575] Dynamic subtest vcs0: SUCCESS (3.963s)
[479.789110] Starting dynamic subtest: vecs0
[483.798283] Dynamic subtest vecs0: SUCCESS (4.030s)
[483.799949] Subtest engine-error-state-capture: SUCCESS (15.679s)
[483.925339] [107/142] (523s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-sf)
[484.137502] Subtest cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[484.189949] [108/142] (523s left) gem_exec_schedule (u-fairslice)
[484.425771] Starting subtest: u-fairslice
[484.427633] Starting dynamic subtest: rcs0
[486.462848] Dynamic subtest rcs0: SUCCESS (2.034s)
[486.486930] Starting dynamic subtest: bcs0
[488.499350] Dynamic subtest bcs0: SUCCESS (2.033s)
[488.520996] Starting dynamic subtest: vcs0
[490.532199] Dynamic subtest vcs0: SUCCESS (2.030s)
[490.554474] Starting dynamic subtest: vecs0
[492.564727] Dynamic subtest vecs0: SUCCESS (2.029s)
[492.566433] Subtest u-fairslice: SUCCESS (8.139s)
[492.909546] [109/142] (514s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_mc_ccs)
[493.537202] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs
[493.541212] Subtest pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[493.902120] [110/142] (513s left) kms_plane_alpha_blend (constant-alpha-min)
[494.213711] Starting subtest: constant-alpha-min
[494.520672] Starting dynamic subtest: pipe-A-DP-1
[495.240416] Dynamic subtest pipe-A-DP-1: SUCCESS (0.718s)
[495.276446] Starting dynamic subtest: pipe-C-DP-1
[496.190049] Dynamic subtest pipe-C-DP-1: SUCCESS (0.942s)
[496.191504] Subtest constant-alpha-min: SUCCESS (1.980s)
[496.559891] [111/142] (511s left) gem_ringfill (legacy-basic)
[497.053436] Starting subtest: legacy-basic
[497.054960] Starting dynamic subtest: default
[497.072385] Dynamic subtest default: SUCCESS (0.017s)
[497.104863] Starting dynamic subtest: render
[497.106396] Dynamic subtest render: SUCCESS (0.016s)
[497.128773] Starting dynamic subtest: bsd
[497.130215] Dynamic subtest bsd: SUCCESS (0.019s)
[497.152777] Starting dynamic subtest: bsd1
[497.154343] Dynamic subtest bsd1: SUCCESS (0.019s)
[497.176424] Starting dynamic subtest: blt
[497.177856] Dynamic subtest blt: SUCCESS (0.024s)
[497.199366] Starting dynamic subtest: vebox
[497.200713] Dynamic subtest vebox: SUCCESS (0.020s)
[497.202042] Subtest legacy-basic: SUCCESS (0.134s)
[497.276283] [112/142] (510s left) kms_universal_plane (cursor-fb-leak-pipe-d)
[497.590083] Subtest cursor-fb-leak-pipe-D: SKIP (0.000s)
[497.676818] [113/142] (510s left) gem_exec_params (sol-reset-not-gen7)
[497.892872] Starting subtest: sol-reset-not-gen7
[497.897937] Subtest sol-reset-not-gen7: SUCCESS (0.004s)
[498.010227] [114/142] (509s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[498.399128] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[498.695142] [115/142] (509s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render)
[499.015268] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render
[499.018390] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[499.123990] [116/142] (508s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[499.446241] Starting subtest: plane-all-modeset-transition-internal-panels
[499.449286] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[499.539857] [117/142] (508s left) gem_mmap_gtt (basic-write)
[499.744875] Starting subtest: basic-write
[500.163561] Subtest basic-write: SUCCESS (0.418s)
[500.273132] [118/142] (507s left) kms_selftest (drm_cmdline)
[500.474026] Starting subtest: drm_cmdline
[500.480992] Subtest drm_cmdline: SKIP (0.004s)
[500.556777] [119/142] (507s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[500.871617] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[500.874823] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[500.973297] [120/142] (507s left) i915_pm_rpm (dpms-lpsp)
[502.776673] Starting subtest: dpms-lpsp
[502.782105] Subtest dpms-lpsp: SKIP (0.000s)
[503.251174] [121/142] (504s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[503.557563] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[503.558927] Starting dynamic subtest: pipe-A-valid-mode
[503.654949] Dynamic subtest pipe-A-valid-mode: SKIP (0.096s)
[503.657748] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.100s)
[503.977395] [122/142] (504s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[504.195372] Starting subtest: basic-cpu-wc-noreloc
[504.211249] Subtest basic-cpu-wc-noreloc: SUCCESS (0.016s)
[504.410386] [123/142] (503s left) drm_fdinfo (virtual-busy-hang-all)
[504.624035] Starting subtest: virtual-busy-hang-all
[504.626139] Subtest virtual-busy-hang-all: SUCCESS (0.002s)
[504.710311] [124/142] (503s left) kms_plane_scaling (planes-upscale-20x20)
[505.016131] Starting subtest: planes-upscale-20x20
[505.020628] Starting dynamic subtest: pipe-A-DP-1
[505.081660] Dynamic subtest pipe-A-DP-1: SUCCESS (0.063s)
[505.128708] Starting dynamic subtest: pipe-B-DP-1
[505.492714] Dynamic subtest pipe-B-DP-1: SUCCESS (0.404s)
[505.524300] Starting dynamic subtest: pipe-C-DP-1
[505.597512] Dynamic subtest pipe-C-DP-1: SKIP (0.096s)
[505.599189] Subtest planes-upscale-20x20: SUCCESS (0.579s)
[505.996328] [125/142] (502s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[506.309434] Starting subtest: primary-x-tiled-reflect-x-0
[506.312584] Subtest primary-x-tiled-reflect-x-0: SKIP (0.003s)
[506.396049] [126/142] (501s left) perf (non-system-wide-paranoid)
[506.726788] Starting subtest: non-system-wide-paranoid
[506.841791] Subtest non-system-wide-paranoid: SUCCESS (0.115s)
[506.895691] [127/142] (501s left) gem_wait (wait)
[507.140936] Starting subtest: wait
[507.143227] Starting dynamic subtest: all-engines
[508.181908] Dynamic subtest all-engines: SUCCESS (1.039s)
[508.212034] Starting dynamic subtest: rcs0
[509.209831] Dynamic subtest rcs0: SUCCESS (1.025s)
[509.236894] Starting dynamic subtest: bcs0
[510.241699] Dynamic subtest bcs0: SUCCESS (1.029s)
[510.267419] Starting dynamic subtest: vcs0
[511.266662] Dynamic subtest vcs0: SUCCESS (1.022s)
[511.292067] Starting dynamic subtest: vecs0
[512.294636] Dynamic subtest vecs0: SUCCESS (1.025s)
[512.296290] Subtest wait: SUCCESS (5.155s)
[512.547237] [128/142] (495s left) kms_pipe_crc_basic (hang-read-crc)
[512.855207] Starting subtest: hang-read-crc
[512.859847] Starting dynamic subtest: pipe-A-DP-1
[514.139917] Dynamic subtest pipe-A-DP-1: SUCCESS (1.280s)
[514.165980] Starting dynamic subtest: pipe-B-DP-1
[515.824330] Dynamic subtest pipe-B-DP-1: SUCCESS (1.679s)
[515.848655] Starting dynamic subtest: pipe-C-DP-1
[517.781530] Dynamic subtest pipe-C-DP-1: SUCCESS (1.952s)
[517.783426] Subtest hang-read-crc: SUCCESS (4.928s)
[518.101293] [129/142] (490s left) perf (short-reads)
[518.408874] Starting subtest: short-reads
[518.459139] Subtest short-reads: SUCCESS (0.050s)
[518.519502] [130/142] (490s left) vc4/vc4_perfmon (create-perfmon-exceed)
[518.774453] Subtest create-perfmon-exceed: SKIP (0.000s)
[518.850902] [131/142] (489s left) kms_invalid_mode (bad-vsync-end)
[519.154279] Starting subtest: bad-vsync-end
[519.155738] Starting dynamic subtest: DP-1-pipe-A
[519.248402] Dynamic subtest DP-1-pipe-A: SUCCESS (0.094s)
[519.272862] Starting dynamic subtest: DP-1-pipe-B
[519.274397] Dynamic subtest DP-1-pipe-B: SUCCESS (0.015s)
[519.296106] Starting dynamic subtest: DP-1-pipe-C
[519.297480] Dynamic subtest DP-1-pipe-C: SUCCESS (0.015s)
[519.298817] Subtest bad-vsync-end: SUCCESS (0.136s)
[519.630428] [132/142] (488s left) kms_vblank (pipe-d-wait-forked-hang)
[519.935354] Subtest pipe-D-wait-forked-hang: SKIP (0.000s)
[520.030391] [133/142] (488s left) gem_ctx_shared (q-promotion)
[520.262719] Starting subtest: Q-promotion
[520.264272] Starting dynamic subtest: rcs0
[520.368237] Dynamic subtest rcs0: SUCCESS (0.103s)
[520.399935] Starting dynamic subtest: bcs0
[520.489525] Dynamic subtest bcs0: SUCCESS (0.118s)
[520.523166] Starting dynamic subtest: vcs0
[520.590672] Dynamic subtest vcs0: SUCCESS (0.098s)
[520.620560] Starting dynamic subtest: vecs0
[520.688705] Dynamic subtest vecs0: SUCCESS (0.095s)
[520.691746] Subtest Q-promotion: SUCCESS (0.426s)
[520.914167] [134/142] (487s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[521.238415] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[522.601800] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.363s)
[522.749109] [135/142] (485s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[523.424148] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[523.746972] [136/142] (485s left) syncobj_wait (reset-signaled)
[523.954804] Starting subtest: reset-signaled
[523.956745] Subtest reset-signaled: SUCCESS (0.001s)
[524.046767] [137/142] (484s left) kms_atomic_transition (plane-all-transition-nonblocking)
[524.356345] Starting subtest: plane-all-transition-nonblocking
[524.357927] Starting dynamic subtest: pipe-A-DP-1
[528.301217] Dynamic subtest pipe-A-DP-1: SUCCESS (3.946s)
[528.425678] Starting dynamic subtest: pipe-B-DP-1
[532.827993] Dynamic subtest pipe-B-DP-1: SUCCESS (4.424s)
[532.928631] Subtest plane-all-transition-nonblocking: SUCCESS (8.574s)
[533.269196] [138/142] (475s left) gem_exec_params (cliprects-invalid)
[533.491090] Starting subtest: cliprects-invalid
[533.493246] Subtest cliprects-invalid: SUCCESS (0.001s)
[533.602307] [139/142] (475s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[533.810782] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[533.812529] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[533.908833] [140/142] (475s left) gem_lmem_swapping (parallel-random-verify-ccs)
[534.123969] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[534.184972] [141/142] (474s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[534.433983] Starting subtest: map-fixed-invalidate-overlap-busy
[534.435890] Starting dynamic subtest: gtt
[538.405086] Dynamic subtest gtt: SUCCESS (3.969s)
[538.433415] Starting dynamic subtest: wb
[542.282084] Dynamic subtest wb: SUCCESS (3.874s)
[542.308135] Starting dynamic subtest: wc
[546.097174] Dynamic subtest wc: SUCCESS (3.812s)
[546.125756] Starting dynamic subtest: uc
[549.942135] Dynamic subtest uc: SUCCESS (3.842s)
[549.944139] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (15.510s)
[550.087175] [142/142] (458s left) gem_exec_reloc (basic-wc)
[550.304918] Starting subtest: basic-wc
[550.326960] Subtest basic-wc: SUCCESS (0.022s)
[550.531396] Closing watchdogs
Done.