[48.111606] Initializing watchdogs
[48.111906]   /dev/watchdog0
[48.127739] [001/141] (960s left) kms_plane_cursor (viewport)
[48.457857] Starting subtest: viewport
[48.460347] Starting dynamic subtest: pipe-A-DP-1-size-64
[50.919173] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.462s)
[50.980229] Starting dynamic subtest: pipe-A-DP-1-size-128
[53.402437] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.433s)
[53.465495] Starting dynamic subtest: pipe-A-DP-1-size-256
[55.904406] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.450s)
[56.067989] Starting dynamic subtest: pipe-B-DP-1-size-64
[58.721951] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.664s)
[58.783674] Starting dynamic subtest: pipe-B-DP-1-size-128
[61.187750] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.416s)
[61.248676] Starting dynamic subtest: pipe-B-DP-1-size-256
[63.671769] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.433s)
[63.818511] Starting dynamic subtest: pipe-C-DP-1-size-64
[66.479171] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.672s)
[66.539595] Starting dynamic subtest: pipe-C-DP-1-size-128
[68.945614] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.416s)
[69.006371] Starting dynamic subtest: pipe-C-DP-1-size-256
[71.411906] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.416s)
[71.543438] Subtest viewport: SUCCESS (23.089s)
[71.858128] [002/141] (936s left) kms_frontbuffer_tracking (fbc-2p-rte)
[72.177426] Starting subtest: fbc-2p-rte
[72.180615] Subtest fbc-2p-rte: SKIP (0.000s)
[72.255282] [003/141] (936s left) gem_pxp (create-valid-protected-context)
[74.985893] Subtest create-valid-protected-context: SKIP (0.000s)
[75.055243] [004/141] (933s left) gem_exec_fence (long-history)
[75.803056] Starting subtest: long-history
[81.562879] Subtest long-history: SUCCESS (5.762s)
[82.191969] [005/141] (926s left) vc4/vc4_wait_bo (bad-pad)
[82.459373] Subtest bad-pad: SKIP (0.000s)
[82.522923] [006/141] (926s left) perf_pmu (busy-idle-no-semaphores)
[82.737449] Starting subtest: busy-idle-no-semaphores
[82.738837] Starting dynamic subtest: rcs0
[83.386424] Dynamic subtest rcs0: SUCCESS (0.647s)
[83.401053] Starting dynamic subtest: bcs0
[84.016964] Dynamic subtest bcs0: SUCCESS (0.630s)
[84.032191] Starting dynamic subtest: vcs0
[84.650524] Dynamic subtest vcs0: SUCCESS (0.633s)
[84.665156] Starting dynamic subtest: vecs0
[85.277663] Dynamic subtest vecs0: SUCCESS (0.627s)
[85.279170] Subtest busy-idle-no-semaphores: SUCCESS (2.539s)
[85.376109] [007/141] (923s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[85.683566] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[85.686165] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[85.774138] [008/141] (923s left) gem_exec_create (forked)
[85.999323] Starting subtest: forked
[86.000844] Starting dynamic subtest: smem
[106.107942] Dynamic subtest smem: SUCCESS (20.109s)
[106.109216] Subtest forked: SUCCESS (20.109s)
[106.308421] [009/141] (902s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[106.622869] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[106.625485] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[106.726228] [010/141] (902s left) prime_mmap (test_map_unmap)
[106.927835] Starting subtest: test_map_unmap
[106.929320] Starting dynamic subtest: test_map_unmap-smem
[106.935387] Dynamic subtest test_map_unmap-smem: SUCCESS (0.007s)
[106.936962] Subtest test_map_unmap: SUCCESS (0.008s)
[107.041334] [011/141] (901s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[107.330772] Starting subtest: 2x-flip-vs-rmfb-interruptible
[107.334075] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.003s)
[107.425359] [012/141] (901s left) syncobj_basic (bad-destroy-pad)
[107.624566] Starting subtest: bad-destroy-pad
[107.626410] Subtest bad-destroy-pad: SUCCESS (0.000s)
[107.708234] [013/141] (901s left) perf (invalid-open-flags)
[108.040765] Starting subtest: invalid-open-flags
[108.042426] Subtest invalid-open-flags: SUCCESS (0.001s)
[108.089609] [014/141] (900s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[108.507695] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[108.511658] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[109.099572] [015/141] (899s left) gem_lmem_swapping (massive-random)
[109.310983] Subtest massive-random: SKIP (0.000s)
[109.365283] [016/141] (899s left) gem_exec_balancer (bonded-false-hang)
[113.417630] Starting subtest: bonded-false-hang
[116.994933] Subtest bonded-false-hang: SUCCESS (3.578s)
[117.084109] [017/141] (892s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[117.744163] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[117.748192] Subtest pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[118.104261] [018/141] (891s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[118.413826] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[118.416470] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[118.503896] [019/141] (890s left) kms_vblank (pipe-a-query-idle-hang)
[118.807920] Starting subtest: pipe-A-query-idle-hang
[125.998394] Subtest pipe-A-query-idle-hang: SUCCESS (7.189s)
[126.329210] [020/141] (882s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[126.653605] Starting subtest: y-tiled-32bpp-rotate-0
[131.894507] Subtest y-tiled-32bpp-rotate-0: SUCCESS (5.239s)
[132.413947] [021/141] (876s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[132.719749] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[132.722263] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[132.896820] [022/141] (876s left) gem_exec_reloc (basic-wc)
[133.106325] Starting subtest: basic-wc
[133.126362] Subtest basic-wc: SUCCESS (0.019s)
[133.313396] [023/141] (876s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[133.519924] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[133.521420] Starting dynamic subtest: smem
[133.835305] Dynamic subtest smem: SUCCESS (0.314s)
[133.837411] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.315s)
[134.032092] [024/141] (875s left) kms_rotation_crc (sprite-rotation-90)
[134.324180] Starting subtest: sprite-rotation-90
[140.436309] Subtest sprite-rotation-90: SUCCESS (6.115s)
[140.856702] [025/141] (868s left) gem_caching (reads)
[141.067067] Starting subtest: reads
[147.800343] Subtest reads: SUCCESS (6.733s)
[147.906330] [026/141] (861s left) v3d/v3d_submit_csd (bad-perfmon)
[148.172232] Subtest bad-perfmon: SKIP (0.000s)
[148.238939] [027/141] (861s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[148.553875] Starting subtest: yf-tiled-64bpp-rotate-270
[148.556731] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[148.656677] [028/141] (860s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[148.868507] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[149.024335] [029/141] (860s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[149.230719] Starting subtest: single-wait-for-submit-available-submitted
[149.232283] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[149.322580] [030/141] (860s left) kms_content_protection (legacy)
[149.649792] Starting subtest: legacy
[149.855085] Starting dynamic subtest: pipe-A-DP-1
[270.013491] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[270.736153] Closing watchdogs
[270.744050] Initializing watchdogs
[270.744242]   /dev/watchdog0
[270.764988] [031/141] (738s left) kms_color (ctm-0-50)
[271.066982] Starting subtest: ctm-0-50
[271.068370] Starting dynamic subtest: pipe-A
[272.885328] Dynamic subtest pipe-A: SUCCESS (1.819s)
[272.903364] Starting dynamic subtest: pipe-B
[275.008690] Dynamic subtest pipe-B: SUCCESS (2.122s)
[275.026211] Starting dynamic subtest: pipe-C
[277.245991] Dynamic subtest pipe-C: SUCCESS (2.235s)
[277.247291] Subtest ctm-0-50: SUCCESS (6.179s)
[277.573114] [032/141] (732s left) kms_vblank (pipe-d-query-forked-hang)
[277.871628] Subtest pipe-D-query-forked-hang: SKIP (0.000s)
[277.956591] [033/141] (731s left) i915_hangman (gt-engine-hang)
[278.177710] Starting subtest: gt-engine-hang
[278.179302] Starting dynamic subtest: rcs0
[278.776986] Dynamic subtest rcs0: SUCCESS (0.599s)
[278.794813] Starting dynamic subtest: bcs0
[279.370802] Dynamic subtest bcs0: SUCCESS (0.593s)
[279.387868] Starting dynamic subtest: vcs0
[279.958839] Dynamic subtest vcs0: SUCCESS (0.587s)
[279.979201] Starting dynamic subtest: vecs0
[280.543681] Dynamic subtest vecs0: SUCCESS (0.584s)
[280.545689] Subtest gt-engine-hang: SUCCESS (2.367s)
[280.672802] [034/141] (729s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[280.974839] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[280.978037] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[281.072907] [035/141] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[281.387449] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[281.390035] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[281.490077] [036/141] (728s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs)
[281.786887] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs
[281.790076] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[282.512815] [037/141] (727s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[283.158351] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[283.160950] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s)
[283.546477] [038/141] (726s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[283.870130] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[283.872774] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[283.980459] [039/141] (725s left) i915_pm_rps (reset)
[284.189716] Starting subtest: reset
[287.765744] Subtest reset: SUCCESS (3.576s)
[287.849425] [040/141] (722s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[288.172436] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[288.175101] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[288.263787] [041/141] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[288.567528] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[288.570258] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[288.664767] [042/141] (721s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_mc_ccs)
[289.181455] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs
[289.184249] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[289.689282] [043/141] (720s left) gem_userptr_blits (create-destroy-unsync)
[289.900762] Subtest create-destroy-unsync: SKIP (0.000s)
[290.057143] [044/141] (720s left) gem_exec_fence (syncobj-timeline-export)
[290.842584] Starting subtest: syncobj-timeline-export
[290.849667] Subtest syncobj-timeline-export: SUCCESS (0.008s)
[291.073767] [045/141] (719s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[291.378508] Starting subtest: cursorA-vs-flipB-varying-size
[291.381744] Subtest cursorA-vs-flipB-varying-size: SKIP (0.004s)
[291.473329] [046/141] (718s left) gem_wait (await)
[291.708817] Starting subtest: await
[291.710610] Starting dynamic subtest: all-engines
[292.744834] Dynamic subtest all-engines: SUCCESS (1.035s)
[292.763936] Starting dynamic subtest: rcs0
[293.769869] Dynamic subtest rcs0: SUCCESS (1.024s)
[293.788620] Starting dynamic subtest: bcs0
[294.798274] Dynamic subtest bcs0: SUCCESS (1.027s)
[294.816453] Starting dynamic subtest: vcs0
[295.823637] Dynamic subtest vcs0: SUCCESS (1.025s)
[295.842804] Starting dynamic subtest: vecs0
[296.850584] Dynamic subtest vecs0: SUCCESS (1.026s)
[296.851891] Subtest await: SUCCESS (5.142s)
[297.090396] [047/141] (713s left) kms_prop_blob (blob-prop-validate)
[297.290160] Starting subtest: blob-prop-validate
[297.291785] Subtest blob-prop-validate: SUCCESS (0.000s)
[297.373530] [048/141] (712s left) vc4/vc4_label_bo (set-label)
[297.636409] Subtest set-label: SKIP (0.000s)
[297.705955] [049/141] (712s left) gem_mmap_wc (bad-size)
[297.904781] Starting subtest: bad-size
[297.906796] Subtest bad-size: SUCCESS (0.002s)
[298.005870] [050/141] (712s left) kms_hdr (static-toggle)
[298.299957] Starting subtest: static-toggle
[298.302569] Subtest static-toggle: SKIP (0.000s)
[298.389518] [051/141] (712s left) gem_pread (uncached)
[298.590533] Starting subtest: uncached
[303.009091] Subtest uncached: SUCCESS (4.417s)
[303.106274] [052/141] (707s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[303.404224] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[303.405449] Starting dynamic subtest: pipe-A-valid-mode
[303.500747] Dynamic subtest pipe-A-valid-mode: SKIP (0.095s)
[303.504499] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.098s)
[303.799607] [053/141] (706s left) kms_psr (psr2_sprite_render)
[303.999577] Subtest psr2_sprite_render: SKIP (0.000s)
[304.049063] [054/141] (706s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[304.343406] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[304.344788] Starting dynamic subtest: pipe-A-valid-mode
[305.025712] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.681s)
[305.027331] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (0.685s)
[305.374651] [055/141] (705s left) dumb_buffer (map-uaf)
[305.575392] Starting subtest: map-uaf
[305.641970] Subtest map-uaf: SUCCESS (0.068s)
[305.740521] [056/141] (704s left) gem_softpin (full)
[305.948511] Starting subtest: full
[305.969150] Subtest full: SUCCESS (0.019s)
[306.074280] [057/141] (704s left) kms_lease (lease_invalid_crtc)
[306.378154] Starting subtest: lease_invalid_crtc
[306.379544] Starting dynamic subtest: pipe-A-DP-1
[306.381044] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[306.401249] Starting dynamic subtest: pipe-B-DP-1
[306.402574] Dynamic subtest pipe-B-DP-1: SUCCESS (0.000s)
[306.419515] Starting dynamic subtest: pipe-C-DP-1
[306.420815] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[306.422099] Subtest lease_invalid_crtc: SUCCESS (0.011s)
[306.474202] [058/141] (704s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[306.770617] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[306.773629] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.004s)
[306.874941] [059/141] (703s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[307.203824] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[308.335042] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.131s)
[308.678960] [060/141] (702s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-c)
[308.989248] Starting subtest: universal-plane-pageflip-windowed-pipe-C
[309.911377] Subtest universal-plane-pageflip-windowed-pipe-C: SUCCESS (0.924s)
[310.222233] [061/141] (700s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[310.423447] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[310.530195] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[310.622701] [062/141] (700s left) sw_sync (alloc_fence)
[310.818867] Starting subtest: alloc_fence
[310.820636] Subtest alloc_fence: SUCCESS (0.000s)
[310.889457] [063/141] (699s left) kms_psr (primary_mmap_cpu)
[311.089360] Subtest primary_mmap_cpu: SKIP (0.000s)
[311.139402] [064/141] (699s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[311.448583] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[311.451399] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[311.557173] [065/141] (699s left) i915_pm_rpm (gem-execbuf-stress)
[313.364977] Starting subtest: gem-execbuf-stress
[313.368161] Starting dynamic subtest: smem0
[315.507869] Dynamic subtest smem0: SUCCESS (2.142s)
[315.527402] Starting dynamic subtest: extra-wait-smem0
[368.029161] Dynamic subtest extra-wait-smem0: SUCCESS (52.517s)
[368.031395] Subtest gem-execbuf-stress: SUCCESS (54.662s)
[368.502349] [066/141] (642s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_ccs)
[369.049626] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_ccs
[369.051180] Subtest pipe-B-missing-ccs-buffer-y_tiled_ccs: SUCCESS (0.001s)
[369.512178] [067/141] (641s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[369.820592] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[369.823156] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[369.928197] [068/141] (641s left) perf (low-oa-exponent-permissions)
[370.225567] Starting subtest: low-oa-exponent-permissions
[370.379173] Subtest low-oa-exponent-permissions: SUCCESS (0.154s)
[370.430174] [069/141] (640s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[370.740932] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[370.743797] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[370.845408] [070/141] (640s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[371.045698] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[371.154282] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[371.245240] [071/141] (639s left) tools_test (tools_test)
[371.448776] Starting subtest: tools_test
[371.860514] Subtest tools_test: SUCCESS (0.418s)
[371.928393] [072/141] (639s left) gem_mmap_gtt (medium-copy-xy)
[372.129828] Starting subtest: medium-copy-XY
[379.524445] Subtest medium-copy-XY: SUCCESS (7.395s)
[379.684691] [073/141] (631s left) gem_mmap_wc (write-cpu-read-wc)
[380.008408] Starting subtest: write-cpu-read-wc
[380.282273] Subtest write-cpu-read-wc: SUCCESS (0.275s)
[380.365178] [074/141] (630s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs)
[380.869420] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs
[380.872539] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[381.403981] [075/141] (629s left) syncobj_timeline (invalid-single-wait-all-available-unsubmitted)
[381.619382] Starting subtest: invalid-single-wait-all-available-unsubmitted
[381.621182] Subtest invalid-single-wait-all-available-unsubmitted: SUCCESS (0.000s)
[381.703370] [076/141] (629s left) syncobj_timeline (transfer-timeline-point)
[381.905281] Starting subtest: transfer-timeline-point
[381.907127] Subtest transfer-timeline-point: SUCCESS (0.001s)
[382.003084] [077/141] (629s left) gem_exec_schedule (lateslice)
[382.239785] Starting subtest: lateslice
[382.241316] Starting dynamic subtest: rcs0
[382.273376] Dynamic subtest rcs0: SUCCESS (0.031s)
[382.295768] Starting dynamic subtest: bcs0
[382.305264] Dynamic subtest bcs0: SUCCESS (0.031s)
[382.326855] Starting dynamic subtest: vcs0
[382.334476] Dynamic subtest vcs0: SUCCESS (0.027s)
[382.355324] Starting dynamic subtest: vecs0
[382.364223] Dynamic subtest vecs0: SUCCESS (0.028s)
[382.366759] Subtest lateslice: SUCCESS (0.125s)
[382.721644] [078/141] (628s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[383.432889] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[383.728606] [079/141] (627s left) kms_ccs (pipe-c-bad-rotation-90-yf_tiled_ccs)
[384.366638] Starting subtest: pipe-C-bad-rotation-90-yf_tiled_ccs
[384.369439] Subtest pipe-C-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[384.799988] [080/141] (626s left) device_reset (unbind-reset-rebind)
[385.041638] Starting subtest: unbind-reset-rebind
[385.857299] Subtest unbind-reset-rebind: SUCCESS (0.814s)
[386.372742] [081/141] (625s left) gem_ctx_persistence (legacy-engines-hostile)
[386.605391] Starting subtest: legacy-engines-hostile
[386.609947] Starting dynamic subtest: render
[386.699940] Dynamic subtest render: SUCCESS (0.092s)
[386.722487] Starting dynamic subtest: bsd
[386.790969] Dynamic subtest bsd: SUCCESS (0.089s)
[386.814165] Starting dynamic subtest: blt
[386.887997] Dynamic subtest blt: SUCCESS (0.094s)
[386.909281] Starting dynamic subtest: vebox
[386.976448] Dynamic subtest vebox: SUCCESS (0.086s)
[386.977738] Subtest legacy-engines-hostile: SUCCESS (0.371s)
[387.060332] [082/141] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[387.372515] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[387.375644] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[387.476685] [083/141] (624s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[387.678694] Starting subtest: multi-wait-all-for-submit-signaled
[387.680165] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.002s)
[387.776458] [084/141] (623s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[388.083278] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[388.086160] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[388.193544] [085/141] (623s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[388.498419] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[388.501189] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[388.609692] [086/141] (623s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[389.088303] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs
[389.096783] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.005s)
[389.647946] [087/141] (622s left) gem_busy (parallel)
[390.010620] Starting subtest: parallel
[390.012595] Starting dynamic subtest: rcs0
[390.063242] Dynamic subtest rcs0: SUCCESS (0.049s)
[390.085848] Starting dynamic subtest: bcs0
[390.103604] Dynamic subtest bcs0: SUCCESS (0.041s)
[390.128667] Starting dynamic subtest: vcs0
[390.138668] Dynamic subtest vcs0: SUCCESS (0.035s)
[390.160905] Starting dynamic subtest: vecs0
[390.188748] Dynamic subtest vecs0: SUCCESS (0.049s)
[390.190152] Subtest parallel: SUCCESS (0.179s)
[390.434652] [088/141] (621s left) drm_fdinfo (busy-hang)
[390.641855] Starting subtest: busy-hang
[390.643466] Starting dynamic subtest: rcs0
[391.680213] Dynamic subtest rcs0: SUCCESS (1.037s)
[391.704504] Starting dynamic subtest: bcs0
[392.724752] Dynamic subtest bcs0: SUCCESS (1.041s)
[392.746035] Starting dynamic subtest: vcs0
[393.756041] Dynamic subtest vcs0: SUCCESS (1.032s)
[393.777574] Starting dynamic subtest: vecs0
[394.790273] Dynamic subtest vecs0: SUCCESS (1.032s)
[394.791633] Subtest busy-hang: SUCCESS (4.148s)
[394.880866] [089/141] (616s left) gem_exec_reloc (basic-gtt)
[395.100047] Starting subtest: basic-gtt
[395.123964] Subtest basic-gtt: SUCCESS (0.024s)
[395.314542] [090/141] (616s left) kms_lease (lessee_list)
[395.618180] Starting subtest: lessee_list
[395.619896] Starting dynamic subtest: pipe-A-DP-1
[395.621439] Dynamic subtest pipe-A-DP-1: SUCCESS (0.003s)
[395.651265] Starting dynamic subtest: pipe-B-DP-1
[395.652650] Dynamic subtest pipe-B-DP-1: SUCCESS (0.001s)
[395.673189] Starting dynamic subtest: pipe-C-DP-1
[395.674481] Dynamic subtest pipe-C-DP-1: SUCCESS (0.001s)
[395.675784] Subtest lessee_list: SUCCESS (0.016s)
[395.731565] [091/141] (616s left) kms_chamelium_frames (vga-frame-dump)
[396.142154] Subtest vga-frame-dump: SKIP (0.000s)
[396.429419] [092/141] (615s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_rc_ccs)
[397.133711] Subtest pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[397.434369] [093/141] (614s left) gem_exec_reloc (basic-cpu-noreloc)
[397.644962] Starting subtest: basic-cpu-noreloc
[397.662277] Subtest basic-cpu-noreloc: SUCCESS (0.017s)
[397.850546] [094/141] (614s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[398.154946] Starting subtest: fbc-modesetfrombusy
[399.347024] Subtest fbc-modesetfrombusy: SUCCESS (1.194s)
[399.458215] [095/141] (612s left) gem_flink_race (flink_close)
[399.654628] Starting subtest: flink_close
[404.682392] Subtest flink_close: SUCCESS (5.027s)
[404.773868] [096/141] (607s left) kms_getfb (getfb-addfb-different-handles)
[404.975856] Starting subtest: getfb-addfb-different-handles
[404.977422] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[405.074918] [097/141] (607s left) perf_pmu (busy-double-start)
[405.284092] Starting subtest: busy-double-start
[405.285716] Starting dynamic subtest: rcs0
[408.833415] Dynamic subtest rcs0: SUCCESS (3.547s)
[408.854574] Starting dynamic subtest: bcs0
[412.390243] Dynamic subtest bcs0: SUCCESS (3.555s)
[412.412412] Starting dynamic subtest: vcs0
[415.937793] Dynamic subtest vcs0: SUCCESS (3.546s)
[415.959359] Starting dynamic subtest: vecs0
[419.484146] Dynamic subtest vecs0: SUCCESS (3.544s)
[419.485994] Subtest busy-double-start: SUCCESS (14.200s)
[419.573969] [098/141] (592s left) gem_exec_params (no-bsd)
[419.785842] Starting subtest: no-bsd
[419.791436] Subtest no-bsd: SUCCESS (0.002s)
[419.907520] [099/141] (592s left) gem_exec_reloc (basic-gtt-noreloc)
[420.116401] Starting subtest: basic-gtt-noreloc
[420.128049] Subtest basic-gtt-noreloc: SUCCESS (0.012s)
[420.307731] [100/141] (592s left) gem_eio (wait-immediate)
[420.535574] Starting subtest: wait-immediate
[420.610672] Subtest wait-immediate: SUCCESS (0.073s)
[420.790175] [101/141] (591s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[421.093753] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[423.197193] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.109s)
[423.342725] [102/141] (589s left) gem_close (many-handles-one-vma)
[423.553600] Starting subtest: many-handles-one-vma
[423.635959] Subtest many-handles-one-vma: SUCCESS (0.082s)
[423.740985] [103/141] (588s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu)
[424.065735] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu
[425.885301] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (1.823s)
[426.007917] [104/141] (586s left) gem_exec_reloc (basic-write-wc-active)
[426.222074] Starting subtest: basic-write-wc-active
[426.363796] Subtest basic-write-wc-active: SUCCESS (0.141s)
[426.558255] [105/141] (585s left) i915_hangman (engine-error-state-capture)
[426.780371] Starting subtest: engine-error-state-capture
[426.781842] Starting dynamic subtest: rcs0
[430.721570] Dynamic subtest rcs0: SUCCESS (3.939s)
[430.744663] Starting dynamic subtest: bcs0
[434.751159] Dynamic subtest bcs0: SUCCESS (4.027s)
[434.773769] Starting dynamic subtest: vcs0
[438.710938] Dynamic subtest vcs0: SUCCESS (3.958s)
[438.733655] Starting dynamic subtest: vecs0
[442.754552] Dynamic subtest vecs0: SUCCESS (4.042s)
[442.756277] Subtest engine-error-state-capture: SUCCESS (15.974s)
[442.858469] [106/141] (569s left) i915_pm_rpm (system-suspend-modeset)
[444.896949] Starting subtest: system-suspend-modeset
[462.582508] Subtest system-suspend-modeset: SUCCESS (2.439s)
[467.320779] [107/141] (564s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[467.628622] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[467.631683] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[468.416945] [108/141] (563s left) kms_atomic_interruptible (legacy-setmode)
[468.715400] Starting subtest: legacy-setmode
[468.719832] Starting dynamic subtest: DP-1-pipe-A
[475.261381] Dynamic subtest DP-1-pipe-A: SUCCESS (6.540s)
[475.262906] Subtest legacy-setmode: SUCCESS (6.545s)
[475.600476] [109/141] (556s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[479.638604] Subtest parallel-dmabuf-import-out-fence: SKIP (0.000s)
[479.749737] [110/141] (552s left) prime_vgem (fence-flip-hang)
[479.966109] Subtest fence-flip-hang: SKIP (0.000s)
[480.082306] [111/141] (551s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[480.282065] Starting subtest: addfb25-x-tiled-mismatch-legacy
[480.283581] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[480.483192] [112/141] (551s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[480.785976] Starting subtest: cursor-rapid-movement-64x21
[480.797502] Starting dynamic subtest: pipe-A-DP-1
[481.304372] Dynamic subtest pipe-A-DP-1: SUCCESS (0.502s)
[481.393883] Starting dynamic subtest: pipe-C-DP-1
[482.185079] Dynamic subtest pipe-C-DP-1: SUCCESS (0.817s)
[482.186440] Subtest cursor-rapid-movement-64x21: SUCCESS (1.398s)
[482.560404] [113/141] (549s left) gem_userptr_blits (map-fixed-invalidate-busy)
[482.799475] Starting subtest: map-fixed-invalidate-busy
[482.803780] Starting dynamic subtest: gtt
[486.349163] Dynamic subtest gtt: SUCCESS (3.547s)
[486.374789] Starting dynamic subtest: wb
[489.920417] Dynamic subtest wb: SUCCESS (3.570s)
[489.945866] Starting dynamic subtest: wc
[493.516586] Dynamic subtest wc: SUCCESS (3.594s)
[493.542172] Starting dynamic subtest: uc
[497.093033] Dynamic subtest uc: SUCCESS (3.575s)
[497.094455] Subtest map-fixed-invalidate-busy: SUCCESS (14.292s)
[497.240831] [114/141] (534s left) kms_cursor_edge_walk (256x256-left-edge)
[497.542562] Starting subtest: 256x256-left-edge
[497.544047] Starting dynamic subtest: pipe-A-DP-1
[501.201390] Dynamic subtest pipe-A-DP-1: SUCCESS (3.658s)
[501.230445] Starting dynamic subtest: pipe-C-DP-1
[504.685707] Dynamic subtest pipe-C-DP-1: SUCCESS (3.477s)
[504.687826] Subtest 256x256-left-edge: SUCCESS (7.145s)
[505.003934] [115/141] (527s left) gem_exec_schedule (noreorder-priority)
[505.362469] Starting subtest: noreorder-priority
[505.364002] Starting dynamic subtest: rcs0
[506.492190] Dynamic subtest rcs0: SUCCESS (1.127s)
[506.528327] Starting dynamic subtest: bcs0
[507.621279] Dynamic subtest bcs0: SUCCESS (1.126s)
[507.649199] Starting dynamic subtest: vcs0
[508.752529] Dynamic subtest vcs0: SUCCESS (1.129s)
[508.781759] Starting dynamic subtest: vecs0
[509.884157] Dynamic subtest vecs0: SUCCESS (1.129s)
[509.885858] Subtest noreorder-priority: SUCCESS (4.521s)
[510.085553] [116/141] (522s left) kms_plane_scaling (plane-upscale-with-pixel-format-factor-0-25)
[510.381050] Starting subtest: plane-upscale-with-pixel-format-factor-0-25
[510.382527] Starting dynamic subtest: pipe-A-DP-1
[511.036892] Dynamic subtest pipe-A-DP-1: SUCCESS (0.655s)
[511.065609] Starting dynamic subtest: pipe-B-DP-1
[511.970539] Dynamic subtest pipe-B-DP-1: SUCCESS (0.929s)
[512.022359] Starting dynamic subtest: pipe-C-DP-1
[512.342541] Dynamic subtest pipe-C-DP-1: SUCCESS (0.368s)
[512.343860] Subtest plane-upscale-with-pixel-format-factor-0-25: SUCCESS (1.965s)
[512.756578] [117/141] (519s left) gem_exec_schedule (semaphore-noskip)
[512.993982] Starting subtest: semaphore-noskip
[513.240249] Subtest semaphore-noskip: SUCCESS (0.246s)
[513.590444] [118/141] (518s left) kms_vblank (pipe-c-query-forked-busy-hang)
[513.884004] Starting subtest: pipe-C-query-forked-busy-hang
[521.215398] Subtest pipe-C-query-forked-busy-hang: SUCCESS (7.332s)
[521.572997] [119/141] (510s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[521.875269] Starting subtest: 2x-long-cursor-vs-flip-atomic
[521.878085] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.005s)
[521.971800] [120/141] (510s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-25)
[522.271322] Starting subtest: plane-downscale-with-rotation-factor-0-25
[522.278932] Starting dynamic subtest: pipe-A-DP-1
[522.328448] Dynamic subtest pipe-A-DP-1: SKIP (0.043s)
[522.358497] Starting dynamic subtest: pipe-B-DP-1
[522.414047] Dynamic subtest pipe-B-DP-1: SKIP (0.088s)
[522.441371] Starting dynamic subtest: pipe-C-DP-1
[522.506583] Dynamic subtest pipe-C-DP-1: SKIP (0.089s)
[522.509262] Subtest plane-downscale-with-rotation-factor-0-25: SKIP (0.233s)
[522.604457] [121/141] (509s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_mc_ccs)
[523.307986] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[523.628326] [122/141] (508s left) gem_ctx_persistence (userptr)
[523.837942] Starting subtest: userptr
[523.959833] Subtest userptr: SUCCESS (0.122s)
[524.062567] [123/141] (508s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[524.449151] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[524.735488] [124/141] (507s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[525.040321] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[525.043731] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[525.147654] [125/141] (507s left) core_getstats
[525.447809] [126/141] (507s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[525.775300] Starting subtest: 4-tiled-16bpp-rotate-90
[525.778188] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[525.882085] [127/141] (506s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[526.571772] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[526.576088] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[526.914488] [128/141] (505s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_rc_ccs)
[527.625327] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[527.946245] [129/141] (504s left) v3d/v3d_mmap (mmap-bad-flags)
[528.200458] Subtest mmap-bad-flags: SKIP (0.000s)
[528.278628] [130/141] (504s left) gem_ctx_engines (none)
[528.502015] Starting subtest: none
[528.506135] Subtest none: SUCCESS (0.003s)
[528.714378] [131/141] (504s left) gem_mmap_gtt (flink-race)
[528.912896] Starting subtest: flink-race
[549.025884] Subtest flink-race: SUCCESS (20.114s)
[549.129445] [132/141] (483s left) gem_mmap_wc (write)
[549.331335] Starting subtest: write
[549.519549] Subtest write: SUCCESS (0.190s)
[549.611857] [133/141] (483s left) kms_cursor_crc (cursor-random-256x85)
[549.929574] Starting subtest: cursor-random-256x85
[549.942201] Starting dynamic subtest: pipe-A-DP-1
[553.751638] Dynamic subtest pipe-A-DP-1: SUCCESS (3.808s)
[553.855471] Starting dynamic subtest: pipe-C-DP-1
[557.977756] Dynamic subtest pipe-C-DP-1: SUCCESS (4.145s)
[557.979183] Subtest cursor-random-256x85: SUCCESS (8.047s)
[558.338522] [134/141] (474s left) gem_exec_store (pages)
[558.567045] Starting subtest: pages
[558.568545] Starting dynamic subtest: rcs0
[558.668617] Dynamic subtest rcs0: SUCCESS (0.102s)
[558.695795] Starting dynamic subtest: bcs0
[558.759560] Dynamic subtest bcs0: SUCCESS (0.089s)
[558.785550] Starting dynamic subtest: vcs0
[558.845900] Dynamic subtest vcs0: SUCCESS (0.085s)
[558.871299] Starting dynamic subtest: vecs0
[558.933893] Dynamic subtest vecs0: SUCCESS (0.087s)
[558.935300] Subtest pages: SUCCESS (0.369s)
[559.135547] [135/141] (474s left) sw_sync (sync_merge)
[559.338239] Starting subtest: sync_merge
[559.339654] Subtest sync_merge: SUCCESS (0.001s)
[559.420186] [136/141] (473s left) api_intel_bb (object-noreloc-purge-cache-simple)
[559.620870] Starting subtest: object-noreloc-purge-cache-simple
[559.629885] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.009s)
[559.750876] [137/141] (473s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[560.066775] Starting subtest: x-tiled-64bpp-rotate-0
[567.538731] Subtest x-tiled-64bpp-rotate-0: SUCCESS (7.471s)
[568.452767] [138/141] (464s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[568.756283] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[571.124935] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (2.372s)
[571.268293] [139/141] (462s left) kms_addfb_basic (addfb25-bad-modifier)
[571.469104] Starting subtest: addfb25-bad-modifier
[571.470762] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[571.685047] [140/141] (461s left) v3d/v3d_perfmon (destroy-valid-perfmon)
[571.939830] Subtest destroy-valid-perfmon: SKIP (0.000s)
[572.018004] [141/141] (461s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[572.346579] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[573.822051] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.474s)
[573.968002] Closing watchdogs
Done.