[36.819500] Initializing watchdogs
[36.819705]   /dev/watchdog0
[36.855475] [001/140] (960s left) gen9_exec_parse (shadow-peek)
[37.148138] Starting subtest: shadow-peek
[37.168930] Subtest shadow-peek: SUCCESS (0.015s)
[37.403806] [002/140] (960s left) gem_exec_schedule (noreorder)
[37.797308] Starting subtest: noreorder
[37.816149] Starting dynamic subtest: rcs0
[37.861708] Dynamic subtest rcs0: SUCCESS (0.066s)
[37.894791] Starting dynamic subtest: bcs0
[37.915577] Dynamic subtest bcs0: SUCCESS (0.052s)
[37.946532] Starting dynamic subtest: vcs0
[37.965825] Dynamic subtest vcs0: SUCCESS (0.061s)
[37.998479] Starting dynamic subtest: vecs0
[38.025458] Dynamic subtest vecs0: SUCCESS (0.051s)
[38.047404] Subtest noreorder: SUCCESS (0.232s)
[38.218679] [003/140] (959s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[38.582642] Starting subtest: x-tiled-64bpp-rotate-0
[46.384092] Subtest x-tiled-64bpp-rotate-0: SUCCESS (7.838s)
[47.358179] [004/140] (950s left) gem_pread (snoop)
[47.578488] Starting subtest: snoop
[52.472905] Subtest snoop: SUCCESS (4.701s)
[52.575425] [005/140] (945s left) kms_busy (extended-pageflip-hang-newfb)
[52.907991] Starting subtest: extended-pageflip-hang-newfb
[52.933127] Starting dynamic subtest: pipe-A
[57.109866] Dynamic subtest pipe-A: SUCCESS (4.201s)
[57.142769] Starting dynamic subtest: pipe-C
[61.105211] Dynamic subtest pipe-C: SUCCESS (3.955s)
[61.125776] Subtest extended-pageflip-hang-newfb: SUCCESS (8.166s)
[61.432850] [006/140] (936s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[61.843403] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[61.946158] [007/140] (935s left) gem_tiling_max_stride
[62.318067] [008/140] (935s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[62.738348] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[63.034536] [009/140] (935s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[63.265451] Starting subtest: basic-write-cpu-read-gtt
[63.302499] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[63.386855] [010/140] (934s left) kms_addfb_basic (invalid-set-prop-any)
[63.616560] Starting subtest: invalid-set-prop-any
[63.638125] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[63.805060] [011/140] (934s left) prime_udl
[64.110176] [012/140] (934s left) api_intel_allocator (two-level-inception-interruptible)
[64.344470] Starting subtest: two-level-inception-interruptible
[70.043822] Subtest two-level-inception-interruptible: SUCCESS (5.557s)
[70.129749] [013/140] (928s left) kms_rotation_crc (primary-rotation-180)
[70.424516] Starting subtest: primary-rotation-180
[74.796796] Subtest primary-rotation-180: SUCCESS (4.381s)
[75.227970] [014/140] (923s left) kms_flip (bo-too-big)
[75.526762] Starting subtest: bo-too-big
[75.549146] Starting dynamic subtest: A-DP1
[78.731972] Dynamic subtest A-DP1: SUCCESS (3.038s)
[78.767529] Starting dynamic subtest: B-DP1
[81.677517] Dynamic subtest B-DP1: SUCCESS (2.944s)
[81.715441] Starting dynamic subtest: C-DP1
[84.654193] Dynamic subtest C-DP1: SUCCESS (2.975s)
[84.673646] Subtest bo-too-big: SUCCESS (8.963s)
[85.325473] [015/140] (913s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[85.667769] Starting subtest: y-tiled-ccs-to-x-tiled
[85.686636] Starting dynamic subtest: smem
[85.953594] Dynamic subtest smem: SUCCESS (0.293s)
[85.974570] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.294s)
[86.205868] [016/140] (912s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[86.471050] Starting subtest: invalid-signal-one-illegal-handle
[86.489983] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.001s)
[86.571631] [017/140] (912s left) kms_psr (psr_primary_blt)
[86.900483] Subtest psr_primary_blt: SKIP (0.000s)
[86.986810] [018/140] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[87.332877] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[87.374891] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[87.459064] [019/140] (911s left) gem_mmap_gtt (basic-copy)
[87.684506] Starting subtest: basic-copy
[88.435127] Subtest basic-copy: SUCCESS (0.787s)
[88.569886] [020/140] (910s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[89.122127] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[89.470906] [021/140] (909s left) kms_plane_scaling (planes-upscale-20x20)
[89.782202] Starting subtest: planes-upscale-20x20
[89.806960] Starting dynamic subtest: pipe-A-DP-1
[89.859573] Dynamic subtest pipe-A-DP-1: SUCCESS (0.063s)
[89.897091] Starting dynamic subtest: pipe-B-DP-1
[90.237482] Dynamic subtest pipe-B-DP-1: SUCCESS (0.365s)
[90.261251] Subtest planes-upscale-20x20: SUCCESS (0.457s)
[90.670350] [022/140] (908s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[91.018023] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[91.060387] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[91.149071] [023/140] (908s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[91.500515] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[91.540655] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[91.628610] [024/140] (907s left) gem_pipe_control_store_loop (reused-buffer)
[91.860408] Starting subtest: reused-buffer
[94.160072] Subtest reused-buffer: SUCCESS (2.153s)
[94.239726] [025/140] (905s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-dg2-rc-ccs)
[94.665814] Starting subtest: pipe-B-bad-rotation-90-4-tiled-dg2-rc-ccs
[94.705333] Subtest pipe-B-bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[95.081192] [026/140] (904s left) kms_rotation_crc (cursor-rotation-180)
[95.368072] Starting subtest: cursor-rotation-180
[96.178522] Subtest cursor-rotation-180: SUCCESS (0.814s)
[96.617147] [027/140] (902s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[96.914315] Starting subtest: cursorA-vs-flipA-atomic-transitions
[107.985523] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.074s)
[108.369279] [028/140] (891s left) kms_force_connector_basic (prune-stale-modes)
[108.649919] Subtest prune-stale-modes: SKIP (0.000s)
[108.765168] [029/140] (891s left) perf (low-oa-exponent-permissions)
[109.147542] Starting subtest: low-oa-exponent-permissions
[109.306805] Subtest low-oa-exponent-permissions: SUCCESS (0.156s)
[109.429984] [030/140] (890s left) gem_exec_reloc (basic-write-wc-active)
[109.665932] Starting subtest: basic-write-wc-active
[109.777217] Subtest basic-write-wc-active: SUCCESS (0.137s)
[109.993653] [031/140] (890s left) gem_exec_params (invalid-bsd2-flag-on-render)
[110.228490] Starting subtest: invalid-bsd2-flag-on-render
[110.247526] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.001s)
[110.356175] [032/140] (889s left) gem_exec_fence (syncobj-invalid-wait)
[111.111332] Starting subtest: syncobj-invalid-wait
[111.131994] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[111.480851] [033/140] (888s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[111.708116] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[111.728647] Starting dynamic subtest: smem
[112.117906] Dynamic subtest smem: SUCCESS (0.418s)
[112.138505] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.420s)
[112.348395] [034/140] (887s left) kms_cursor_legacy (forked-bo)
[112.638093] Starting subtest: forked-bo
[112.696367] Starting dynamic subtest: pipe-A
[118.301185] Dynamic subtest pipe-A: SUCCESS (5.464s)
[118.351677] Starting dynamic subtest: pipe-B
[123.777182] Dynamic subtest pipe-B: SUCCESS (5.478s)
[123.824025] Starting dynamic subtest: pipe-C
[129.255353] Dynamic subtest pipe-C: SUCCESS (5.477s)
[129.314161] Starting dynamic subtest: all-pipes
[134.544465] Dynamic subtest all-pipes: SUCCESS (5.466s)
[134.565930] Subtest forked-bo: SUCCESS (21.891s)
[134.655272] [035/140] (865s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[135.012145] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[135.054506] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[135.139913] [036/140] (865s left) kms_color (ctm-0-50)
[135.418103] Starting subtest: ctm-0-50
[135.436512] Starting dynamic subtest: pipe-A
[137.265259] Dynamic subtest pipe-A: SUCCESS (1.838s)
[137.298105] Starting dynamic subtest: pipe-B
[139.290059] Dynamic subtest pipe-B: SUCCESS (2.022s)
[139.328857] Starting dynamic subtest: pipe-C
[141.304987] Dynamic subtest pipe-C: SUCCESS (2.013s)
[141.330913] Subtest ctm-0-50: SUCCESS (5.878s)
[141.679257] [037/140] (858s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-dg2-mc-ccs)
[142.188653] Starting subtest: pipe-C-bad-rotation-90-4-tiled-dg2-mc-ccs
[142.240309] Subtest pipe-C-bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[142.575190] [038/140] (858s left) drm_fdinfo (busy)
[142.851271] Starting subtest: busy
[142.876556] Starting dynamic subtest: rcs0
[143.352041] Dynamic subtest rcs0: SUCCESS (0.528s)
[143.392662] Starting dynamic subtest: bcs0
[144.103387] Dynamic subtest bcs0: SUCCESS (0.538s)
[144.141151] Starting dynamic subtest: vcs0
[144.418873] Dynamic subtest vcs0: SUCCESS (0.524s)
[144.461080] Starting dynamic subtest: vecs0
[144.940403] Dynamic subtest vecs0: SUCCESS (0.525s)
[144.964427] Subtest busy: SUCCESS (2.123s)
[145.077065] [039/140] (855s left) gem_ctx_engines (none)
[145.338555] Starting subtest: none
[145.362344] Subtest none: SUCCESS (0.003s)
[145.570831] [040/140] (855s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[145.833335] Starting subtest: no-spare-fences-busy
[147.970139] Subtest no-spare-fences-busy: SUCCESS (2.158s)
[148.330119] [041/140] (852s left) kms_ccs (pipe-a-ccs-on-another-bo-y-tiled-ccs)
[148.745085] Starting subtest: pipe-A-ccs-on-another-bo-y-tiled-ccs
[148.766933] Subtest pipe-A-ccs-on-another-bo-y-tiled-ccs: SUCCESS (0.001s)
[149.208947] [042/140] (851s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[149.548133] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[151.061966] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.541s)
[151.251959] [043/140] (849s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[151.588541] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[151.627295] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[151.722317] [044/140] (849s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-mtl-rc-ccs)
[152.116681] Starting subtest: pipe-A-crc-primary-basic-4-tiled-mtl-rc-ccs
[152.160564] Subtest pipe-A-crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.001s)
[152.590647] [045/140] (848s left) kms_atomic_transition (modeset-transition-nonblocking)
[152.895346] Starting subtest: modeset-transition-nonblocking
[152.914760] Starting dynamic subtest: 1x-outputs
[157.758156] Dynamic subtest 1x-outputs: SUCCESS (4.871s)
[157.868725] Subtest modeset-transition-nonblocking: SUCCESS (4.969s)
[158.231490] [046/140] (843s left) kms_pm_rpm (fences)
[160.120532] Starting subtest: fences
[162.941558] Subtest fences: SUCCESS (2.816s)
[163.160961] [047/140] (838s left) syncobj_wait (wait-all-for-submit-snapshot)
[163.401947] Starting subtest: wait-all-for-submit-snapshot
[163.457497] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[163.571579] [048/140] (837s left) kms_cursor_crc (cursor-sliding-max-size)
[163.898479] Starting subtest: cursor-sliding-max-size
[163.960626] Subtest cursor-sliding-max-size: SKIP (0.000s)
[164.051628] [049/140] (837s left) gem_busy (parallel)
[164.413602] Starting subtest: parallel
[164.433782] Starting dynamic subtest: rcs0
[164.494713] Dynamic subtest rcs0: SUCCESS (0.061s)
[164.529857] Starting dynamic subtest: bcs0
[164.552227] Dynamic subtest bcs0: SUCCESS (0.043s)
[164.589251] Starting dynamic subtest: vcs0
[164.610325] Dynamic subtest vcs0: SUCCESS (0.039s)
[164.645574] Starting dynamic subtest: vecs0
[164.664814] Dynamic subtest vecs0: SUCCESS (0.037s)
[164.683914] Subtest parallel: SUCCESS (0.191s)
[164.866065] [050/140] (836s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[165.221660] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[165.264928] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[165.354649] [051/140] (836s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[165.660275] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[165.679440] Starting dynamic subtest: pipe-A-valid-mode
[166.443914] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.774s)
[166.465780] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.778s)
[166.798207] [052/140] (835s left) kms_ccs (pipe-c-crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[167.300184] Starting subtest: pipe-C-crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[167.346826] Subtest pipe-C-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.001s)
[167.686328] [053/140] (834s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-dg2-rc-ccs)
[168.232885] Subtest pipe-D-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[168.564965] [054/140] (833s left) kms_ccs (pipe-d-bad-rotation-90-4-tiled-mtl-rc-ccs)
[169.106605] Subtest pipe-D-bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[169.434291] [055/140] (832s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[169.859934] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[170.174689] [056/140] (831s left) gem_mmap_offset (blt-coherency)
[170.411706] Starting subtest: blt-coherency
[170.433609] Subtest blt-coherency: SUCCESS (0.021s)
[170.525541] [057/140] (831s left) gem_mmap_wc (read-write-distinct)
[170.767348] Starting subtest: read-write-distinct
[170.788901] Subtest read-write-distinct: SUCCESS (0.032s)
[170.894611] [058/140] (831s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[171.104434] Starting subtest: single-wait-for-submit-available-submitted
[171.123504] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[171.211194] [059/140] (831s left) kms_async_flips (test-time-stamp)
[171.515764] Starting subtest: test-time-stamp
[171.698401] Starting dynamic subtest: pipe-A-DP-1
[172.103103] Dynamic subtest pipe-A-DP-1: SUCCESS (0.405s)
[172.302076] Starting dynamic subtest: pipe-B-DP-1
[172.588072] Dynamic subtest pipe-B-DP-1: SUCCESS (0.293s)
[172.782868] Starting dynamic subtest: pipe-C-DP-1
[173.069045] Dynamic subtest pipe-C-DP-1: SUCCESS (0.290s)
[173.088262] Subtest test-time-stamp: SUCCESS (1.541s)
[173.563858] [060/140] (828s left) gem_ctx_persistence (smoketest)
[173.801124] Starting subtest: smoketest
[204.860727] Subtest smoketest: SUCCESS (31.067s)
[204.964076] [061/140] (797s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[205.484185] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[205.525377] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[205.839567] [062/140] (796s left) gem_vm_create (execbuf)
[206.072634] Starting subtest: execbuf
[206.094414] Subtest execbuf: SUCCESS (0.012s)
[206.207202] [063/140] (796s left) gem_softpin (evict-single-offset)
[206.443247] Starting subtest: evict-single-offset
[242.511681] Subtest evict-single-offset: SUCCESS (36.093s)
[242.640245] [064/140] (760s left) prime_mmap_coherency (read)
[243.012191] Starting subtest: read
[248.573234] Subtest read: SUCCESS (5.406s)
[248.665762] [065/140] (754s left) kms_ccs (pipe-d-random-ccs-data-4-tiled-dg2-rc-ccs)
[249.287974] Subtest pipe-D-random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[249.608746] [066/140] (753s left) kms_lease (lease-invalid-crtc)
[249.910554] Starting subtest: lease-invalid-crtc
[249.929494] Starting dynamic subtest: pipe-A-DP-1
[249.948358] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[249.983370] Starting dynamic subtest: pipe-B-DP-1
[250.002083] Dynamic subtest pipe-B-DP-1: SUCCESS (0.000s)
[250.040040] Starting dynamic subtest: pipe-C-DP-1
[250.061953] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[250.082483] Subtest lease-invalid-crtc: SUCCESS (0.012s)
[250.172407] [067/140] (752s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[250.472783] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[250.491680] Starting dynamic subtest: pipe-A-valid-mode
[250.581870] Dynamic subtest pipe-A-valid-mode: SKIP (0.088s)
[250.620140] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.092s)
[250.890352] [068/140] (752s left) kms_plane_scaling (planes-downscale-factor-0-75)
[251.191938] Starting subtest: planes-downscale-factor-0-75
[251.213676] Starting dynamic subtest: pipe-A-DP-1
[251.301820] Dynamic subtest pipe-A-DP-1: SUCCESS (0.094s)
[251.341968] Starting dynamic subtest: pipe-B-DP-1
[251.698486] Dynamic subtest pipe-B-DP-1: SUCCESS (0.394s)
[251.717461] Subtest planes-downscale-factor-0-75: SUCCESS (0.519s)
[252.141871] [069/140] (751s left) prime_self_import (export-vs-gem_close-race)
[252.362130] Starting subtest: export-vs-gem_close-race
[257.571930] Subtest export-vs-gem_close-race: SUCCESS (5.022s)
[257.659848] [070/140] (745s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[257.922774] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[257.941926] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[258.039871] [071/140] (745s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[258.269921] Starting subtest: multi-wait-all-for-submit-available-signaled
[258.288812] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.002s)
[258.382463] [072/140] (745s left) gem_exec_schedule (smoketest)
[258.776133] Starting subtest: smoketest
[258.797798] Starting dynamic subtest: rcs0
[264.465181] Dynamic subtest rcs0: SUCCESS (5.461s)
[264.506690] Starting dynamic subtest: bcs0
[269.756262] Dynamic subtest bcs0: SUCCESS (5.455s)
[269.793135] Starting dynamic subtest: vcs0
[275.390812] Dynamic subtest vcs0: SUCCESS (5.463s)
[275.427709] Starting dynamic subtest: vecs0
[280.676489] Dynamic subtest vecs0: SUCCESS (5.463s)
[280.695241] Subtest smoketest: SUCCESS (21.853s)
[280.830410] [073/140] (722s left) gem_set_tiling_vs_pwrite
[281.183603] [074/140] (722s left) gem_exec_fence (syncobj-timeline-signal)
[281.997927] Starting subtest: syncobj-timeline-signal
[282.016738] Subtest syncobj-timeline-signal: SUCCESS (0.010s)
[282.257502] [075/140] (721s left) kms_draw_crc (draw-method-pwrite)
[282.555309] Starting subtest: draw-method-pwrite
[282.573797] Starting dynamic subtest: xrgb8888-untiled
[282.848471] Dynamic subtest xrgb8888-untiled: SUCCESS (0.291s)
[282.883549] Starting dynamic subtest: rgb565-untiled
[283.113383] Dynamic subtest rgb565-untiled: SUCCESS (0.264s)
[283.148698] Starting dynamic subtest: xrgb2101010-untiled
[283.425804] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.298s)
[283.466175] Starting dynamic subtest: xrgb8888-xtiled
[283.743080] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.314s)
[283.785131] Starting dynamic subtest: rgb565-xtiled
[284.065317] Dynamic subtest rgb565-xtiled: SUCCESS (0.314s)
[284.115821] Starting dynamic subtest: xrgb2101010-xtiled
[284.374191] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.314s)
[284.418819] Starting dynamic subtest: xrgb8888-ytiled
[284.689570] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.314s)
[284.730724] Starting dynamic subtest: rgb565-ytiled
[284.978227] Dynamic subtest rgb565-ytiled: SUCCESS (0.281s)
[285.018310] Starting dynamic subtest: xrgb2101010-ytiled
[285.296432] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.314s)
[285.324801] Subtest draw-method-pwrite: SUCCESS (2.727s)
[285.434929] [076/140] (718s left) v3d/v3d_perfmon (get-values-invalid-pad)
[285.749594] Subtest get-values-invalid-pad: SKIP (0.000s)
[285.858598] [077/140] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[286.250551] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[286.288126] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[286.381570] [078/140] (717s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[286.624271] Starting subtest: cpuset-basic-small-copy-odd
[292.531375] Subtest cpuset-basic-small-copy-odd: SUCCESS (5.944s)
[292.644557] [079/140] (711s left) i915_pm_freq_api (freq-reset)
[293.000664] Subtest freq-reset: SKIP (0.000s)
[293.089495] [080/140] (711s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[293.491244] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[293.567236] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[293.662548] [081/140] (710s left) gem_pwrite (basic-random)
[293.910139] Starting subtest: basic-random
[299.646495] Subtest basic-random: SUCCESS (5.575s)
[299.774990] [082/140] (704s left) gem_workarounds (reset)
[300.159349] Starting subtest: reset
[300.180302] Subtest reset: SUCCESS (0.025s)
[300.304526] [083/140] (704s left) kms_flip (2x-plain-flip-ts-check)
[300.630061] Starting subtest: 2x-plain-flip-ts-check
[300.671541] Subtest 2x-plain-flip-ts-check: SKIP (0.003s)
[300.758741] [084/140] (703s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-dg2-rc-ccs)
[301.299628] Starting subtest: pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs
[301.339939] Subtest pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[301.684404] [085/140] (703s left) prime_mmap (test_errors)
[301.901436] Starting subtest: test_errors
[301.920312] Starting dynamic subtest: test_errors-smem
[301.939130] Dynamic subtest test_errors-smem: SUCCESS (0.017s)
[301.957683] Subtest test_errors: SUCCESS (0.020s)
[302.049557] [086/140] (702s left) v3d/v3d_create_bo (create-bo-4096)
[302.369876] Subtest create-bo-4096: SKIP (0.000s)
[302.459558] [087/140] (702s left) vgem_basic (bad-flag)
[302.692739] Starting subtest: bad-flag
[302.713453] Subtest bad-flag: SUCCESS (0.000s)
[302.800547] [088/140] (702s left) gem_exec_whisper (basic-normal)
[303.072470] Starting subtest: basic-normal
[309.644216] Subtest basic-normal: SUCCESS (6.403s)
[309.738839] [089/140] (695s left) i915_suspend (fence-restore-untiled)
[309.969715] Starting subtest: fence-restore-untiled
[328.793104] Subtest fence-restore-untiled: SUCCESS (4.468s)
[333.951671] [090/140] (690s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[334.190179] Starting subtest: etime-multi-wait-available-unsubmitted
[334.259184] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[334.374199] [091/140] (690s left) v3d/v3d_wait_bo (unused-bo-0ns)
[334.643092] Subtest unused-bo-0ns: SKIP (0.000s)
[334.741712] [092/140] (690s left) kms_rotation_crc (sprite-rotation-180)
[335.042453] Starting subtest: sprite-rotation-180
[339.425761] Subtest sprite-rotation-180: SUCCESS (4.396s)
[339.882195] [093/140] (685s left) perf (oa-exponents)
[340.244943] Starting subtest: oa-exponents
[340.265994] Starting dynamic subtest: 0-rcs0
[344.350373] Dynamic subtest 0-rcs0: SUCCESS (4.102s)
[344.369177] Subtest oa-exponents: SUCCESS (4.104s)
[344.480708] [094/140] (680s left) kms_ccs (pipe-a-random-ccs-data-4-tiled-mtl-mc-ccs)
[344.889421] Starting subtest: pipe-A-random-ccs-data-4-tiled-mtl-mc-ccs
[344.946656] Subtest pipe-A-random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[345.368213] [095/140] (679s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[345.780828] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[345.824672] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[345.940329] [096/140] (679s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[346.420700] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[346.462728] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[346.831722] [097/140] (678s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[347.057681] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[347.140283] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.109s)
[347.266548] [098/140] (678s left) kms_vblank (ts-continuation-suspend)
[347.567535] Starting subtest: ts-continuation-suspend
[347.586267] Starting dynamic subtest: pipe-A-DP-1
[365.274189] Dynamic subtest pipe-A-DP-1: SUCCESS (1.844s)
[365.319153] Starting dynamic subtest: pipe-C-DP-1
[383.265819] Dynamic subtest pipe-C-DP-1: SUCCESS (1.976s)
[383.286177] Subtest ts-continuation-suspend: SUCCESS (3.833s)
[387.857648] [099/140] (673s left) api_intel_bb (object-noreloc-keep-cache-simple)
[388.082183] Starting subtest: object-noreloc-keep-cache-simple
[388.101114] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.008s)
[388.223552] [100/140] (673s left) kms_flip (2x-nonexisting-fb)
[388.537966] Starting subtest: 2x-nonexisting-fb
[388.575462] Subtest 2x-nonexisting-fb: SKIP (0.003s)
[388.669802] [101/140] (673s left) kms_ccs (pipe-b-ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[389.125828] Starting subtest: pipe-B-ccs-on-another-bo-4-tiled-mtl-mc-ccs
[389.166929] Subtest pipe-B-ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[389.545162] [102/140] (672s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[389.886227] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[389.925568] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[390.018162] [103/140] (671s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[390.375548] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[390.413105] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[390.509018] [104/140] (671s left) kms_plane_alpha_blend (alpha-basic)
[390.813320] Starting subtest: alpha-basic
[391.126734] Starting dynamic subtest: pipe-A-DP-1
[396.632274] Dynamic subtest pipe-A-DP-1: FAIL (4.071s)
[396.681505] Starting dynamic subtest: pipe-C-DP-1
[402.818074] Dynamic subtest pipe-C-DP-1: FAIL (5.451s)
[402.839597] Subtest alpha-basic: FAIL (9.932s)
[402.950323] [105/140] (659s left) prime_mmap (test_map_unmap)
[403.184297] Starting subtest: test_map_unmap
[403.203445] Starting dynamic subtest: test_map_unmap-smem
[403.222653] Dynamic subtest test_map_unmap-smem: SUCCESS (0.006s)
[403.241609] Subtest test_map_unmap: SUCCESS (0.009s)
[403.340699] [106/140] (658s left) kms_hdr (static-swap)
[403.641261] Starting subtest: static-swap
[403.678872] Subtest static-swap: SKIP (0.000s)
[403.775080] [107/140] (658s left) kms_cursor_crc (cursor-onscreen-512x512)
[404.100269] Starting subtest: cursor-onscreen-512x512
[404.139664] Subtest cursor-onscreen-512x512: SKIP (0.003s)
[404.231464] [108/140] (658s left) kms_flip (2x-flip-vs-suspend-interruptible)
[404.548182] Starting subtest: 2x-flip-vs-suspend-interruptible
[404.590457] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.003s)
[404.682507] [109/140] (657s left) kms_psr (pr_suspend)
[405.004052] Subtest pr_suspend: SKIP (0.000s)
[405.103544] [110/140] (657s left) perf_pmu (semaphore-wait-idle)
[405.337578] Starting subtest: semaphore-wait-idle
[405.358611] Starting dynamic subtest: rcs0
[405.826346] Dynamic subtest rcs0: SUCCESS (0.516s)
[405.866710] Starting dynamic subtest: bcs0
[406.343430] Dynamic subtest bcs0: SUCCESS (0.514s)
[406.387402] Starting dynamic subtest: vcs0
[406.863013] Dynamic subtest vcs0: SUCCESS (0.513s)
[406.905108] Starting dynamic subtest: vecs0
[407.378693] Dynamic subtest vecs0: SUCCESS (0.513s)
[407.397523] Subtest semaphore-wait-idle: SUCCESS (2.072s)
[407.538328] [111/140] (655s left) perf (gen8-unprivileged-single-ctx-counters)
[407.830579] Starting subtest: gen8-unprivileged-single-ctx-counters
[408.041157] Subtest gen8-unprivileged-single-ctx-counters: SUCCESS (0.221s)
[408.161804] [112/140] (654s left) i915_pm_rpm (gem-mmap-type)
[410.144125] Starting subtest: gem-mmap-type
[410.166069] Starting dynamic subtest: gtt-smem0
[412.685818] Dynamic subtest gtt-smem0: SUCCESS (2.528s)
[412.730222] Starting dynamic subtest: wb-smem0
[413.968086] Dynamic subtest wb-smem0: SUCCESS (1.277s)
[414.015005] Starting dynamic subtest: wc-smem0
[415.274632] Dynamic subtest wc-smem0: SUCCESS (1.306s)
[415.316615] Starting dynamic subtest: uc-smem0
[416.542262] Dynamic subtest uc-smem0: SUCCESS (1.277s)
[416.562176] Subtest gem-mmap-type: SUCCESS (6.400s)
[416.753514] [113/140] (646s left) vgem_basic (dmabuf-fence-before)
[416.988798] Starting subtest: dmabuf-fence-before
[417.007765] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[417.104490] [114/140] (645s left) kms_psr (pr_cursor_render)
[417.405468] Subtest pr_cursor_render: SKIP (0.000s)
[417.499995] [115/140] (645s left) kms_flip (nonblocking-read)
[417.790038] Starting subtest: nonblocking-read
[417.808758] Subtest nonblocking-read: SUCCESS (0.000s)
[417.931428] [116/140] (645s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[418.286403] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[418.329187] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[418.427805] [117/140] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render)
[418.787428] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render
[418.832690] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[418.929613] [118/140] (644s left) gem_exec_store (pages)
[419.223109] Starting subtest: pages
[419.242144] Starting dynamic subtest: rcs0
[419.263930] Dynamic subtest rcs0: SUCCESS (0.097s)
[419.317257] Starting dynamic subtest: bcs0
[419.360604] Dynamic subtest bcs0: SUCCESS (0.099s)
[419.405370] Starting dynamic subtest: vcs0
[419.467166] Dynamic subtest vcs0: SUCCESS (0.104s)
[419.511540] Starting dynamic subtest: vecs0
[419.555776] Dynamic subtest vecs0: SUCCESS (0.088s)
[419.576458] Subtest pages: SUCCESS (0.399s)
[419.787606] [119/140] (643s left) kms_prime (d3hot)
[422.043202] Subtest D3hot: SKIP (0.000s)
[422.159664] [120/140] (641s left) gem_exec_parallel (basic)
[422.391839] Starting subtest: basic
[422.413630] Starting dynamic subtest: rcs0
[425.799846] Dynamic subtest rcs0: SUCCESS (3.219s)
[425.841189] Starting dynamic subtest: bcs0
[429.130050] Dynamic subtest bcs0: SUCCESS (3.329s)
[429.173187] Starting dynamic subtest: vcs0
[432.252610] Dynamic subtest vcs0: SUCCESS (3.127s)
[432.296093] Starting dynamic subtest: vecs0
[435.392203] Dynamic subtest vecs0: SUCCESS (3.137s)
[435.411146] Subtest basic: SUCCESS (12.823s)
[435.502864] [121/140] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[435.882292] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[435.920253] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[436.017754] [122/140] (627s left) kms_plane_multiple (tiling-y)
[436.323672] Starting subtest: tiling-y
[436.349693] Starting dynamic subtest: pipe-A-DP-1
[438.233388] Dynamic subtest pipe-A-DP-1: SUCCESS (1.892s)
[438.274358] Starting dynamic subtest: pipe-B-DP-1
[440.328719] Dynamic subtest pipe-B-DP-1: SUCCESS (2.108s)
[440.379371] Starting dynamic subtest: pipe-C-DP-1
[442.403971] Dynamic subtest pipe-C-DP-1: SUCCESS (2.054s)
[442.424021] Subtest tiling-y: SUCCESS (6.067s)
[442.793353] [123/140] (621s left) gem_ctx_shared (q-smoketest-all)
[443.061140] Starting subtest: Q-smoketest-all
[475.426581] Subtest Q-smoketest-all: SUCCESS (32.308s)
[475.593689] [124/140] (588s left) gem_close_race (basic-threads)
[475.810511] Starting subtest: basic-threads
[477.017145] Subtest basic-threads: SUCCESS (1.208s)
[477.246438] [125/140] (586s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[477.618094] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[479.426386] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (1.887s)
[479.599149] [126/140] (584s left) gem_exec_balancer (smoke)
[479.831354] Starting subtest: smoke
[483.500774] Subtest smoke: SUCCESS (3.505s)
[487.231672] [127/140] (576s left) v3d/v3d_submit_cl (simple-flush-cache)
[487.505370] Subtest simple-flush-cache: SKIP (0.000s)
[487.602657] [128/140] (576s left) vc4/vc4_label_bo (set-kernel-name)
[487.879817] Subtest set-kernel-name: SKIP (0.000s)
[487.977790] [129/140] (576s left) gem_exec_params (invalid-bsd-ring)
[488.205982] Starting subtest: invalid-bsd-ring
[488.227545] Subtest invalid-bsd-ring: SUCCESS (0.002s)
[488.329866] [130/140] (576s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[488.682566] Starting subtest: fbcpsr-suspend
[488.725287] Subtest fbcpsr-suspend: SKIP (0.000s)
[488.822880] [131/140] (575s left) gem_ctx_persistence (engines-cleanup)
[489.056470] Starting subtest: engines-cleanup
[489.076641] Starting dynamic subtest: rcs0
[489.096591] Dynamic subtest rcs0: SUCCESS (0.034s)
[489.139280] Starting dynamic subtest: bcs0
[489.158135] Dynamic subtest bcs0: SUCCESS (0.039s)
[489.200842] Starting dynamic subtest: vcs0
[489.222408] Dynamic subtest vcs0: SUCCESS (0.031s)
[489.265125] Starting dynamic subtest: vecs0
[489.286062] Dynamic subtest vecs0: SUCCESS (0.041s)
[489.306086] Subtest engines-cleanup: SUCCESS (0.156s)
[489.398734] [132/140] (575s left) perf_pmu (init-sema)
[489.631425] Starting subtest: init-sema
[489.650561] Starting dynamic subtest: rcs0
[489.669637] Dynamic subtest rcs0: SUCCESS (0.001s)
[489.711315] Starting dynamic subtest: bcs0
[489.732864] Dynamic subtest bcs0: SUCCESS (0.001s)
[489.775637] Starting dynamic subtest: vcs0
[489.796424] Dynamic subtest vcs0: SUCCESS (0.001s)
[489.838474] Starting dynamic subtest: vecs0
[489.857514] Dynamic subtest vecs0: SUCCESS (0.001s)
[489.876222] Subtest init-sema: SUCCESS (0.016s)
[489.993622] [133/140] (574s left) kms_content_protection (srm)
[490.342956] Starting subtest: srm
[490.364648] Starting dynamic subtest: pipe-A-DP-1
[610.553741] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[618.583701] Closing watchdogs
[618.588870] Initializing watchdogs
[618.589175]   /dev/watchdog0
[618.631702] [134/140] (446s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[618.874152] Starting subtest: yf-tiled-to-vebox-x-tiled
[618.911638] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[619.095568] [135/140] (445s left) gem_exec_balancer (parallel-bb-first)
[623.118699] Subtest parallel-bb-first: SKIP (0.000s)
[623.213597] [136/140] (441s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[623.515754] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[623.557467] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.004s)
[623.651682] [137/140] (441s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[623.987063] Starting subtest: yf-tiled-8bpp-rotate-0
[624.028813] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[624.122561] [138/140] (441s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[624.416097] Starting subtest: 2x-cursor-vs-flip-legacy
[624.459399] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.004s)
[624.557981] [139/140] (440s left) kms_vrr (negative-basic)
[624.858274] Starting subtest: negative-basic
[624.896140] Subtest negative-basic: SKIP (0.000s)
[624.997465] [140/140] (440s left) drm_fdinfo (virtual-busy-idle)
[625.229184] Starting subtest: virtual-busy-idle
[627.783394] Subtest virtual-busy-idle: SUCCESS (2.575s)
[627.879057] Closing watchdogs
Done.