[40.341943] Initializing watchdogs
[40.342248]   /dev/watchdog0
[40.354463] [001/139] (960s left) gem_spin_batch (spin-each)
[40.498883] Starting subtest: spin-each
[43.882810] Subtest spin-each: SUCCESS (3.384s)
[44.091964] [002/139] (956s left) gen9_exec_parse (unaligned-jump)
[44.221202] Starting subtest: unaligned-jump
[44.418156] Subtest unaligned-jump: SUCCESS (0.194s)
[44.622605] [003/139] (956s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[44.824670] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[44.827702] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[44.903853] [004/139] (956s left) gem_exec_params (invalid-bsd1-flag-on-render)
[45.014631] Starting subtest: invalid-bsd1-flag-on-render
[45.016375] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[45.096685] [005/139] (955s left) kms_invalid_mode (bad-vsync-start)
[45.281311] Starting subtest: bad-vsync-start
[45.284551] Starting dynamic subtest: pipe-A-HDMI-A-1
[45.698533] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.416s)
[45.709149] Starting dynamic subtest: pipe-A-HDMI-A-2
[45.710965] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.003s)
[45.725163] Starting dynamic subtest: pipe-B-HDMI-A-1
[45.728184] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[45.748920] Starting dynamic subtest: pipe-B-HDMI-A-2
[45.750967] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[45.771473] Starting dynamic subtest: pipe-C-HDMI-A-1
[45.773368] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[45.793931] Starting dynamic subtest: pipe-C-HDMI-A-2
[45.795874] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.001s)
[45.797685] Subtest bad-vsync-start: SUCCESS (0.442s)
[45.978957] [006/139] (955s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled)
[46.086705] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled
[46.132765] Subtest invalid-multi-wait-available-unsubmitted-signaled: FAIL (0.032s)
[46.197168] [007/139] (954s left) gen3_render_linear_blits
[46.347765] [008/139] (954s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[46.541984] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[47.601131] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.057s)
[47.862191] [009/139] (953s left) prime_mmap (test_errors)
[47.967174] Starting subtest: test_errors
[47.968208] Starting dynamic subtest: test_errors-smem
[47.988075] Dynamic subtest test_errors-smem: SUCCESS (0.022s)
[47.989170] Subtest test_errors: SUCCESS (0.023s)
[48.064627] [010/139] (953s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[48.659143] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[48.830834] [011/139] (952s left) kms_ccs (pipe-d-bad-pixel-format-y-tiled-gen12-rc-ccs)
[49.583869] Subtest pipe-D-bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[49.776221] [012/139] (951s left) v3d/v3d_job_submission (threaded-job-submission)
[49.920561] Subtest threaded-job-submission: SKIP (0.000s)
[49.975563] [013/139] (951s left) kms_atomic_transition (modeset-transition-nonblocking)
[50.153751] Starting subtest: modeset-transition-nonblocking
[50.155937] Starting dynamic subtest: 1x-outputs
[55.061820] Dynamic subtest 1x-outputs: SUCCESS (4.905s)
[55.335888] Starting dynamic subtest: 2x-outputs
[65.657772] Dynamic subtest 2x-outputs: SUCCESS (10.351s)
[66.044540] Subtest modeset-transition-nonblocking: SUCCESS (15.890s)
[66.264089] [014/139] (934s left) kms_properties (connector-properties-legacy)
[66.467472] Starting subtest: connector-properties-legacy
[70.093410] Subtest connector-properties-legacy: SUCCESS (3.621s)
[70.359605] [015/139] (930s left) gem_workarounds (suspend-resume-fd)
[70.489919] Starting subtest: suspend-resume-fd
[86.566546] Subtest suspend-resume-fd: SUCCESS (1.073s)
[96.607445] [016/139] (929s left) kms_sequence (get-busy)
[96.793405] Starting subtest: get-busy
[96.799984] Starting dynamic subtest: pipe-A-HDMI-A-1
[99.666191] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.867s)
[99.686994] Starting dynamic subtest: pipe-A-HDMI-A-2
[102.271940] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.603s)
[102.294262] Starting dynamic subtest: pipe-B-HDMI-A-1
[104.843952] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.563s)
[104.859695] Starting dynamic subtest: pipe-B-HDMI-A-2
[107.412702] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.563s)
[107.428197] Starting dynamic subtest: pipe-C-HDMI-A-1
[110.056884] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.640s)
[110.074479] Starting dynamic subtest: pipe-C-HDMI-A-2
[112.741480] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.678s)
[112.743929] Subtest get-busy: SUCCESS (15.947s)
[112.945757] [017/139] (913s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[113.057363] Starting subtest: etime-multi-wait-all-for-submit-submitted
[113.160567] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[113.243056] [018/139] (912s left) kms_plane_scaling (planes-scaler-unity-scaling)
[113.431613] Starting subtest: planes-scaler-unity-scaling
[113.474081] Starting dynamic subtest: pipe-A-HDMI-A-1
[113.783450] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.305s)
[113.831005] Starting dynamic subtest: pipe-B-HDMI-A-1
[114.147029] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.337s)
[114.197695] Subtest planes-scaler-unity-scaling: SUCCESS (0.766s)
[114.592216] [019/139] (911s left) drm_fdinfo (all-busy-check-all)
[114.702728] Starting subtest: all-busy-check-all
[115.222312] Subtest all-busy-check-all: SUCCESS (0.521s)
[115.307500] [020/139] (910s left) gem_lmem_swapping (parallel-random-engines)
[115.421390] Subtest parallel-random-engines: SKIP (0.000s)
[115.459993] [021/139] (910s left) kms_prop_blob (invalid-get-prop-any)
[115.570727] Starting subtest: invalid-get-prop-any
[115.571961] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[115.651648] [022/139] (910s left) gem_exec_schedule (preempt-hang)
[115.896282] Starting subtest: preempt-hang
[115.897404] Starting dynamic subtest: rcs0
[116.143661] Dynamic subtest rcs0: SUCCESS (0.237s)
[116.158691] Starting dynamic subtest: bcs0
[116.385781] Dynamic subtest bcs0: SUCCESS (0.242s)
[116.402378] Starting dynamic subtest: vcs0
[116.610891] Dynamic subtest vcs0: SUCCESS (0.231s)
[116.631439] Starting dynamic subtest: vecs0
[116.846373] Dynamic subtest vecs0: SUCCESS (0.228s)
[116.849126] Subtest preempt-hang: SUCCESS (0.945s)
[117.057885] [023/139] (909s left) kms_addfb_basic (addfb25-bad-modifier)
[117.168049] Starting subtest: addfb25-bad-modifier
[117.169580] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[117.338684] [024/139] (908s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[117.543833] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[117.546318] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[117.621018] [025/139] (908s left) kms_ccs (pipe-d-crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[118.346626] Subtest pipe-D-crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[118.556407] [026/139] (907s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[118.759129] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[118.761738] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[118.851571] [027/139] (907s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[119.867420] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[119.877472] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[120.298272] [028/139] (906s left) kms_content_protection (legacy)
[120.549429] Starting subtest: legacy
[123.537033] Subtest legacy: SKIP (2.977s)
[123.944222] [029/139] (902s left) gen7_exec_parse (bitmasks)
[124.066138] Subtest bitmasks: SKIP (0.000s)
[124.118838] [030/139] (902s left) gem_mmap_gtt (pf-nonblock)
[124.225896] Starting subtest: pf-nonblock
[124.228195] Subtest pf-nonblock: SUCCESS (0.007s)
[124.312737] [031/139] (902s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[124.518706] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[127.052509] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.536s)
[127.250057] [032/139] (899s left) prime_busy (hang)
[127.367411] Starting subtest: hang
[127.368657] Starting dynamic subtest: rcs0
[134.043938] Dynamic subtest rcs0: SUCCESS (6.672s)
[134.058207] Starting dynamic subtest: bcs0
[141.084475] Dynamic subtest bcs0: SUCCESS (7.038s)
[141.097965] Starting dynamic subtest: vcs0
[148.059748] Dynamic subtest vcs0: SUCCESS (6.973s)
[148.077937] Starting dynamic subtest: vecs0
[155.035375] Dynamic subtest vecs0: SUCCESS (6.974s)
[155.036652] Subtest hang: SUCCESS (27.667s)
[155.135888] [033/139] (871s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[155.337858] Starting subtest: cursor-rapid-movement-64x21
[155.409520] Starting dynamic subtest: pipe-A-HDMI-A-1
[156.273008] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.859s)
[156.359286] Starting dynamic subtest: pipe-C-HDMI-A-1
[156.886004] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.545s)
[156.887076] Subtest cursor-rapid-movement-64x21: SUCCESS (1.541s)
[157.187024] [034/139] (869s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[157.383796] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[157.389581] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[157.479347] [035/139] (869s left) kms_psr (sprite_mmap_cpu)
[157.589531] Subtest sprite_mmap_cpu: SKIP (0.000s)
[157.641529] [036/139] (869s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[157.747224] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[157.858759] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[157.937563] [037/139] (868s left) gem_create (create-massive)
[158.041147] Starting subtest: create-massive
[158.042238] Subtest create-massive: SUCCESS (0.000s)
[158.248337] [038/139] (868s left) drm_fdinfo (virtual-busy-idle-all)
[158.358595] Starting subtest: virtual-busy-idle-all
[158.360922] Subtest virtual-busy-idle-all: SUCCESS (0.002s)
[158.438156] [039/139] (868s left) gem_exec_fence (syncobj-signal)
[159.020634] Starting subtest: syncobj-signal
[159.026149] Subtest syncobj-signal: SUCCESS (0.007s)
[159.367739] [040/139] (867s left) kms_ccs (pipe-a-random-ccs-data-4-tiled-dg2-mc-ccs)
[159.945441] Starting subtest: pipe-A-random-ccs-data-4-tiled-dg2-mc-ccs
[159.949598] Subtest pipe-A-random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[160.291843] [041/139] (866s left) syncobj_basic (bad-create-flags)
[160.395653] Starting subtest: bad-create-flags
[160.396795] Subtest bad-create-flags: SUCCESS (0.000s)
[160.484181] [042/139] (866s left) gem_exec_fair (basic-none)
[160.609689] Starting subtest: basic-none
[160.611726] Starting dynamic subtest: rcs0
[166.384386] Dynamic subtest rcs0: FAIL (5.743s)
[166.397305] Starting dynamic subtest: bcs0
[166.400534] Dynamic subtest bcs0: SKIP (0.006s)
[166.413120] Starting dynamic subtest: vcs0
[172.543252] Dynamic subtest vcs0: FAIL (6.152s)
[172.555947] Starting dynamic subtest: vecs0
[178.736612] Dynamic subtest vecs0: FAIL (6.182s)
[178.737927] Subtest basic-none: FAIL (18.094s)
[178.901247] [043/139] (847s left) syncobj_wait (wait-all-snapshot)
[179.009659] Starting subtest: wait-all-snapshot
[179.098059] Subtest wait-all-snapshot: SUCCESS (0.085s)
[179.176755] [044/139] (847s left) kms_pm_rpm (legacy-planes)
[181.108234] Starting subtest: legacy-planes
[181.112918] Starting dynamic subtest: plane-40
[182.671957] Dynamic subtest plane-40: SUCCESS (1.565s)
[182.689477] Starting dynamic subtest: plane-48
[184.172890] Dynamic subtest plane-48: SUCCESS (1.499s)
[184.190219] Starting dynamic subtest: plane-56
[185.708579] Dynamic subtest plane-56: SUCCESS (1.533s)
[185.711267] Subtest legacy-planes: SUCCESS (4.604s)
[186.151181] [045/139] (840s left) kms_pipe_crc_basic (nonblocking-crc)
[186.339311] Starting subtest: nonblocking-crc
[186.349691] Starting dynamic subtest: pipe-A-HDMI-A-1
[187.331044] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.983s)
[187.352837] Starting dynamic subtest: pipe-B-HDMI-A-2
[188.018950] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.680s)
[188.035209] Starting dynamic subtest: pipe-C-HDMI-A-1
[188.712683] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.690s)
[188.715452] Subtest nonblocking-crc: SUCCESS (2.374s)
[188.935719] [046/139] (838s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[189.150333] Starting subtest: fbc-rgb101010-draw-blt
[192.102139] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.953s)
[192.300129] [047/139] (834s left) gem_exec_schedule (semaphore-noskip)
[192.432705] Starting subtest: semaphore-noskip
[192.641370] Subtest semaphore-noskip: SUCCESS (0.206s)
[192.970018] [048/139] (834s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[193.175096] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[193.177272] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[193.266866] [049/139] (833s left) kms_ccs (pipe-a-ccs-on-another-bo-yf-tiled-ccs)
[193.899831] Starting subtest: pipe-A-ccs-on-another-bo-yf-tiled-ccs
[193.901054] Subtest pipe-A-ccs-on-another-bo-yf-tiled-ccs: SUCCESS (0.001s)
[194.235991] [050/139] (832s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[194.450165] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[194.452403] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[194.536513] [051/139] (832s left) kms_plane_scaling (plane-downscale-factor-0-25-with-modifiers)
[194.726024] Starting subtest: plane-downscale-factor-0-25-with-modifiers
[194.757420] Starting dynamic subtest: pipe-A-HDMI-A-1
[194.844256] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.078s)
[194.898465] Starting dynamic subtest: pipe-B-HDMI-A-1
[194.966664] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.089s)
[195.024405] Starting dynamic subtest: pipe-C-HDMI-A-1
[195.156133] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.151s)
[195.159123] Subtest plane-downscale-factor-0-25-with-modifiers: SKIP (0.427s)
[195.270098] [052/139] (831s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[195.892108] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[196.146317] [053/139] (831s left) perf (global-sseu-config-invalid)
[196.383277] Starting subtest: global-sseu-config-invalid
[196.385195] Starting dynamic subtest: 0-rcs0
[196.419173] Dynamic subtest 0-rcs0: SUCCESS (0.037s)
[196.421113] Subtest global-sseu-config-invalid: SUCCESS (0.040s)
[196.470607] [054/139] (830s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[196.576659] Starting subtest: single-wait-for-submit-available-submitted
[196.578174] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[196.654018] [055/139] (830s left) gem_ctx_shared (q-smoketest)
[196.780706] Starting subtest: Q-smoketest
[196.785057] Starting dynamic subtest: rcs0
[202.214564] Dynamic subtest rcs0: SUCCESS (5.426s)
[202.229443] Starting dynamic subtest: bcs0
[207.644397] Dynamic subtest bcs0: SUCCESS (5.427s)
[207.657500] Starting dynamic subtest: vcs0
[213.073065] Dynamic subtest vcs0: SUCCESS (5.427s)
[213.086177] Starting dynamic subtest: vecs0
[218.498206] Dynamic subtest vecs0: SUCCESS (5.422s)
[218.499517] Subtest Q-smoketest: SUCCESS (21.713s)
[218.687934] [056/139] (808s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[218.873078] Starting subtest: 2x-cursor-vs-flip-atomic
[239.129823] Subtest 2x-cursor-vs-flip-atomic: SUCCESS (20.250s)
[239.434651] [057/139] (787s left) kms_flip (plain-flip-ts-check-interruptible)
[239.623608] Starting subtest: plain-flip-ts-check-interruptible
[239.630771] Starting dynamic subtest: A-HDMI-A1
[245.630458] Dynamic subtest A-HDMI-A1: SUCCESS (5.996s)
[245.648376] Starting dynamic subtest: B-HDMI-A1
[251.321389] Dynamic subtest B-HDMI-A1: SUCCESS (5.684s)
[251.344622] Starting dynamic subtest: C-HDMI-A1
[256.960327] Dynamic subtest C-HDMI-A1: SUCCESS (5.636s)
[256.981994] Starting dynamic subtest: A-HDMI-A2
[262.659607] Dynamic subtest A-HDMI-A2: SUCCESS (5.693s)
[262.679249] Starting dynamic subtest: B-HDMI-A2
[268.287052] Dynamic subtest B-HDMI-A2: SUCCESS (5.619s)
[268.303057] Starting dynamic subtest: C-HDMI-A2
[273.929639] Dynamic subtest C-HDMI-A2: SUCCESS (5.639s)
[273.930766] Subtest plain-flip-ts-check-interruptible: SUCCESS (34.304s)
[274.357045] [058/139] (752s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[274.541054] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[285.912963] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SUCCESS (11.362s)
[286.144062] [059/139] (741s left) kms_atomic_interruptible (legacy-cursor)
[286.351034] Starting subtest: legacy-cursor
[286.355943] Starting dynamic subtest: pipe-A-HDMI-A-1
[293.260906] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.905s)
[293.263466] Subtest legacy-cursor: SUCCESS (6.912s)
[293.492646] [060/139] (733s left) syncobj_wait (signal)
[293.608616] Starting subtest: signal
[293.609732] Subtest signal: SUCCESS (0.001s)
[293.698077] [061/139] (733s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[293.906101] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[296.279737] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.377s)
[296.511440] [062/139] (730s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[296.719205] Starting subtest: fbc-rgb101010-draw-render
[299.696514] Subtest fbc-rgb101010-draw-render: SUCCESS (2.977s)
[299.878578] [063/139] (727s left) debugfs_test (basic-hwmon)
[299.990069] Starting subtest: basic-hwmon
[299.992271] Subtest basic-hwmon: SKIP (0.000s)
[300.162186] [064/139] (727s left) gem_fence_thrash (bo-write-verify-threaded-none)
[300.265582] Starting subtest: bo-write-verify-threaded-none
[304.368209] Subtest bo-write-verify-threaded-none: SUCCESS (4.101s)
[304.449298] [065/139] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[304.666201] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[304.668749] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[304.744984] [066/139] (722s left) kms_vblank (wait-busy-hang)
[304.939752] Starting subtest: wait-busy-hang
[304.940919] Starting dynamic subtest: pipe-A-HDMI-A-1
[312.230605] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.286s)
[312.262282] Starting dynamic subtest: pipe-A-HDMI-A-2
[319.293944] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.054s)
[319.328553] Starting dynamic subtest: pipe-C-HDMI-A-1
[326.227906] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.927s)
[326.245421] Starting dynamic subtest: pipe-C-HDMI-A-2
[333.285358] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.048s)
[333.286609] Subtest wait-busy-hang: SUCCESS (28.349s)
[333.558080] [067/139] (694s left) kms_pipe_crc_basic (suspend-read-crc)
[333.742708] Starting subtest: suspend-read-crc
[333.750974] Starting dynamic subtest: pipe-A-HDMI-A-1
[352.075650] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.455s)
[352.091414] Starting dynamic subtest: pipe-B-HDMI-A-2
[369.996340] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.908s)
[370.019989] Starting dynamic subtest: pipe-C-HDMI-A-1
[388.000773] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.889s)
[388.004351] Subtest suspend-read-crc: SUCCESS (6.270s)
[392.226065] [068/139] (687s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[392.432045] Starting subtest: primary-y-tiled-reflect-x-180
[392.435132] Subtest primary-y-tiled-reflect-x-180: SKIP (0.004s)
[392.523295] [069/139] (687s left) kms_chamelium_color (ctm-max)
[392.710848] Subtest ctm-max: SKIP (0.000s)
[392.758243] [070/139] (686s left) kms_vblank (ts-continuation-idle-hang)
[392.942966] Starting subtest: ts-continuation-idle-hang
[392.952544] Starting dynamic subtest: pipe-A-HDMI-A-1
[400.234772] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.284s)
[400.270721] Starting dynamic subtest: pipe-A-HDMI-A-2
[407.257458] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.013s)
[407.287509] Starting dynamic subtest: pipe-C-HDMI-A-1
[414.224967] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.951s)
[414.238563] Starting dynamic subtest: pipe-C-HDMI-A-2
[421.198029] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.968s)
[421.199647] Subtest ts-continuation-idle-hang: SUCCESS (28.255s)
[421.471631] [071/139] (658s left) gem_ctx_persistence (file)
[421.585994] Starting subtest: file
[421.656805] Subtest file: SUCCESS (0.070s)
[421.742582] [072/139] (658s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[421.947748] Starting subtest: x-tiled-32bpp-rotate-90
[422.289048] Subtest x-tiled-32bpp-rotate-90: SKIP (0.339s)
[422.487764] [073/139] (657s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[422.682682] Starting subtest: pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[422.687322] Subtest pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[423.471339] [074/139] (656s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt)
[423.676028] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt
[423.678393] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[423.766182] [075/139] (656s left) v3d/v3d_wait_bo (used-bo-1ns)
[423.922690] Subtest used-bo-1ns: SKIP (0.000s)
[423.992299] [076/139] (655s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[424.177934] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[424.186189] Starting dynamic subtest: pipe-A-valid-mode
[424.612315] Dynamic subtest pipe-A-valid-mode: SKIP (0.428s)
[424.615861] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.435s)
[424.888324] [077/139] (655s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-dg2-mc-ccs)
[425.563786] Starting subtest: pipe-B-bad-rotation-90-4-tiled-dg2-mc-ccs
[425.566148] Subtest pipe-B-bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[425.873512] [078/139] (654s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[426.085394] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[429.241426] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SUCCESS (3.156s)
[429.391788] [079/139] (650s left) api_intel_bb (intel-bb-blit-x)
[429.499356] Starting subtest: intel-bb-blit-x
[432.038170] Subtest intel-bb-blit-x: SUCCESS (2.533s)
[432.125436] [080/139] (647s left) gem_exec_balancer (full-late-pulse)
[432.246111] Starting subtest: full-late-pulse
[435.197479] Subtest full-late-pulse: SUCCESS (2.949s)
[438.145466] [081/139] (641s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[438.347790] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[438.351081] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[438.435957] [082/139] (641s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[438.634290] Starting subtest: addfb25-y-tiled-legacy
[438.635441] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[438.723441] [083/139] (641s left) prime_mmap (test_correct)
[438.827763] Starting subtest: test_correct
[438.828840] Starting dynamic subtest: test_correct-smem
[438.835580] Dynamic subtest test_correct-smem: SUCCESS (0.009s)
[438.839208] Subtest test_correct: SUCCESS (0.011s)
[438.925048] [084/139] (641s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[439.129839] Starting subtest: psr-rgb101010-draw-blt
[439.133410] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[439.219235] [085/139] (640s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[439.410884] Starting subtest: cursorB-vs-flipA-legacy
[450.766208] Subtest cursorB-vs-flipA-legacy: SUCCESS (11.345s)
[450.997354] [086/139] (629s left) gem_eio (wait-1us)
[451.139193] Starting subtest: wait-1us
[451.232608] Subtest wait-1us: SUCCESS (0.090s)
[451.404734] [087/139] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[451.612393] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[451.614569] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[451.704365] [088/139] (628s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[451.897385] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[451.899899] Starting dynamic subtest: pipe-A-valid-mode
[452.341716] Dynamic subtest pipe-A-valid-mode: SKIP (0.440s)
[452.344297] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.445s)
[452.567446] [089/139] (627s left) gem_eio (wait-10ms)
[452.698773] Starting subtest: wait-10ms
[452.805876] Subtest wait-10ms: SUCCESS (0.107s)
[452.985136] [090/139] (627s left) kms_ccs (pipe-d-random-ccs-data-y-tiled-gen12-rc-ccs)
[453.706332] Subtest pipe-D-random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[453.916387] [091/139] (626s left) i915_pm_rpm (system-suspend)
[455.841452] Starting subtest: system-suspend
[474.566571] Subtest system-suspend: SUCCESS (0.972s)
[481.739804] [092/139] (623s left) gem_eio (create)
[481.859121] Starting subtest: create
[481.923399] Subtest create: SUCCESS (0.061s)
[482.095019] [093/139] (622s left) gem_exec_reloc (basic-wc-cpu-active)
[482.208099] Starting subtest: basic-wc-cpu-active
[482.341531] Subtest basic-wc-cpu-active: SUCCESS (0.128s)
[482.511022] [094/139] (622s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[482.616535] Starting subtest: multi-wait-available-submitted-signaled
[482.617776] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.002s)
[482.696381] [095/139] (622s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[482.902292] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[485.346429] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.444s)
[485.482363] [096/139] (619s left) gem_caching (read-writes)
[485.595103] Starting subtest: read-writes
[507.230180] Subtest read-writes: SUCCESS (21.637s)
[507.355036] [097/139] (597s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[507.478310] Starting subtest: x-tiled-to-vebox-yf-tiled
[507.480775] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[507.683532] [098/139] (597s left) gem_ccs (block-multicopy-compressed)
[507.796456] Subtest block-multicopy-compressed: SKIP (0.000s)
[507.851579] [099/139] (597s left) kms_cursor_legacy (single-bo)
[508.044474] Starting subtest: single-bo
[508.047005] Starting dynamic subtest: pipe-A
[513.450108] Dynamic subtest pipe-A: SUCCESS (5.401s)
[513.467874] Starting dynamic subtest: pipe-B
[518.848329] Dynamic subtest pipe-B: SUCCESS (5.398s)
[518.869081] Starting dynamic subtest: pipe-C
[524.246003] Dynamic subtest pipe-C: SUCCESS (5.397s)
[524.260996] Starting dynamic subtest: all-pipes
[529.650815] Dynamic subtest all-pipes: SUCCESS (5.397s)
[529.652450] Subtest single-bo: SUCCESS (21.602s)
[529.731539] [100/139] (575s left) gem_tiled_blits (interruptible)
[530.975076] Starting subtest: interruptible
[585.468482] Subtest interruptible: SUCCESS (54.496s)
[585.568157] [101/139] (519s left) kms_addfb_basic (bad-pitch-63)
[585.779853] Starting subtest: bad-pitch-63
[585.783550] Subtest bad-pitch-63: SUCCESS (0.000s)
[585.963544] [102/139] (519s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[586.090049] Starting subtest: yf-tiled-to-vebox-x-tiled
[586.092281] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[586.283637] [103/139] (518s left) gem_exercise_blt (fast-copy-emit)
[586.400412] Starting subtest: fast-copy-emit
[586.405057] Starting dynamic subtest: linear-smem-smem-emit
[586.453430] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.052s)
[586.471744] Starting dynamic subtest: ymajor-smem-smem-emit
[586.497344] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.042s)
[586.516397] Starting dynamic subtest: yfmajor-smem-smem-emit
[586.540008] Dynamic subtest yfmajor-smem-smem-emit: SUCCESS (0.039s)
[586.557660] Starting dynamic subtest: tile64-smem-smem-emit
[586.580823] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.039s)
[586.582151] Subtest fast-copy-emit: SUCCESS (0.181s)
[586.681981] [104/139] (518s left) kms_dsc (dsc-with-bpc)
[586.877667] Subtest dsc-with-bpc: SKIP (0.000s)
[586.929031] [105/139] (518s left) i915_pm_rps (thresholds-park)
[587.041137] Starting subtest: thresholds-park
[587.046968] Starting dynamic subtest: gt0
[601.834035] Dynamic subtest gt0: SUCCESS (14.788s)
[601.836855] Subtest thresholds-park: SUCCESS (14.792s)
[601.917378] [106/139] (503s left) kms_psr (psr2_sprite_blt)
[602.026765] Subtest psr2_sprite_blt: SKIP (0.000s)
[602.081921] [107/139] (503s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[602.287630] Starting subtest: yf-tiled-addfb-size-offset-overflow
[602.292831] Subtest yf-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[602.380238] [108/139] (503s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[602.581808] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[604.433170] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.851s)
[604.581231] [109/139] (500s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[605.271594] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[605.276995] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[605.551682] [110/139] (499s left) gem_exec_store (basic)
[605.683608] Starting subtest: basic
[605.722470] Subtest basic: SUCCESS (0.039s)
[605.921876] [111/139] (499s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[606.598815] Starting subtest: pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[606.602203] Subtest pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.001s)
[606.919359] [112/139] (498s left) gem_exec_params (dr1-dirt)
[607.038038] Starting subtest: DR1-dirt
[607.039213] Subtest DR1-dirt: SUCCESS (0.001s)
[607.125652] [113/139] (498s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[607.331217] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[609.939921] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.609s)
[610.141990] [114/139] (495s left) kms_rotation_crc (primary-rotation-270)
[610.339139] Starting subtest: primary-rotation-270
[625.797309] Subtest primary-rotation-270: SUCCESS (15.456s)
[625.990884] [115/139] (479s left) syncobj_timeline (wait-all-for-submit-snapshot)
[626.121004] Starting subtest: wait-all-for-submit-snapshot
[626.209258] Subtest wait-all-for-submit-snapshot: SUCCESS (0.086s)
[626.293217] [116/139] (479s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-gen12-mc-ccs)
[627.042810] Subtest pipe-D-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[627.259274] [117/139] (478s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[627.372607] Starting subtest: invalid-single-wait-all-unsubmitted
[627.374665] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.001s)
[627.458295] [118/139] (478s left) i915_pm_freq_api (freq-basic-api)
[627.569506] Subtest freq-basic-api: SKIP (0.000s)
[627.615184] [119/139] (478s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[628.368874] Starting subtest: pipe-C-random-ccs-data-4-tiled-mtl-rc-ccs-cc
[628.372475] Subtest pipe-C-random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[628.608449] [120/139] (477s left) kms_ccs (pipe-c-bad-pixel-format-y-tiled-gen12-rc-ccs)
[629.327631] Starting subtest: pipe-C-bad-pixel-format-y-tiled-gen12-rc-ccs
[629.329900] Subtest pipe-C-bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[629.602293] [121/139] (476s left) kms_pm_dc (dc5-psr)
[630.808372] Starting subtest: dc5-psr
[630.811990] Subtest dc5-psr: SKIP (0.000s)
[630.955586] [122/139] (474s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[631.164239] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[631.166681] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[631.252921] [123/139] (474s left) sw_sync (sync_random_merge)
[631.358179] Starting subtest: sync_random_merge
[631.472019] Subtest sync_random_merge: SUCCESS (0.114s)
[631.537215] [124/139] (474s left) gem_exec_params (readonly)
[631.649594] Starting subtest: readonly
[631.651257] Subtest readonly: SUCCESS (0.002s)
[631.749171] [125/139] (474s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[631.960100] Starting subtest: psr-2p-pri-indfb-multidraw
[631.962340] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[632.048808] [126/139] (474s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[632.689988] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[632.693216] Subtest pipe-A-crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.001s)
[633.041582] [127/139] (473s left) vc4/vc4_wait_bo (bad-bo)
[633.203938] Subtest bad-bo: SKIP (0.000s)
[633.275620] [128/139] (472s left) gem_exec_reloc (basic-cpu-read-active)
[633.390023] Starting subtest: basic-cpu-read-active
[633.518174] Subtest basic-cpu-read-active: SUCCESS (0.125s)
[633.686591] [129/139] (472s left) gem_tiling_max_stride
[633.943567] [130/139] (472s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[634.150681] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[636.477192] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SUCCESS (2.326s)
[636.609716] [131/139] (469s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[639.256673] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[639.341101] [132/139] (466s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[639.547192] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[639.549658] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.001s)
[639.638265] [133/139] (466s left) gem_exec_flush (basic-uc-rw-default)
[639.761625] Starting subtest: basic-uc-rw-default
[645.179694] Subtest basic-uc-rw-default: SUCCESS (5.417s)
[645.373531] [134/139] (460s left) syncobj_wait (wait-any-complex)
[645.485340] Starting subtest: wait-any-complex
[645.553988] Subtest wait-any-complex: SUCCESS (0.065s)
[645.639930] [135/139] (460s left) kms_addfb_basic (bo-too-small)
[645.832576] Starting subtest: bo-too-small
[645.833998] Subtest bo-too-small: SUCCESS (0.000s)
[645.921869] [136/139] (460s left) kms_ccs (pipe-c-bad-aux-stride-4-tiled-mtl-mc-ccs)
[646.663978] Starting subtest: pipe-C-bad-aux-stride-4-tiled-mtl-mc-ccs
[646.666486] Subtest pipe-C-bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[646.892886] [137/139] (459s left) v3d/v3d_perfmon (get-values-valid-perfmon)
[647.055862] Subtest get-values-valid-perfmon: SKIP (0.000s)
[647.132063] [138/139] (459s left) kms_cursor_crc (cursor-random-256x256)
[647.340527] Starting subtest: cursor-random-256x256
[647.405161] Starting dynamic subtest: pipe-A-HDMI-A-1
[651.725389] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.317s)
[651.842868] Starting dynamic subtest: pipe-C-HDMI-A-1
[655.622826] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.815s)
[655.624992] Subtest cursor-random-256x256: SUCCESS (8.286s)
[655.877258] [139/139] (450s left) vc4/vc4_perfmon (create-perfmon-exceed)
[656.038483] Subtest create-perfmon-exceed: SKIP (0.000s)
[656.105443] Closing watchdogs
Done.