[50.991073] Initializing watchdogs
[50.991267]   /dev/watchdog0
[51.008383] [001/142] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[51.299443] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[51.304519] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[51.394646] [002/142] (960s left) kms_flip (modeset-vs-vblank-race-interruptible)
[51.639071] Starting subtest: modeset-vs-vblank-race-interruptible
[51.642566] Starting dynamic subtest: A-DP1
[56.316493] Dynamic subtest A-DP1: SUCCESS (4.673s)
[56.331169] Starting dynamic subtest: B-DP1
[60.734738] Dynamic subtest B-DP1: SUCCESS (4.417s)
[60.746916] Starting dynamic subtest: C-DP1
[64.825674] Dynamic subtest C-DP1: SUCCESS (4.090s)
[64.827889] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (13.188s)
[65.239243] [003/142] (946s left) syncobj_timeline (transfer-timeline-point)
[65.398034] Starting subtest: transfer-timeline-point
[65.401160] Subtest transfer-timeline-point: SUCCESS (0.002s)
[65.486147] [004/142] (946s left) gem_vm_create (invalid-destroy)
[65.644872] Starting subtest: invalid-destroy
[65.646746] Subtest invalid-destroy: SUCCESS (0.001s)
[65.734729] [005/142] (945s left) gem_exec_reloc (basic-gtt-wc)
[65.899549] Starting subtest: basic-gtt-wc
[65.923957] Subtest basic-gtt-wc: SUCCESS (0.025s)
[66.102308] [006/142] (945s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[66.343931] Starting subtest: flip-vs-cursor-busy-crc-legacy
[67.167630] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.821s)
[67.544349] [007/142] (944s left) kms_sequence (get-forked-busy)
[67.787575] Starting subtest: get-forked-busy
[67.789909] Starting dynamic subtest: DP-1-pipe-A
[70.270427] Dynamic subtest DP-1-pipe-A: SUCCESS (2.482s)
[70.283516] Starting dynamic subtest: DP-1-pipe-B
[72.906144] Dynamic subtest DP-1-pipe-B: SUCCESS (2.634s)
[72.921396] Starting dynamic subtest: DP-1-pipe-C
[75.547960] Dynamic subtest DP-1-pipe-C: SUCCESS (2.639s)
[75.549517] Subtest get-forked-busy: SUCCESS (7.764s)
[75.864551] [008/142] (935s left) kms_content_protection (legacy)
[76.145637] Starting subtest: legacy
[76.351494] Starting dynamic subtest: pipe-A-DP-1
[197.190340] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[197.760995] Closing watchdogs
[197.770778] Initializing watchdogs
[197.770977]   /dev/watchdog0
[197.789354] [009/142] (814s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[198.272248] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[198.277848] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.005s)
[198.596316] [010/142] (813s left) gem_exec_schedule (preempt-self)
[198.774774] Starting subtest: preempt-self
[198.776320] Starting dynamic subtest: rcs0
[198.824117] Dynamic subtest rcs0: SUCCESS (0.045s)
[198.844954] Starting dynamic subtest: bcs0
[198.866063] Dynamic subtest bcs0: SUCCESS (0.043s)
[198.892224] Starting dynamic subtest: vcs0
[198.902449] Dynamic subtest vcs0: SUCCESS (0.036s)
[198.924278] Starting dynamic subtest: vecs0
[198.941729] Dynamic subtest vecs0: SUCCESS (0.036s)
[198.943245] Subtest preempt-self: SUCCESS (0.167s)
[199.298078] [011/142] (812s left) kms_chamelium_hpd (vga-hpd)
[199.628862] Subtest vga-hpd: SKIP (0.000s)
[199.921235] [012/142] (811s left) gem_render_copy (y-tiled-ccs-to-linear)
[200.083916] Starting subtest: y-tiled-ccs-to-linear
[200.085587] Starting dynamic subtest: smem
[200.349969] Dynamic subtest smem: SUCCESS (0.265s)
[200.351368] Subtest y-tiled-ccs-to-linear: SUCCESS (0.266s)
[200.549894] [013/142] (811s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[200.801298] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[200.803838] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[200.899356] [014/142] (811s left) kms_chamelium_audio (hdmi-audio-edid)
[201.229704] Subtest hdmi-audio-edid: SKIP (0.000s)
[201.513234] [015/142] (810s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[201.757422] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[203.923774] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.168s)
[204.057260] [016/142] (807s left) kms_frontbuffer_tracking (fbcpsr-badstride)
[204.309817] Starting subtest: fbcpsr-badstride
[204.312390] Subtest fbcpsr-badstride: SKIP (0.000s)
[204.408491] [017/142] (807s left) gem_exec_fence (syncobj-timeline-repeat)
[205.253679] Starting subtest: syncobj-timeline-repeat
[206.385867] Subtest syncobj-timeline-repeat: SUCCESS (1.132s)
[206.592746] [018/142] (805s left) gem_fenced_exec_thrash (too-many-fences)
[206.739150] Starting subtest: too-many-fences
[208.909196] Subtest too-many-fences: SUCCESS (2.167s)
[209.074522] [019/142] (803s left) gem_userptr_blits (create-destroy-unsync)
[209.231133] Subtest create-destroy-unsync: SKIP (0.000s)
[209.396799] [020/142] (802s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[211.244676] Starting subtest: gem-execbuf-stress-pc8
[211.292724] Subtest gem-execbuf-stress-pc8: SKIP (0.041s)
[211.702203] [021/142] (800s left) kms_feature_discovery (dp-mst)
[211.943914] Starting subtest: dp-mst
[211.946612] Subtest dp-mst: SKIP (0.001s)
[212.032445] [022/142] (800s left) kms_dp_aux_dev
[212.716584] [023/142] (799s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[212.858697] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[212.860255] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[212.950537] [024/142] (799s left) kms_chamelium_edid (vga-edid-read)
[213.281175] Subtest vga-edid-read: SKIP (0.000s)
[213.566870] [025/142] (798s left) gem_fence_thrash (bo-write-verify-threaded-x)
[213.708264] Starting subtest: bo-write-verify-threaded-x
[215.839319] Subtest bo-write-verify-threaded-x: SUCCESS (2.130s)
[215.947944] [026/142] (796s left) dmabuf_sync_file (export-basic)
[216.093315] Starting subtest: export-basic
[216.098558] Subtest export-basic: SUCCESS (0.003s)
[216.163695] [027/142] (796s left) gem_softpin (overlap)
[216.316383] Starting subtest: overlap
[219.035991] Subtest overlap: SUCCESS (2.719s)
[219.144910] [028/142] (793s left) gem_exec_reloc (basic-wc-cpu-active)
[219.293691] Starting subtest: basic-wc-cpu-active
[219.433182] Subtest basic-wc-cpu-active: SUCCESS (0.138s)
[219.611282] [029/142] (792s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[219.846972] Starting subtest: flip-vs-cursor-legacy
[235.506872] Subtest flip-vs-cursor-legacy: SUCCESS (15.660s)
[235.838921] [030/142] (776s left) syncobj_wait (wait-any-complex)
[235.983096] Starting subtest: wait-any-complex
[236.046647] Subtest wait-any-complex: SUCCESS (0.064s)
[236.133724] [031/142] (776s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[236.368052] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[236.369370] Starting dynamic subtest: pipe-A-valid-mode
[236.462635] Dynamic subtest pipe-A-valid-mode: SKIP (0.091s)
[236.465263] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.094s)
[236.773461] [032/142] (775s left) kms_vblank (pipe-a-query-forked-busy-hang)
[237.006814] Starting subtest: pipe-A-query-forked-busy-hang
[244.019937] Subtest pipe-A-query-forked-busy-hang: SUCCESS (7.012s)
[244.360334] [033/142] (768s left) gem_tiled_blits (basic)
[245.762413] Starting subtest: basic
[245.806553] Subtest basic: SUCCESS (0.044s)
[245.959468] [034/142] (766s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[246.334223] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[248.657941] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.327s)
[248.795371] [035/142] (763s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[248.956910] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[248.959841] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[249.164423] [036/142] (763s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[249.412367] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[249.415188] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[249.512708] [037/142] (763s left) core_getclient
[249.729443] [038/142] (763s left) gem_exec_fence (basic-wait)
[250.034698] Starting subtest: basic-wait
[250.036393] Starting dynamic subtest: rcs0
[250.065440] Dynamic subtest rcs0: SUCCESS (0.030s)
[250.083852] Starting dynamic subtest: bcs0
[250.105060] Dynamic subtest bcs0: SUCCESS (0.037s)
[250.123283] Starting dynamic subtest: vcs0
[250.133810] Dynamic subtest vcs0: SUCCESS (0.027s)
[250.152907] Starting dynamic subtest: vecs0
[250.165599] Dynamic subtest vecs0: SUCCESS (0.030s)
[250.167306] Subtest basic-wait: SUCCESS (0.132s)
[250.845499] [039/142] (762s left) gem_render_copy (x-tiled)
[251.007116] Starting subtest: x-tiled
[251.008737] Starting dynamic subtest: smem
[251.293222] Dynamic subtest smem: SUCCESS (0.284s)
[251.295038] Subtest x-tiled: SUCCESS (0.286s)
[251.497430] [040/142] (761s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[251.740884] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[251.744708] Starting dynamic subtest: pipe-A-DP-1
[252.080706] Dynamic subtest pipe-A-DP-1: SUCCESS (0.337s)
[252.101435] Starting dynamic subtest: pipe-B-DP-1
[252.464098] Dynamic subtest pipe-B-DP-1: SUCCESS (0.377s)
[252.487139] Starting dynamic subtest: pipe-C-DP-1
[252.561408] Dynamic subtest pipe-C-DP-1: SKIP (0.092s)
[252.563169] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.820s)
[252.938351] [041/142] (760s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[253.180968] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[253.183722] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[253.287707] [042/142] (759s left) vc4/vc4_purgeable_bo (mark-unpurgeable-check-retained)
[253.520685] Subtest mark-unpurgeable-check-retained: SKIP (0.000s)
[253.586827] [043/142] (759s left) kms_getfb (getfb-handle-valid)
[253.728333] Starting subtest: getfb-handle-valid
[253.729812] Subtest getfb-handle-valid: SUCCESS (0.000s)
[253.843359] [044/142] (759s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[254.328560] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[254.657753] [045/142] (758s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[254.930164] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[254.936555] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[255.022705] [046/142] (758s left) kms_busy (extended-pageflip-hang-oldfb)
[255.268692] Starting subtest: extended-pageflip-hang-oldfb
[255.272887] Starting dynamic subtest: pipe-A
[255.749088] Dynamic subtest pipe-A: SUCCESS (0.475s)
[255.770974] Starting dynamic subtest: pipe-C
[256.235770] Dynamic subtest pipe-C: SUCCESS (0.480s)
[256.237429] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.967s)
[256.580478] [047/142] (756s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_mc_ccs)
[257.028573] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs
[257.031535] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.001s)
[257.388791] [048/142] (755s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_rc_ccs)
[257.797150] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs
[257.799889] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[258.175442] [049/142] (755s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs)
[258.572317] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs
[258.576380] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[258.976243] [050/142] (754s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[259.450729] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[259.767892] [051/142] (753s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[259.924357] Starting subtest: basic-gtt-cpu-noreloc
[259.934549] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.010s)
[260.117495] [052/142] (753s left) gem_exec_reloc (basic-write-wc-active)
[260.269070] Starting subtest: basic-write-wc-active
[260.409114] Subtest basic-write-wc-active: SUCCESS (0.137s)
[260.601824] [053/142] (752s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[260.743675] Starting subtest: multi-wait-all-for-submit-signaled
[260.745410] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[260.833724] [054/142] (752s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_mc_ccs)
[261.251594] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs
[261.254371] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[261.622229] [055/142] (751s left) gem_exec_reloc (basic-concurrent0)
[261.777210] Starting subtest: basic-concurrent0
[267.247744] Subtest basic-concurrent0: SUCCESS (5.468s)
[267.455970] [056/142] (746s left) gem_ctx_persistence (engines-hostile)
[267.609397] Starting subtest: engines-hostile
[267.611225] Starting dynamic subtest: rcs0
[267.704957] Dynamic subtest rcs0: SUCCESS (0.095s)
[267.724022] Starting dynamic subtest: bcs0
[267.799347] Dynamic subtest bcs0: SUCCESS (0.092s)
[267.820684] Starting dynamic subtest: vcs0
[267.890587] Dynamic subtest vcs0: SUCCESS (0.087s)
[267.909077] Starting dynamic subtest: vecs0
[267.978667] Dynamic subtest vecs0: SUCCESS (0.087s)
[267.980325] Subtest engines-hostile: SUCCESS (0.371s)
[268.075081] [057/142] (745s left) gem_ctx_shared (q-in-order)
[268.242679] Starting subtest: Q-in-order
[268.244218] Starting dynamic subtest: rcs0
[268.353187] Dynamic subtest rcs0: SUCCESS (0.107s)
[268.376439] Starting dynamic subtest: bcs0
[268.468344] Dynamic subtest bcs0: SUCCESS (0.111s)
[268.492283] Starting dynamic subtest: vcs0
[268.562426] Dynamic subtest vcs0: SUCCESS (0.089s)
[268.583237] Starting dynamic subtest: vecs0
[268.651668] Dynamic subtest vecs0: SUCCESS (0.089s)
[268.653533] Subtest Q-in-order: SUCCESS (0.410s)
[268.890807] [058/142] (744s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[269.145220] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[269.148293] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[269.238951] [059/142] (744s left) v3d/v3d_submit_cl (multi-and-single-sync)
[269.435760] Subtest multi-and-single-sync: SKIP (0.000s)
[269.504808] [060/142] (744s left) kms_invalid_mode (bad-hsync-end)
[269.748107] Starting subtest: bad-hsync-end
[269.749639] Starting dynamic subtest: DP-1-pipe-A
[269.831738] Dynamic subtest DP-1-pipe-A: SUCCESS (0.084s)
[269.852743] Starting dynamic subtest: DP-1-pipe-B
[269.854109] Dynamic subtest DP-1-pipe-B: SUCCESS (0.002s)
[269.871871] Starting dynamic subtest: DP-1-pipe-C
[269.873473] Dynamic subtest DP-1-pipe-C: SUCCESS (0.002s)
[269.874938] Subtest bad-hsync-end: SUCCESS (0.099s)
[270.174856] [061/142] (743s left) gem_exec_balancer (nop)
[270.342525] Starting subtest: nop
[310.226593] Subtest nop: SUCCESS (39.884s)
[314.140819] [062/142] (699s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[314.380887] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[314.383631] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[314.945132] [063/142] (698s left) gen9_exec_parse (batch-zero-length)
[315.113593] Starting subtest: batch-zero-length
[315.117807] Subtest batch-zero-length: SUCCESS (0.002s)
[315.348694] [064/142] (698s left) kms_universal_plane (universal-plane-pipe-c-sanity)
[315.591058] Starting subtest: universal-plane-pipe-C-sanity
[316.348983] Subtest universal-plane-pipe-C-sanity: SUCCESS (0.757s)
[316.668454] [065/142] (697s left) kms_pm_dc (dc5-dpms-negative)
[317.916487] Starting subtest: dc5-dpms-negative
[322.236645] Subtest dc5-dpms-negative: SUCCESS (4.322s)
[322.399136] [066/142] (691s left) kms_lease (simple_lease)
[322.640246] Starting subtest: simple_lease
[322.642358] Starting dynamic subtest: pipe-A-DP-1
[323.141736] Dynamic subtest pipe-A-DP-1: SUCCESS (0.498s)
[323.167161] Starting dynamic subtest: pipe-B-DP-1
[323.752685] Dynamic subtest pipe-B-DP-1: SUCCESS (0.607s)
[323.774764] Starting dynamic subtest: pipe-C-DP-1
[324.354938] Dynamic subtest pipe-C-DP-1: SUCCESS (0.600s)
[324.356377] Subtest simple_lease: SUCCESS (1.716s)
[324.676481] [067/142] (689s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[325.141040] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[325.143787] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[325.487591] [068/142] (688s left) kms_cursor_edge_walk (128x128-left-edge)
[325.724594] Starting subtest: 128x128-left-edge
[325.728817] Starting dynamic subtest: pipe-A-DP-1
[329.384660] Dynamic subtest pipe-A-DP-1: SUCCESS (3.655s)
[329.405164] Starting dynamic subtest: pipe-C-DP-1
[332.846172] Dynamic subtest pipe-C-DP-1: SUCCESS (3.458s)
[332.847952] Subtest 128x128-left-edge: SUCCESS (7.123s)
[333.169500] [069/142] (680s left) gem_softpin (safe-alignment)
[333.327058] Starting subtest: safe-alignment
[333.354791] Subtest safe-alignment: SUCCESS (0.028s)
[333.469304] [070/142] (680s left) kms_flip (blocking-wf_vblank)
[333.690249] Starting subtest: blocking-wf_vblank
[333.695454] Starting dynamic subtest: A-DP1
[344.506410] Dynamic subtest A-DP1: SUCCESS (10.812s)
[344.527356] Starting dynamic subtest: B-DP1
[355.236532] Dynamic subtest B-DP1: SUCCESS (10.726s)
[355.258326] Starting dynamic subtest: C-DP1
[365.963550] Dynamic subtest C-DP1: SUCCESS (10.724s)
[365.968033] Subtest blocking-wf_vblank: SUCCESS (32.278s)
[366.391949] [071/142] (647s left) gem_ctx_persistence (legacy-engines-hang)
[366.540549] Starting subtest: legacy-engines-hang
[366.545111] Starting dynamic subtest: render
[366.582916] Dynamic subtest render: SUCCESS (0.040s)
[366.606134] Starting dynamic subtest: bsd
[366.622292] Dynamic subtest bsd: SUCCESS (0.035s)
[366.645705] Starting dynamic subtest: blt
[366.648389] Dynamic subtest blt: SKIP (0.004s)
[366.668038] Starting dynamic subtest: vebox
[366.689267] Dynamic subtest vebox: SUCCESS (0.055s)
[366.691046] Subtest legacy-engines-hang: SUCCESS (0.150s)
[366.789864] [072/142] (647s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[367.029232] Starting subtest: cursorA-vs-flipB-atomic
[367.032681] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[367.122287] [073/142] (647s left) gem_set_tiling_vs_pwrite
[367.388108] [074/142] (646s left) kms_vblank (pipe-c-accuracy-idle)
[367.624619] Starting subtest: pipe-C-accuracy-idle
[370.229558] Subtest pipe-C-accuracy-idle: SUCCESS (2.604s)
[370.575568] [075/142] (643s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[370.845830] Starting subtest: x-tiled-8bpp-rotate-0
[373.702805] Subtest x-tiled-8bpp-rotate-0: SUCCESS (2.857s)
[373.942617] [076/142] (640s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[374.086245] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[374.193341] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[374.274656] [077/142] (640s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[374.529409] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[374.532642] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[374.626998] [078/142] (639s left) i915_suspend (basic-s2idle-without-i915)
[374.765424] Starting subtest: basic-s2idle-without-i915
[393.891599] Subtest basic-s2idle-without-i915: SUCCESS (19.123s)
[400.055563] [079/142] (620s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[400.302100] Starting subtest: 2x-flip-vs-rmfb-interruptible
[400.304882] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.003s)
[400.406271] [080/142] (620s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[400.652516] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[400.655374] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[400.754992] [081/142] (619s left) prime_mmap (test_correct)
[400.906868] Starting subtest: test_correct
[400.908320] Starting dynamic subtest: test_correct-smem
[400.912703] Dynamic subtest test_correct-smem: SUCCESS (0.007s)
[400.914347] Subtest test_correct: SUCCESS (0.009s)
[401.022212] [082/142] (619s left) vgem_basic (create)
[401.171255] Starting subtest: create
[401.172824] Subtest create: SUCCESS (0.000s)
[401.239517] [083/142] (619s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[401.488740] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[403.784664] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.297s)
[403.926563] [084/142] (616s left) gem_pread (uncached)
[404.069764] Starting subtest: uncached
[408.605759] Subtest uncached: SUCCESS (4.535s)
[408.707968] [085/142] (612s left) gem_lmem_swapping (heavy-verify-random)
[408.870331] Subtest heavy-verify-random: SKIP (0.000s)
[408.926149] [086/142] (611s left) kms_plane_scaling (planes-downscale-factor-0-75)
[409.162039] Starting subtest: planes-downscale-factor-0-75
[409.163434] Starting dynamic subtest: pipe-A-DP-1
[409.266497] Dynamic subtest pipe-A-DP-1: SUCCESS (0.103s)
[409.292222] Starting dynamic subtest: pipe-B-DP-1
[409.675275] Dynamic subtest pipe-B-DP-1: SUCCESS (0.402s)
[409.705989] Starting dynamic subtest: pipe-C-DP-1
[409.793040] Dynamic subtest pipe-C-DP-1: SKIP (0.109s)
[409.794646] Subtest planes-downscale-factor-0-75: SUCCESS (0.631s)
[410.206714] [087/142] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[410.453553] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[410.456364] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[410.555272] [088/142] (610s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[410.804306] Starting subtest: fbcpsr-suspend
[410.806996] Subtest fbcpsr-suspend: SKIP (0.000s)
[410.906146] [089/142] (610s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_ccs)
[411.284578] Starting subtest: pipe-B-bad-rotation-90-y_tiled_ccs
[411.762570] Subtest pipe-B-bad-rotation-90-y_tiled_ccs: SUCCESS (0.474s)
[412.297231] [090/142] (608s left) perf_pmu (init-busy)
[412.451237] Starting subtest: init-busy
[412.452820] Starting dynamic subtest: rcs0
[412.457519] Dynamic subtest rcs0: SUCCESS (0.007s)
[412.484650] Starting dynamic subtest: bcs0
[412.485916] Dynamic subtest bcs0: SUCCESS (0.001s)
[412.505852] Starting dynamic subtest: vcs0
[412.507267] Dynamic subtest vcs0: SUCCESS (0.002s)
[412.525618] Starting dynamic subtest: vecs0
[412.527112] Dynamic subtest vecs0: SUCCESS (0.001s)
[412.528455] Subtest init-busy: SUCCESS (0.022s)
[412.563563] [091/142] (608s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[412.931671] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[412.934678] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[413.370810] [092/142] (607s left) perf (non-zero-reason)
[413.658330] Starting subtest: non-zero-reason
[413.660050] Starting dynamic subtest: 0-rcs0
[445.839281] Dynamic subtest 0-rcs0: SUCCESS (32.179s)
[445.840774] Subtest non-zero-reason: SUCCESS (32.182s)
[445.890668] [093/142] (575s left) gem_pxp (hw-rejects-pxp-context)
[448.554036] Starting subtest: hw-rejects-pxp-context
[448.555459] Subtest hw-rejects-pxp-context: SUCCESS (0.001s)
[448.637960] [094/142] (572s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[448.886307] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[448.889618] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[448.987279] [095/142] (572s left) api_intel_bb (object-noreloc-purge-cache-simple)
[449.134540] Starting subtest: object-noreloc-purge-cache-simple
[449.144829] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.012s)
[449.254206] [096/142] (571s left) vgem_basic (bad-fence)
[449.398790] Starting subtest: bad-fence
[449.400564] Subtest bad-fence: SUCCESS (0.000s)
[449.473880] [097/142] (571s left) gem_exec_params (invalid-bsd-ring)
[449.623184] Starting subtest: invalid-bsd-ring
[449.627734] Subtest invalid-bsd-ring: SUCCESS (0.002s)
[449.737725] [098/142] (571s left) kms_flip (dpms-off-confusion-interruptible)
[449.973631] Starting subtest: dpms-off-confusion-interruptible
[449.978728] Starting dynamic subtest: A-DP1
[460.473870] Dynamic subtest A-DP1: SUCCESS (10.494s)
[460.497282] Starting dynamic subtest: B-DP1
[470.914655] Dynamic subtest B-DP1: SUCCESS (10.435s)
[470.936160] Starting dynamic subtest: C-DP1
[481.348988] Dynamic subtest C-DP1: SUCCESS (10.433s)
[481.354780] Subtest dpms-off-confusion-interruptible: SUCCESS (31.378s)
[481.771404] [099/142] (539s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[482.034904] Starting subtest: y-tiled-32bpp-rotate-90
[487.045126] Subtest y-tiled-32bpp-rotate-90: SUCCESS (5.010s)
[487.606604] [100/142] (533s left) gem_exec_whisper (basic-contexts-priority)
[487.778789] Starting subtest: basic-contexts-priority
[503.617573] Subtest basic-contexts-priority: SUCCESS (15.837s)
[503.823088] [101/142] (517s left) kms_scaling_modes (scaling-mode-none)
[504.058145] Starting subtest: scaling-mode-none
[504.061642] Subtest scaling-mode-none: SKIP (0.001s)
[504.154457] [102/142] (517s left) kms_cursor_crc (cursor-offscreen-32x32)
[504.392805] Starting subtest: cursor-offscreen-32x32
[504.514213] Subtest cursor-offscreen-32x32: SKIP (0.118s)
[504.638395] [103/142] (516s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[505.124866] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[505.436090] [104/142] (516s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[505.687408] Starting subtest: coverage-vs-premult-vs-constant
[506.006913] Starting dynamic subtest: pipe-A-DP-1
[506.441919] Dynamic subtest pipe-A-DP-1: SUCCESS (0.432s)
[506.464397] Starting dynamic subtest: pipe-C-DP-1
[507.093630] Dynamic subtest pipe-C-DP-1: SUCCESS (0.649s)
[507.095110] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.410s)
[507.468145] [105/142] (514s left) gem_exec_balancer (parallel-ordering)
[511.453682] Subtest parallel-ordering: SKIP (0.000s)
[511.550993] [106/142] (510s left) perf (invalid-remove-userspace-config)
[511.796075] Starting subtest: invalid-remove-userspace-config
[511.838916] Subtest invalid-remove-userspace-config: SUCCESS (0.040s)
[511.887220] [107/142] (509s left) kms_lease (lease_invalid_plane)
[512.123160] Starting subtest: lease_invalid_plane
[512.124461] Starting dynamic subtest: pipe-A-DP-1
[512.125800] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[512.150289] Starting dynamic subtest: pipe-B-DP-1
[512.151598] Dynamic subtest pipe-B-DP-1: SUCCESS (0.000s)
[512.172915] Starting dynamic subtest: pipe-C-DP-1
[512.174287] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[512.175595] Subtest lease_invalid_plane: SUCCESS (0.013s)
[512.217660] [108/142] (509s left) gem_busy (parallel)
[512.528259] Starting subtest: parallel
[512.529848] Starting dynamic subtest: rcs0
[512.580080] Dynamic subtest rcs0: SUCCESS (0.051s)
[512.608977] Starting dynamic subtest: bcs0
[512.619096] Dynamic subtest bcs0: SUCCESS (0.036s)
[512.649146] Starting dynamic subtest: vcs0
[512.656058] Dynamic subtest vcs0: SUCCESS (0.035s)
[512.684513] Starting dynamic subtest: vecs0
[512.699955] Dynamic subtest vecs0: SUCCESS (0.040s)
[512.702231] Subtest parallel: SUCCESS (0.174s)
[512.953355] [109/142] (508s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[513.191370] Starting subtest: plane-all-modeset-transition-fencing
[513.195149] Starting dynamic subtest: pipe-A-DP-1
[571.150468] Dynamic subtest pipe-A-DP-1: SUCCESS (57.956s)
[571.279271] Starting dynamic subtest: pipe-B-DP-1
[628.926557] Dynamic subtest pipe-B-DP-1: SUCCESS (57.675s)
[629.021876] Subtest plane-all-modeset-transition-fencing: SUCCESS (115.832s)
[629.356367] [110/142] (392s left) kms_async_flips (test-cursor)
[629.605822] Starting subtest: test-cursor
[629.775483] Starting dynamic subtest: pipe-A-DP-1
[630.111252] Dynamic subtest pipe-A-DP-1: SUCCESS (0.336s)
[630.345164] Starting dynamic subtest: pipe-B-DP-1
[630.568052] Dynamic subtest pipe-B-DP-1: SUCCESS (0.262s)
[630.778469] Starting dynamic subtest: pipe-C-DP-1
[631.015081] Dynamic subtest pipe-C-DP-1: SUCCESS (0.257s)
[631.016620] Subtest test-cursor: SUCCESS (1.413s)
[631.542467] [111/142] (390s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[631.794260] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[631.797541] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[631.890267] [112/142] (390s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[632.137626] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[632.140925] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[632.240903] [113/142] (389s left) gem_mmap (bad-offset)
[632.381691] Starting subtest: bad-offset
[632.383331] Subtest bad-offset: SUCCESS (0.001s)
[632.490221] [114/142] (389s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[632.738601] Starting subtest: psr-shrfb-scaledprimary
[632.741583] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[632.858701] [115/142] (389s left) vgem_basic (dmabuf-fence-before)
[633.017216] Starting subtest: dmabuf-fence-before
[633.018914] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[633.092114] [116/142] (388s left) v3d/v3d_wait_bo (unused-bo-1ns)
[633.283480] Subtest unused-bo-1ns: SKIP (0.000s)
[633.357538] [117/142] (388s left) v3d/v3d_perfmon (get-values-invalid-pointer)
[633.567897] Subtest get-values-invalid-pointer: SKIP (0.000s)
[633.640163] [118/142] (388s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[634.024489] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[634.027570] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[634.442960] [119/142] (387s left) i915_pm_rps (fence-order)
[634.596589] Starting subtest: fence-order
[637.848195] Subtest fence-order: SUCCESS (3.248s)
[638.072733] [120/142] (384s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[638.329926] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[638.333103] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[638.439680] [121/142] (383s left) gem_mmap_gtt (basic-small-bo)
[638.580283] Starting subtest: basic-small-bo
[640.111377] Subtest basic-small-bo: SUCCESS (1.529s)
[640.301378] [122/142] (382s left) kms_cursor_crc (cursor-random-64x64)
[640.682626] Starting subtest: cursor-random-64x64
[640.695584] Starting dynamic subtest: pipe-A-DP-1
[644.676261] Dynamic subtest pipe-A-DP-1: SUCCESS (3.981s)
[644.764892] Starting dynamic subtest: pipe-C-DP-1
[648.644182] Dynamic subtest pipe-C-DP-1: SUCCESS (3.899s)
[648.645786] Subtest cursor-random-64x64: SUCCESS (7.962s)
[649.027511] [123/142] (373s left) syncobj_timeline (wait-delayed-signal)
[649.186311] Starting subtest: wait-delayed-signal
[649.290327] Subtest wait-delayed-signal: SUCCESS (0.103s)
[649.392639] [124/142] (373s left) gem_mmap_offset (blt-coherency)
[649.533028] Starting subtest: blt-coherency
[649.555526] Subtest blt-coherency: SUCCESS (0.022s)
[649.673715] [125/142] (372s left) gem_close_race (multigpu-basic-threads)
[649.854183] Starting subtest: multigpu-basic-threads
[649.856876] Subtest multigpu-basic-threads: SKIP (0.000s)
[650.057140] [126/142] (372s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[650.200868] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[650.306100] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[650.391209] [127/142] (372s left) kms_psr (psr2_dpms)
[650.535866] Subtest psr2_dpms: SKIP (0.000s)
[650.592544] [128/142] (372s left) gem_exec_whisper (basic-contexts)
[650.759493] Starting subtest: basic-contexts
[660.263347] Subtest basic-contexts: SUCCESS (9.502s)
[660.475163] [129/142] (362s left) drm_fdinfo (virtual-busy-idle)
[660.623866] Starting subtest: virtual-busy-idle
[663.222498] Subtest virtual-busy-idle: SUCCESS (2.598s)
[663.306549] [130/142] (359s left) i915_pm_rc6_residency (rc6-fence)
[663.448729] Starting subtest: rc6-fence
[678.694995] Subtest rc6-fence: SUCCESS (15.246s)
[678.959792] [131/142] (343s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[679.107430] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[679.108863] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[679.192662] [132/142] (343s left) kms_big_fb (linear-16bpp-rotate-90)
[679.455372] Starting subtest: linear-16bpp-rotate-90
[679.541234] Subtest linear-16bpp-rotate-90: SKIP (0.084s)
[679.657923] [133/142] (343s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[680.039899] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[680.047552] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.006s)
[680.485273] [134/142] (342s left) kms_atomic_interruptible (atomic-setmode)
[680.730944] Starting subtest: atomic-setmode
[680.735234] Starting dynamic subtest: DP-1-pipe-A
[687.269987] Dynamic subtest DP-1-pipe-A: SUCCESS (6.534s)
[687.271661] Subtest atomic-setmode: SUCCESS (6.540s)
[687.619690] [135/142] (335s left) i915_hangman (error-state-basic)
[687.790395] Starting subtest: error-state-basic
[687.815827] Subtest error-state-basic: SUCCESS (0.022s)
[687.918873] [136/142] (335s left) kms_psr (cursor_blt)
[688.062281] Subtest cursor_blt: SKIP (0.000s)
[688.120348] [137/142] (334s left) kms_flip (2x-wf_vblank-ts-check)
[688.338148] Starting subtest: 2x-wf_vblank-ts-check
[688.340833] Subtest 2x-wf_vblank-ts-check: SKIP (0.003s)
[688.451982] [138/142] (334s left) gem_exec_reloc (basic-wc-gtt-active)
[688.606500] Starting subtest: basic-wc-gtt-active
[688.746513] Subtest basic-wc-gtt-active: SUCCESS (0.138s)
[688.935339] [139/142] (334s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[689.204807] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[689.208225] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[689.318616] [140/142] (333s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[689.558973] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[695.522403] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (5.962s)
[695.863719] [141/142] (327s left) kms_vblank (pipe-d-query-idle-hang)
[696.110032] Subtest pipe-D-query-idle-hang: SKIP (0.000s)
[696.192531] [142/142] (327s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[696.427694] Starting subtest: primary-yf-tiled-reflect-x-90
[696.430340] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.003s)
[696.522683] Closing watchdogs
Done.