[49.027974] Initializing watchdogs
[49.028330]   /dev/watchdog0
[49.044173] [001/142] (960s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf_tiled_ccs)
[49.555721] Subtest pipe-D-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[49.868258] [002/142] (959s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[50.103731] Starting subtest: cursorA-vs-flipB-atomic-transitions
[50.106343] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.002s)
[50.178352] [003/142] (959s left) kms_vblank (pipe-c-wait-idle)
[50.410673] Starting subtest: pipe-C-wait-idle
[53.036808] Subtest pipe-C-wait-idle: SUCCESS (2.627s)
[53.374586] [004/142] (956s left) kms_flip (dpms-off-confusion-interruptible)
[53.617469] Starting subtest: dpms-off-confusion-interruptible
[53.621182] Starting dynamic subtest: A-DP1
[64.310472] Dynamic subtest A-DP1: SUCCESS (10.689s)
[64.323954] Starting dynamic subtest: B-DP1
[74.746143] Dynamic subtest B-DP1: SUCCESS (10.434s)
[74.759577] Starting dynamic subtest: C-DP1
[85.187210] Dynamic subtest C-DP1: SUCCESS (10.440s)
[85.191131] Subtest dpms-off-confusion-interruptible: SUCCESS (31.572s)
[85.608895] [005/142] (924s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt)
[85.861425] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt
[85.863932] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[85.958060] [006/142] (923s left) gem_exec_reloc (basic-wc-noreloc)
[86.130269] Starting subtest: basic-wc-noreloc
[86.144095] Subtest basic-wc-noreloc: SUCCESS (0.016s)
[86.325064] [007/142] (923s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[86.472676] Starting subtest: no-spare-fences-busy
[88.656876] Subtest no-spare-fences-busy: SUCCESS (2.185s)
[88.993855] [008/142] (920s left) syncobj_timeline (single-wait-all-available-signaled)
[89.139757] Starting subtest: single-wait-all-available-signaled
[89.141331] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[89.226236] [009/142] (920s left) drm_fdinfo (virtual-busy-hang-all)
[89.371670] Starting subtest: virtual-busy-hang-all
[89.373508] Subtest virtual-busy-hang-all: SUCCESS (0.002s)
[89.457294] [010/142] (920s left) v3d/v3d_wait_bo (unused-bo-0ns)
[89.660243] Subtest unused-bo-0ns: SKIP (0.000s)
[89.724134] [011/142] (920s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[89.962141] Starting subtest: cursorB-vs-flipA-varying-size
[89.967448] Subtest cursorB-vs-flipA-varying-size: SKIP (0.005s)
[90.042069] [012/142] (919s left) kms_lease (master-vs-lease)
[90.281948] Starting subtest: master-vs-lease
[90.284223] Subtest master-vs-lease: SUCCESS (0.003s)
[90.358204] [013/142] (919s left) kms_async_flips (async-flip-with-page-flip-events)
[90.590816] Starting subtest: async-flip-with-page-flip-events
[90.752494] Starting dynamic subtest: pipe-A-DP-1-Yf-CCS
[91.681567] Dynamic subtest pipe-A-DP-1-Yf-CCS: SKIP (0.927s)
[91.695424] Starting dynamic subtest: pipe-A-DP-1-Y-CCS
[92.343448] Dynamic subtest pipe-A-DP-1-Y-CCS: SKIP (0.661s)
[92.358105] Starting dynamic subtest: pipe-A-DP-1-Yf
[94.992699] Dynamic subtest pipe-A-DP-1-Yf: SUCCESS (2.648s)
[95.006896] Starting dynamic subtest: pipe-A-DP-1-Y
[97.626262] Dynamic subtest pipe-A-DP-1-Y: SUCCESS (2.633s)
[97.639721] Starting dynamic subtest: pipe-A-DP-1-X
[99.775234] Dynamic subtest pipe-A-DP-1-X: SUCCESS (2.149s)
[99.789218] Starting dynamic subtest: pipe-A-DP-1-linear
[99.942397] Dynamic subtest pipe-A-DP-1-linear: SKIP (0.168s)
[100.128958] Starting dynamic subtest: pipe-B-DP-1-Yf-CCS
[101.027776] Dynamic subtest pipe-B-DP-1-Yf-CCS: SKIP (0.908s)
[101.041246] Starting dynamic subtest: pipe-B-DP-1-Y-CCS
[101.707175] Dynamic subtest pipe-B-DP-1-Y-CCS: SKIP (0.678s)
[101.720589] Starting dynamic subtest: pipe-B-DP-1-Yf
[104.369928] Dynamic subtest pipe-B-DP-1-Yf: SUCCESS (2.664s)
[104.383921] Starting dynamic subtest: pipe-B-DP-1-Y
[107.004308] Dynamic subtest pipe-B-DP-1-Y: SUCCESS (2.633s)
[107.017999] Starting dynamic subtest: pipe-B-DP-1-X
[109.169551] Dynamic subtest pipe-B-DP-1-X: SUCCESS (2.166s)
[109.183442] Starting dynamic subtest: pipe-B-DP-1-linear
[109.338448] Dynamic subtest pipe-B-DP-1-linear: SKIP (0.168s)
[109.518888] Starting dynamic subtest: pipe-C-DP-1-Yf
[112.385312] Dynamic subtest pipe-C-DP-1-Yf: SUCCESS (2.876s)
[112.398622] Starting dynamic subtest: pipe-C-DP-1-Y
[115.029849] Dynamic subtest pipe-C-DP-1-Y: SUCCESS (2.645s)
[115.043297] Starting dynamic subtest: pipe-C-DP-1-X
[117.196538] Dynamic subtest pipe-C-DP-1-X: SUCCESS (2.166s)
[117.210296] Starting dynamic subtest: pipe-C-DP-1-linear
[117.366937] Dynamic subtest pipe-C-DP-1-linear: SKIP (0.170s)
[117.368303] Subtest async-flip-with-page-flip-events: SUCCESS (26.776s)
[117.818147] [014/142] (892s left) gem_close (basic)
[117.966273] Starting subtest: basic
[117.967742] Subtest basic: SUCCESS (0.000s)
[118.068106] [015/142] (891s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_ccs)
[118.510131] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_ccs
[118.513269] Subtest pipe-C-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.001s)
[118.847329] [016/142] (891s left) syncobj_timeline (host-signal-ordered)
[118.986700] Starting subtest: host-signal-ordered
[118.993881] Subtest host-signal-ordered: SUCCESS (0.002s)
[119.063177] [017/142] (891s left) kms_rotation_crc (primary-rotation-270)
[119.300666] Starting subtest: primary-rotation-270
[125.484237] Subtest primary-rotation-270: SUCCESS (6.185s)
[125.920694] [018/142] (884s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[126.172992] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[126.175481] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[126.267096] [019/142] (883s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[126.686832] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[126.692473] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.005s)
[127.059814] [020/142] (883s left) kms_hdr (invalid-hdr)
[127.292259] Starting subtest: invalid-hdr
[129.642339] Starting dynamic subtest: pipe-A-DP-1
[136.148748] Dynamic subtest pipe-A-DP-1: SUCCESS (6.507s)
[136.150711] Subtest invalid-hdr: SUCCESS (8.858s)
[136.524644] [021/142] (873s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[137.017785] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[137.370772] [022/142] (872s left) kms_content_protection (lic)
[137.639979] Starting subtest: lic
[137.671986] Starting dynamic subtest: pipe-A-DP-1
[258.741759] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[259.264173] Closing watchdogs
[259.272533] Initializing watchdogs
[259.272694]   /dev/watchdog0
[259.291589] [023/142] (751s left) gem_create (create-ext-placement-sanity-check)
[259.563420] Starting subtest: create-ext-placement-sanity-check
[259.569348] Subtest create-ext-placement-sanity-check: SUCCESS (0.008s)
[259.655101] [024/142] (750s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[259.897835] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[259.900523] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[259.988388] [025/142] (750s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[260.227744] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[260.231727] Starting dynamic subtest: pipe-A-DP-1
[260.904763] Dynamic subtest pipe-A-DP-1: SUCCESS (0.674s)
[260.925284] Starting dynamic subtest: pipe-B-DP-1
[261.842985] Dynamic subtest pipe-B-DP-1: SUCCESS (0.936s)
[261.859815] Starting dynamic subtest: pipe-C-DP-1
[262.205438] Dynamic subtest pipe-C-DP-1: SUCCESS (0.359s)
[262.206769] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (1.980s)
[262.610815] [026/142] (747s left) kms_psr (psr2_cursor_blt)
[262.753780] Subtest psr2_cursor_blt: SKIP (0.000s)
[262.795671] [027/142] (747s left) gem_ctx_persistence (engines-cleanup)
[262.945266] Starting subtest: engines-cleanup
[262.946759] Starting dynamic subtest: rcs0
[262.984595] Dynamic subtest rcs0: SUCCESS (0.040s)
[263.002142] Starting dynamic subtest: bcs0
[263.021532] Dynamic subtest bcs0: SUCCESS (0.036s)
[263.038161] Starting dynamic subtest: vcs0
[263.051517] Dynamic subtest vcs0: SUCCESS (0.030s)
[263.066648] Starting dynamic subtest: vecs0
[263.087680] Dynamic subtest vecs0: SUCCESS (0.035s)
[263.089417] Subtest engines-cleanup: SUCCESS (0.145s)
[263.177301] [028/142] (747s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[263.545318] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[263.551630] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.005s)
[263.986891] [029/142] (746s left) gem_caching (reads)
[264.137214] Starting subtest: reads
[270.443566] Subtest reads: SUCCESS (6.306s)
[270.558078] [030/142] (739s left) kms_vblank (pipe-b-wait-forked)
[270.791746] Starting subtest: pipe-B-wait-forked
[273.457599] Subtest pipe-B-wait-forked: SUCCESS (2.666s)
[273.792251] [031/142] (736s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_mc_ccs)
[274.261046] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[274.565643] [032/142] (736s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[274.803269] Starting subtest: basic-flip-after-cursor-varying-size
[275.872152] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.070s)
[276.202403] [033/142] (734s left) v3d/v3d_submit_csd (bad-in-sync)
[276.383343] Subtest bad-in-sync: SKIP (0.000s)
[276.450233] [034/142] (734s left) gem_exec_whisper (basic-contexts-forked-all)
[276.614328] Starting subtest: basic-contexts-forked-all
[300.566342] Subtest basic-contexts-forked-all: SUCCESS (23.950s)
[300.771200] [035/142] (709s left) vc4/vc4_perfmon (create-two-perfmon)
[300.950052] Subtest create-two-perfmon: SKIP (0.000s)
[301.020179] [036/142] (709s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[301.286282] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[301.288936] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[301.385502] [037/142] (709s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs)
[301.621953] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs
[301.627254] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[302.178274] [038/142] (708s left) kms_psr (suspend)
[302.319892] Subtest suspend: SKIP (0.000s)
[302.379658] [039/142] (708s left) syncobj_timeline (wait-any-snapshot)
[302.518040] Starting subtest: wait-any-snapshot
[302.601620] Subtest wait-any-snapshot: SUCCESS (0.083s)
[302.693926] [040/142] (708s left) gen3_render_tiledy_blits
[302.879268] [041/142] (708s left) gem_exec_reloc (basic-cpu-gtt-active)
[303.026977] Starting subtest: basic-cpu-gtt-active
[303.167128] Subtest basic-cpu-gtt-active: SUCCESS (0.140s)
[303.344690] [042/142] (707s left) i915_query (query-regions-unallocated)
[303.486628] Starting subtest: query-regions-unallocated
[303.488146] Subtest query-regions-unallocated: SUCCESS (0.000s)
[303.576895] [043/142] (707s left) gen9_exec_parse (valid-registers)
[303.741760] Starting subtest: valid-registers
[303.922657] Subtest valid-registers: SUCCESS (0.181s)
[304.145619] [044/142] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[304.388270] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[304.390669] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[304.493915] [045/142] (706s left) gem_mmap_wc (pf-nonblock)
[304.633687] Starting subtest: pf-nonblock
[304.637448] Subtest pf-nonblock: SUCCESS (0.005s)
[304.744679] [046/142] (706s left) gem_exec_balancer (nohangcheck)
[308.759120] Starting subtest: nohangcheck
[312.455347] Subtest nohangcheck: SUCCESS (3.696s)
[312.545074] [047/142] (698s left) i915_pm_freq_mult (media-freq)
[312.687877] Starting subtest: media-freq
[312.689550] Starting dynamic subtest: gt0
[312.692663] Dynamic subtest gt0: SKIP (0.000s)
[312.695254] Subtest media-freq: SKIP (0.002s)
[312.776846] [048/142] (698s left) vc4/vc4_wait_bo (bad-pad)
[312.960198] Subtest bad-pad: SKIP (0.000s)
[313.027386] [049/142] (698s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[313.259501] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[313.264212] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.004s)
[313.344874] [050/142] (697s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[313.505224] Starting subtest: y-tiled-ccs-to-x-tiled
[313.506779] Starting dynamic subtest: smem
[313.794547] Dynamic subtest smem: SUCCESS (0.288s)
[313.796247] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.290s)
[313.996256] [051/142] (697s left) syncobj_wait (invalid-reset-bad-pad)
[314.139725] Starting subtest: invalid-reset-bad-pad
[314.141397] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[314.229325] [052/142] (697s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_mc_ccs)
[314.666367] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_mc_ccs
[314.668967] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[315.035807] [053/142] (696s left) gem_exec_capture (capture-invisible)
[315.187063] Starting subtest: capture-invisible
[315.188503] Starting dynamic subtest: smem0
[315.191329] Dynamic subtest smem0: SKIP (0.000s)
[315.193791] Subtest capture-invisible: SKIP (0.002s)
[315.304607] [054/142] (696s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[315.542418] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[315.543690] Starting dynamic subtest: pipe-A-valid-mode
[316.233320] Dynamic subtest pipe-A-valid-mode: SKIP (0.689s)
[316.235917] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (0.692s)
[316.623973] [055/142] (694s left) perf_pmu (gt-awake)
[316.772430] Starting subtest: gt-awake
[319.333667] Subtest gt-awake: SUCCESS (2.560s)
[319.437874] [056/142] (692s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[319.670303] Starting subtest: plane-primary-toggle-with-vblank-wait
[319.673887] Starting dynamic subtest: pipe-A-DP-1
[319.883482] Dynamic subtest pipe-A-DP-1: SUCCESS (0.210s)
[320.003838] Starting dynamic subtest: pipe-B-DP-1
[320.478508] Dynamic subtest pipe-B-DP-1: SUCCESS (0.492s)
[320.577437] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.906s)
[320.912840] [057/142] (690s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_mc_ccs)
[321.283503] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs
[321.286165] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[321.701641] [058/142] (689s left) gem_exec_schedule (semaphore-resolve)
[321.874612] Starting subtest: semaphore-resolve
[321.922340] Subtest semaphore-resolve: SUCCESS (0.048s)
[322.284432] [059/142] (689s left) sw_sync (sync_multi_timeline_wait)
[322.421411] Starting subtest: sync_multi_timeline_wait
[322.425433] Subtest sync_multi_timeline_wait: SUCCESS (0.002s)
[322.500630] [060/142] (689s left) gen9_exec_parse (allowed-single)