[59.615966] Initializing watchdogs
[59.616114]   /dev/watchdog0
[59.636270] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[59.645726] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[59.649759] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.652256] [001/130] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[59.941592] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[59.943322] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[60.069336] [002/130] (960s left) syncobj_wait (invalid-signal-illegal-handle)
[60.143729] Starting subtest: invalid-signal-illegal-handle
[60.144629] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[60.302658] [003/130] (959s left) i915_hangman (gt-error-state-capture)
[60.399516] Starting subtest: gt-error-state-capture
[60.400416] Starting dynamic subtest: rcs0
[70.163294] Dynamic subtest rcs0: SUCCESS (9.770s)
[70.173844] Starting dynamic subtest: bcs0
[80.066644] Dynamic subtest bcs0: SUCCESS (9.905s)
[80.074591] Starting dynamic subtest: vcs0
[89.141756] Dynamic subtest vcs0: SUCCESS (9.076s)
[89.155952] Starting dynamic subtest: vcs1
[99.083514] Dynamic subtest vcs1: SUCCESS (9.943s)
[99.091577] Starting dynamic subtest: vecs0
[109.171524] Dynamic subtest vecs0: SUCCESS (10.088s)
[109.182162] Starting dynamic subtest: vecs1
[119.117343] Dynamic subtest vecs1: SUCCESS (9.946s)
[119.125207] Starting dynamic subtest: ccs0
[129.136398] Dynamic subtest ccs0: SUCCESS (10.019s)
[129.137541] Subtest gt-error-state-capture: SUCCESS (68.749s)
[129.302796] [004/130] (891s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[129.503351] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[133.567356] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.065s)
[133.731630] [005/130] (886s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[133.931180] Starting subtest: plane-downscale-factor-0-5-with-rotation
[133.932028] Starting dynamic subtest: pipe-A
[134.316073] Dynamic subtest pipe-A: SUCCESS (0.385s)
[134.331130] Starting dynamic subtest: pipe-B
[134.805780] Dynamic subtest pipe-B: SUCCESS (0.489s)
[134.825597] Starting dynamic subtest: pipe-C
[135.292184] Dynamic subtest pipe-C: SUCCESS (0.485s)
[135.311157] Starting dynamic subtest: pipe-D
[135.779728] Dynamic subtest pipe-D: SUCCESS (0.488s)
[135.780951] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.848s)
[136.108623] [006/130] (884s left) gem_close_race (multigpu-basic-threads)
[136.214291] Starting subtest: multigpu-basic-threads
[136.216598] Subtest multigpu-basic-threads: SKIP (0.000s)
[136.494609] [007/130] (884s left) gem_ctx_param (non-root-set)
[136.566303] Starting subtest: non-root-set
[136.589256] Subtest non-root-set: SUCCESS (0.023s)
[136.750175] [008/130] (883s left) sw_sync (sync_multi_consumer)
[136.795533] Starting subtest: sync_multi_consumer
[137.126851] Subtest sync_multi_consumer: SUCCESS (0.332s)
[137.191448] [009/130] (883s left) kms_atomic_transition (plane-all-transition-fencing)
[137.390402] Starting subtest: plane-all-transition-fencing
[137.391308] Starting dynamic subtest: pipe-A-DP-3
[141.117293] Dynamic subtest pipe-A-DP-3: SUCCESS (3.725s)
[141.202828] Starting dynamic subtest: pipe-B-DP-3
[144.968220] Dynamic subtest pipe-B-DP-3: SUCCESS (3.775s)
[145.020732] Subtest plane-all-transition-fencing: SUCCESS (7.629s)
[145.301499] [010/130] (875s left) i915_pm_rpm (gem-pread)
[147.057149] Starting subtest: gem-pread
[147.909682] Subtest gem-pread: SUCCESS (0.855s)
[148.135387] [011/130] (872s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[148.348174] Starting subtest: y-tiled-32bpp-rotate-270
[148.350137] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[148.461907] [012/130] (872s left) kms_prop_blob (blob-multiple)
[148.534065] Starting subtest: blob-multiple
[148.555922] Subtest blob-multiple: SUCCESS (0.022s)
[148.704126] [013/130] (872s left) gem_exec_reloc (basic-gtt)
[148.786408] Subtest basic-gtt: SKIP (0.000s)
[148.892751] [014/130] (872s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[149.098516] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[149.100292] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[149.211919] [015/130] (871s left) gem_vm_create (invalid-create)
[149.288906] Starting subtest: invalid-create
[149.292578] Subtest invalid-create: SUCCESS (0.004s)
[149.468663] [016/130] (871s left) gem_mmap_wc (write-read-distinct)
[149.540201] Subtest write-read-distinct: SKIP (0.000s)
[149.609126] [017/130] (871s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[149.814558] Starting subtest: psr-rgb101010-draw-pwrite
[149.816260] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[149.928043] [018/130] (871s left) kms_async_flips (invalid-async-flip)
[150.124300] Starting subtest: invalid-async-flip
[150.126038] Subtest invalid-async-flip: SKIP (0.000s)
[150.576740] [019/130] (870s left) kms_psr2_su (page_flip-p010)
[150.646408] Subtest page_flip-P010: SKIP (0.000s)
[150.729385] [020/130] (870s left) drm_fdinfo (all-busy-idle-check-all)
[150.791489] Starting subtest: all-busy-idle-check-all
[150.816200] Subtest all-busy-idle-check-all: SKIP (0.024s)
[150.918292] [021/130] (870s left) gem_exec_whisper (basic-forked)
[151.038420] Starting subtest: basic-forked
[158.214379] Subtest basic-forked: SUCCESS (7.174s)
[158.474975] [022/130] (862s left) kms_psr (psr2-dpms)
[158.675525] Subtest psr2-dpms: SKIP (0.000s)
[158.736917] [023/130] (862s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[159.009585] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[159.158190] [024/130] (862s left) gem_mmap_wc (bad-size)
[159.232089] Subtest bad-size: SKIP (0.000s)
[159.310591] [025/130] (862s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[159.510576] Starting subtest: flip-vs-cursor-legacy
[168.910302] Subtest flip-vs-cursor-legacy: SUCCESS (9.399s)
[169.130674] [026/130] (852s left) gem_userptr_blits (sync-overlap)
[169.218971] Starting subtest: sync-overlap
[169.219941] Subtest sync-overlap: SUCCESS (0.000s)
[169.400766] [027/130] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[169.608584] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[169.610332] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[169.746568] [028/130] (852s left) kms_frontbuffer_tracking (psr-1p-rte)
[169.950685] Starting subtest: psr-1p-rte
[169.952411] Subtest psr-1p-rte: SKIP (0.000s)
[170.065090] [029/130] (851s left) gem_media_fill (media-fill)
[170.141158] Subtest media-fill: SKIP (0.000s)
[170.262632] [030/130] (851s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[170.461546] Starting subtest: cursor-vs-flip-atomic-transitions
[201.128497] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.666s)
[201.390743] [031/130] (820s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[201.759491] Starting subtest: cursor-rapid-movement-256x256
[201.763329] Starting dynamic subtest: pipe-A-DP-3
[202.222349] Dynamic subtest pipe-A-DP-3: SUCCESS (0.459s)
[202.269172] Starting dynamic subtest: pipe-D-DP-3
[202.640527] Dynamic subtest pipe-D-DP-3: SUCCESS (0.379s)
[202.641596] Subtest cursor-rapid-movement-256x256: SUCCESS (0.880s)
[203.034793] [032/130] (819s left) kms_flip (flip-vs-fences-interruptible)
[203.246153] Starting subtest: flip-vs-fences-interruptible
[203.248104] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[203.352274] [033/130] (818s left) kms_cursor_crc (cursor-dpms)
[203.591129] Starting subtest: cursor-dpms
[203.593173] Starting dynamic subtest: pipe-A-DP-3
[204.774903] Dynamic subtest pipe-A-DP-3: SUCCESS (1.181s)
[204.793742] Starting dynamic subtest: pipe-D-DP-3
[205.959047] Dynamic subtest pipe-D-DP-3: SUCCESS (1.182s)
[205.960473] Subtest cursor-dpms: SUCCESS (2.367s)
[206.490417] [034/130] (815s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[206.693784] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[206.695481] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[206.826292] [035/130] (815s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[207.022057] Starting subtest: flip-vs-dpms-off-vs-modeset
[207.025941] Starting dynamic subtest: A-DP3
[208.029751] Dynamic subtest A-DP3: SUCCESS (1.001s)
[208.047598] Starting dynamic subtest: B-DP3
[208.835401] Dynamic subtest B-DP3: SUCCESS (0.804s)
[208.853736] Starting dynamic subtest: C-DP3
[209.645966] Dynamic subtest C-DP3: SUCCESS (0.809s)
[209.666731] Starting dynamic subtest: D-DP3
[210.453876] Dynamic subtest D-DP3: SUCCESS (0.807s)
[210.457689] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.436s)
[210.775203] [036/130] (811s left) gem_exec_schedule (pi-shared-iova)
[210.986778] Starting subtest: pi-shared-iova
[210.987727] Starting dynamic subtest: rcs0
[211.233362] Dynamic subtest rcs0: SUCCESS (0.255s)
[211.246678] Starting dynamic subtest: bcs0
[211.401805] Dynamic subtest bcs0: SUCCESS (0.168s)
[211.410390] Starting dynamic subtest: vcs0
[211.576528] Dynamic subtest vcs0: SUCCESS (0.174s)
[211.585197] Starting dynamic subtest: vcs1
[211.748882] Dynamic subtest vcs1: SUCCESS (0.172s)
[211.757461] Starting dynamic subtest: vecs0
[211.922212] Dynamic subtest vecs0: SUCCESS (0.173s)
[211.930848] Starting dynamic subtest: vecs1
[212.103260] Dynamic subtest vecs1: SUCCESS (0.181s)
[212.111805] Starting dynamic subtest: ccs0
[212.279671] Dynamic subtest ccs0: SUCCESS (0.176s)
[212.280836] Subtest pi-shared-iova: SUCCESS (1.301s)
[212.674693] [037/130] (809s left) syncobj_basic (create-signaled)
[212.741181] Starting subtest: create-signaled
[212.742172] Subtest create-signaled: SUCCESS (0.000s)
[212.887342] [038/130] (809s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[212.962250] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[213.016366] [039/130] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[213.222710] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[213.224443] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[213.342755] [040/130] (809s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[213.423425] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[213.425607] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[213.656744] [041/130] (808s left) kms_vblank (wait-forked-hang)
[213.857269] Starting subtest: wait-forked-hang
[213.859354] Starting dynamic subtest: pipe-A-DP-3
[240.623439] Dynamic subtest pipe-A-DP-3: SUCCESS (26.764s)
[240.633874] Starting dynamic subtest: pipe-D-DP-3
[265.634448] Dynamic subtest pipe-D-DP-3: SUCCESS (25.009s)
[265.635329] Subtest wait-forked-hang: SUCCESS (51.778s)
[265.890446] [042/130] (756s left) prime_busy (after-wait)
[265.965162] Starting subtest: after-wait
[265.971213] Starting dynamic subtest: rcs0
[266.008299] Dynamic subtest rcs0: SUCCESS (0.037s)
[266.017141] Starting dynamic subtest: bcs0
[266.082313] Dynamic subtest bcs0: SUCCESS (0.073s)
[266.117174] Starting dynamic subtest: vcs0
[266.124965] Dynamic subtest vcs0: SUCCESS (0.041s)
[266.145664] Starting dynamic subtest: vcs1
[266.166414] Dynamic subtest vcs1: SUCCESS (0.040s)
[266.187163] Starting dynamic subtest: vecs0
[266.206086] Dynamic subtest vecs0: SUCCESS (0.039s)
[266.222927] Starting dynamic subtest: vecs1
[266.246070] Dynamic subtest vecs1: SUCCESS (0.039s)
[266.262853] Starting dynamic subtest: ccs0
[266.287632] Dynamic subtest ccs0: SUCCESS (0.041s)
[266.397362] Subtest after-wait: SUCCESS (0.431s)
[266.570237] [043/130] (756s left) gem_ctx_sseu (mmap-args)
[266.650989] Subtest mmap-args: SKIP (0.000s)
[266.729384] [044/130] (756s left) gem_exec_fence (syncobj-repeat)
[267.286242] Starting subtest: syncobj-repeat
[267.578319] Subtest syncobj-repeat: SUCCESS (0.291s)
[268.022375] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[268.024540] [045/130] (754s left) gem_eio (in-flight-contexts-1us)
[268.295882] Starting subtest: in-flight-contexts-1us
[281.991464] Subtest in-flight-contexts-1us: SUCCESS (13.695s)
[282.235223] [046/130] (740s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[282.447774] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[282.449825] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[282.612983] [047/130] (740s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[285.212684] Starting subtest: verify-pxp-stale-buf-optout-execution
[285.214518] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[285.318552] [048/130] (737s left) gem_ctx_persistence (legacy-engines-hang)
[285.406328] Starting subtest: legacy-engines-hang
[285.407299] Starting dynamic subtest: render
[285.503444] Dynamic subtest render: SUCCESS (0.097s)
[285.519889] Starting dynamic subtest: bsd1
[285.594367] Dynamic subtest bsd1: SUCCESS (0.090s)
[285.609426] Starting dynamic subtest: bsd2
[285.689279] Dynamic subtest bsd2: SUCCESS (0.093s)
[285.727882] Starting dynamic subtest: blt
[285.757627] Dynamic subtest blt: SUCCESS (0.066s)
[285.780011] Starting dynamic subtest: vebox
[285.803717] Dynamic subtest vebox: SUCCESS (0.044s)
[285.805113] Subtest legacy-engines-hang: SUCCESS (0.398s)
[285.991455] [049/130] (737s left) kms_psr (fbc-psr-cursor-plane-move)
[286.199448] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[286.264735] [050/130] (736s left) gem_ctx_persistence (hang)
[286.349686] Starting subtest: hang
[286.351928] Subtest hang: SKIP (0.000s)
[286.513276] [051/130] (736s left) gen9_exec_parse (cmd-crossing-page)
[286.595773] Subtest cmd-crossing-page: SKIP (0.000s)
[286.648394] [052/130] (736s left) kms_busy (basic)
[286.862361] Starting subtest: basic
[286.864330] Starting dynamic subtest: flip
[287.458202] Dynamic subtest flip: SUCCESS (0.593s)
[287.478376] Starting dynamic subtest: modeset
[288.432037] Dynamic subtest modeset: SUCCESS (0.972s)
[288.433313] Subtest basic: SUCCESS (1.568s)
[288.715415] [053/130] (734s left) i915_selftest (mock)
[290.097479] Starting subtest: mock
[290.098392] Starting dynamic subtest: sanitycheck
[290.888026] Dynamic subtest sanitycheck: SUCCESS (0.789s)
[290.897519] Starting dynamic subtest: shmem
[291.686122] Dynamic subtest shmem: SUCCESS (0.795s)
[291.714050] Starting dynamic subtest: fence
[300.095297] Dynamic subtest fence: SUCCESS (8.407s)
[300.106735] Starting dynamic subtest: scatterlist
[301.886963] Dynamic subtest scatterlist: SUCCESS (1.789s)
[301.897941] Starting dynamic subtest: syncmap
[304.787241] Dynamic subtest syncmap: SUCCESS (2.898s)
[304.798441] Starting dynamic subtest: uncore
[305.564652] Dynamic subtest uncore: SUCCESS (0.775s)
[305.575870] Starting dynamic subtest: ring
[306.371528] Dynamic subtest ring: SUCCESS (0.805s)
[306.379799] Starting dynamic subtest: engine
[307.182531] Dynamic subtest engine: SUCCESS (0.809s)
[307.193967] Starting dynamic subtest: timelines
[311.271113] Dynamic subtest timelines: SUCCESS (4.087s)
[311.280596] Starting dynamic subtest: requests
[314.015961] Dynamic subtest requests: SUCCESS (2.744s)
[314.024068] Starting dynamic subtest: objects
[314.933365] Dynamic subtest objects: SUCCESS (0.916s)
[314.943192] Starting dynamic subtest: phys
[315.838301] Dynamic subtest phys: SUCCESS (0.904s)
[315.847310] Starting dynamic subtest: dmabuf
[316.746655] Dynamic subtest dmabuf: SUCCESS (0.907s)
[316.757218] Starting dynamic subtest: vma
[323.762473] Dynamic subtest vma: SUCCESS (7.014s)
[323.772568] Starting dynamic subtest: evict
[325.404303] Dynamic subtest evict: SUCCESS (1.641s)
[325.418473] Starting dynamic subtest: gtt
[329.047124] Dynamic subtest gtt: SUCCESS (3.642s)
[329.058711] Starting dynamic subtest: hugepages
[330.145599] Dynamic subtest hugepages: SUCCESS (1.097s)
[330.156606] Starting dynamic subtest: memory_region
[334.171012] Dynamic subtest memory_region: SUCCESS (4.024s)
[334.171952] Subtest mock: SUCCESS (44.073s)
[334.211334] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[334.212981] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[334.215352] [054/130] (689s left) gem_userptr_blits (sd-probe)
[335.739382] Starting subtest: sd-probe
[335.741329] Subtest sd-probe: SKIP (0.000s)
[335.858906] [FACT gem_userptr_blits (sd-probe)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[335.864377] [FACT gem_userptr_blits (sd-probe)] new: kernel.kmod_is_loaded.i915: true
[335.867480] [055/130] (687s left) kms_pm_rpm (drm-resources-equal)
[338.035765] Starting subtest: drm-resources-equal
[339.537380] Subtest drm-resources-equal: SUCCESS (1.502s)
[339.689462] [056/130] (683s left) kms_addfb_basic (bad-pitch-0)
[339.771202] Starting subtest: bad-pitch-0
[339.772134] Subtest bad-pitch-0: SUCCESS (0.000s)
[340.040936] [057/130] (683s left) gem_exec_params (invalid-ring2)
[340.132039] Starting subtest: invalid-ring2
[340.132989] Subtest invalid-ring2: SUCCESS (0.000s)
[340.304997] [058/130] (683s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[340.383705] Starting subtest: multi-wait-for-submit-submitted-signaled
[340.384628] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[340.543614] [059/130] (683s left) prime_mmap (test_correct_cpu_write)
[340.623300] Starting subtest: test_correct_cpu_write
[340.624233] Starting dynamic subtest: test_correct_cpu_write-smem
[340.625307] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[340.634118] Starting dynamic subtest: test_correct_cpu_write-lmem0
[340.635263] Dynamic subtest test_correct_cpu_write-lmem0: SUCCESS (0.000s)
[340.636571] Subtest test_correct_cpu_write: SUCCESS (0.002s)
[340.746704] [060/130] (683s left) kms_psr (pr-cursor-plane-onoff)
[340.954379] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[341.005614] [061/130] (682s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[341.222557] Starting subtest: modeset-transition-nonblocking-fencing
[341.223466] Starting dynamic subtest: 1x-outputs
[343.840909] Dynamic subtest 1x-outputs: SUCCESS (2.617s)
[343.896657] Subtest modeset-transition-nonblocking-fencing: SUCCESS (2.673s)
[344.173955] [062/130] (679s left) gem_ctx_exec (basic)
[344.253769] Starting subtest: basic
[344.259798] Subtest basic: SUCCESS (0.006s)
[344.398809] [063/130] (679s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[344.608449] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[344.610551] Starting dynamic subtest: pipe-A-DP-3
[348.303494] Dynamic subtest pipe-A-DP-3: SUCCESS (3.677s)
[348.317181] Starting dynamic subtest: pipe-B-DP-3
[348.877138] Dynamic subtest pipe-B-DP-3: SUCCESS (0.568s)
[348.899537] Starting dynamic subtest: pipe-C-DP-3
[349.463533] Dynamic subtest pipe-C-DP-3: SUCCESS (0.581s)
[349.486543] Starting dynamic subtest: pipe-D-DP-3
[350.050625] Dynamic subtest pipe-D-DP-3: SUCCESS (0.580s)
[350.052467] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (5.425s)
[350.379951] [064/130] (673s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[350.600486] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[351.864747] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.263s)
[352.050847] [065/130] (672s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[352.266506] Starting subtest: x-tiled-32bpp-rotate-90
[352.331602] Subtest x-tiled-32bpp-rotate-90: SKIP (0.064s)
[352.517742] [066/130] (671s left) gem_pxp (regular-baseline-src-copy-readible)
[355.131908] Starting subtest: regular-baseline-src-copy-readible
[355.134536] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[355.235804] [067/130] (669s left) kms_joiner (invalid-modeset-force-big-joiner)
[355.445084] Starting subtest: invalid-modeset-force-big-joiner
[355.445877] Starting dynamic subtest: big_joiner_on_last_pipe
[355.657298] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.214s)
[355.658182] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.214s)
[355.937691] [068/130] (668s left) kms_dsc (dsc-basic)
[356.145191] Starting subtest: dsc-basic
[356.150430] Subtest dsc-basic: SKIP (0.000s)
[356.245678] [069/130] (668s left) gem_mmap_gtt (basic-small-bo-tiledy)
[356.324636] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[356.386168] [070/130] (668s left) kms_chamelium_frames (dp-frame-dump)
[356.677394] Subtest dp-frame-dump: SKIP (0.000s)
[356.827838] [071/130] (667s left) kms_sequence (get-forked)
[357.034419] Starting subtest: get-forked
[357.035394] Starting dynamic subtest: pipe-A-DP-3
[359.468595] Dynamic subtest pipe-A-DP-3: SUCCESS (2.433s)
[359.483525] Starting dynamic subtest: pipe-B-DP-3
[361.865728] Dynamic subtest pipe-B-DP-3: SUCCESS (2.395s)
[361.874748] Starting dynamic subtest: pipe-C-DP-3
[364.243131] Dynamic subtest pipe-C-DP-3: SUCCESS (2.377s)
[364.255119] Starting dynamic subtest: pipe-D-DP-3
[366.613986] Dynamic subtest pipe-D-DP-3: SUCCESS (2.369s)
[366.614920] Subtest get-forked: SUCCESS (9.580s)
[366.898703] [072/130] (657s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[367.109445] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[367.111564] Starting dynamic subtest: pipe-A-DP-3
[367.120161] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[367.128794] Starting dynamic subtest: pipe-B-DP-3
[367.137349] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[367.145806] Starting dynamic subtest: pipe-C-DP-3
[367.154147] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[367.162629] Starting dynamic subtest: pipe-D-DP-3
[367.173189] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[367.174983] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.008s)
[367.585964] [073/130] (657s left) kms_psr (psr-cursor-plane-move)
[367.801319] Subtest psr-cursor-plane-move: SKIP (0.000s)
[367.864050] [074/130] (656s left) kms_chamelium_frames (vga-frame-dump)
[368.150832] Subtest vga-frame-dump: SKIP (0.000s)
[368.309341] [075/130] (656s left) fbdev (pan)
[368.360994] Starting subtest: pan
[368.404669] Subtest pan: SUCCESS (0.045s)
[368.533617] [076/130] (656s left) syncobj_wait (reset-multiple-signaled)
[368.611010] Starting subtest: reset-multiple-signaled
[368.611930] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[368.739163] [077/130] (656s left) api_intel_bb (simple-bb-ctx)
[368.816302] Starting subtest: simple-bb-ctx
[368.846164] Subtest simple-bb-ctx: SUCCESS (0.030s)
[369.001995] [078/130] (656s left) kms_universal_plane (universal-plane-functional)
[369.209497] Starting subtest: universal-plane-functional
[369.211749] Starting dynamic subtest: pipe-A-DP-3
[371.594212] Dynamic subtest pipe-A-DP-3: SUCCESS (2.383s)
[371.605774] Starting dynamic subtest: pipe-B-DP-3
[373.822030] Dynamic subtest pipe-B-DP-3: SUCCESS (2.226s)
[373.835315] Starting dynamic subtest: pipe-C-DP-3
[376.012936] Dynamic subtest pipe-C-DP-3: SUCCESS (2.188s)
[376.022999] Starting dynamic subtest: pipe-D-DP-3
[378.173948] Dynamic subtest pipe-D-DP-3: SUCCESS (2.160s)
[378.174889] Subtest universal-plane-functional: SUCCESS (8.965s)
[378.433538] [079/130] (646s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[378.640995] Starting subtest: cursor-vs-flip-atomic
[408.896070] Subtest cursor-vs-flip-atomic: SUCCESS (30.255s)
[409.151530] [080/130] (616s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[409.360578] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[409.362900] Starting dynamic subtest: pipe-A-valid-mode
[409.440316] Dynamic subtest pipe-A-valid-mode: SKIP (0.076s)
[409.442358] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.078s)
[409.657966] [081/130] (615s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[409.874304] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[409.876033] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[409.998724] [082/130] (615s left) gem_exec_fence (concurrent)
[410.205666] Starting subtest: concurrent
[410.207901] Subtest concurrent: SKIP (0.000s)
[410.911920] [083/130] (614s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[411.126606] Starting subtest: yf-tiled-64bpp-rotate-270
[411.128391] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[411.243391] [084/130] (614s left) gem_mmap_wc (invalid-flags)
[411.324316] Subtest invalid-flags: SKIP (0.000s)
[411.389952] [085/130] (614s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[411.626030] Starting subtest: fbc-rgb565-draw-pwrite
[414.351727] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.725s)
[414.555893] [086/130] (611s left) kms_flip (flip-vs-expired-vblank-interruptible)
[414.770522] Starting subtest: flip-vs-expired-vblank-interruptible
[414.775280] Starting dynamic subtest: A-DP3
[422.599069] Dynamic subtest A-DP3: SUCCESS (7.823s)
[422.616454] Starting dynamic subtest: B-DP3
[430.349061] Dynamic subtest B-DP3: SUCCESS (7.746s)
[430.360048] Starting dynamic subtest: C-DP3
[438.080245] Dynamic subtest C-DP3: SUCCESS (7.729s)
[438.116215] Starting dynamic subtest: D-DP3
[445.845913] Dynamic subtest D-DP3: SUCCESS (7.761s)
[445.848196] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (31.077s)
[446.181090] [087/130] (579s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[446.258996] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[446.368367] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[446.470128] [088/130] (579s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[446.678856] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[446.680650] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[446.813790] [089/130] (578s left) kms_plane_cursor (primary)
[447.019507] Starting subtest: primary
[447.021293] Starting dynamic subtest: pipe-A-DP-3-size-64
[450.331379] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.310s)
[450.417062] Starting dynamic subtest: pipe-A-DP-3-size-128
[453.948677] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.564s)
[454.011175] Starting dynamic subtest: pipe-A-DP-3-size-256
[457.415045] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.415s)
[457.571552] Starting dynamic subtest: pipe-B-DP-3-size-64
[461.032012] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.471s)
[461.074698] Starting dynamic subtest: pipe-B-DP-3-size-128
[464.549017] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.483s)
[464.592510] Starting dynamic subtest: pipe-B-DP-3-size-256
[467.981969] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.399s)
[468.088918] Starting dynamic subtest: pipe-C-DP-3-size-64
[471.600125] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.521s)
[471.665169] Starting dynamic subtest: pipe-C-DP-3-size-128
[475.099213] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.465s)
[475.147077] Starting dynamic subtest: pipe-C-DP-3-size-256
[478.682669] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.549s)
[478.840324] Starting dynamic subtest: pipe-D-DP-3-size-64
[482.352700] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.542s)
[482.400694] Starting dynamic subtest: pipe-D-DP-3-size-128
[485.752876] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.364s)
[485.800144] Starting dynamic subtest: pipe-D-DP-3-size-256
[489.136213] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.348s)
[489.230458] Subtest primary: SUCCESS (42.210s)
[489.501980] [090/130] (536s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[489.715028] Starting subtest: fbcpsr-tiling-4
[489.716731] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[489.825452] [091/130] (536s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[490.034513] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[490.035442] Starting dynamic subtest: pipe-A
[490.149554] Dynamic subtest pipe-A: SUCCESS (0.114s)
[490.176564] Starting dynamic subtest: pipe-B
[490.387804] Dynamic subtest pipe-B: SUCCESS (0.236s)
[490.404549] Starting dynamic subtest: pipe-C
[490.608409] Dynamic subtest pipe-C: SUCCESS (0.219s)
[490.625536] Starting dynamic subtest: pipe-D
[490.828381] Dynamic subtest pipe-D: SUCCESS (0.219s)
[490.829289] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.794s)
[491.144234] [092/130] (534s left) kms_flip (2x-flip-vs-suspend-interruptible)
[491.358422] Starting subtest: 2x-flip-vs-suspend-interruptible
[491.373482] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.014s)
[491.467325] [093/130] (534s left) gem_exec_balancer (full-late)
[491.562885] Starting subtest: full-late
[493.337168] Subtest full-late: SUCCESS (1.774s)
[493.699792] [094/130] (532s left) perf_pmu (enable-race)
[493.770485] Starting subtest: enable-race
[493.771436] Starting dynamic subtest: rcs0
[506.545583] Dynamic subtest rcs0: SUCCESS (12.775s)
[506.555656] Starting dynamic subtest: bcs0
[519.300778] Dynamic subtest bcs0: SUCCESS (12.754s)
[519.311276] Starting dynamic subtest: vcs0
[532.052699] Dynamic subtest vcs0: SUCCESS (12.750s)
[532.063175] Starting dynamic subtest: vcs1
[544.803887] Dynamic subtest vcs1: SUCCESS (12.748s)
[544.817927] Starting dynamic subtest: vecs0
[557.558631] Dynamic subtest vecs0: SUCCESS (12.750s)
[557.569016] Starting dynamic subtest: vecs1
[570.310665] Dynamic subtest vecs1: SUCCESS (12.750s)
[570.320862] Starting dynamic subtest: ccs0
[583.060406] Dynamic subtest ccs0: SUCCESS (12.748s)
[583.061317] Subtest enable-race: SUCCESS (89.286s)
[583.196387] [095/130] (442s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[583.406873] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[583.408590] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[583.509714] [096/130] (442s left) api_intel_bb (crc32)
[583.591437] Starting subtest: crc32
[583.592437] Starting dynamic subtest: rcs0-lmem0
[583.857942] Dynamic subtest rcs0-lmem0: SUCCESS (0.265s)
[583.873527] Starting dynamic subtest: rcs0-smem0
[584.194313] Dynamic subtest rcs0-smem0: SUCCESS (0.332s)
[584.207845] Starting dynamic subtest: bcs0-lmem0
[584.457348] Dynamic subtest bcs0-lmem0: SUCCESS (0.259s)
[584.472536] Starting dynamic subtest: bcs0-smem0
[584.830132] Dynamic subtest bcs0-smem0: SUCCESS (0.369s)
[584.843785] Starting dynamic subtest: vcs0-lmem0
[585.217058] Dynamic subtest vcs0-lmem0: SUCCESS (0.383s)
[585.232619] Starting dynamic subtest: vcs0-smem0
[585.711985] Dynamic subtest vcs0-smem0: SUCCESS (0.491s)
[585.730844] Starting dynamic subtest: vcs1-lmem0
[586.103533] Dynamic subtest vcs1-lmem0: SUCCESS (0.388s)
[586.117218] Starting dynamic subtest: vcs1-smem0
[586.604403] Dynamic subtest vcs1-smem0: SUCCESS (0.497s)
[586.618224] Starting dynamic subtest: vecs0-lmem0
[586.990056] Dynamic subtest vecs0-lmem0: SUCCESS (0.381s)
[587.008915] Starting dynamic subtest: vecs0-smem0
[587.495417] Dynamic subtest vecs0-smem0: SUCCESS (0.501s)
[587.509312] Starting dynamic subtest: vecs1-lmem0
[587.888148] Dynamic subtest vecs1-lmem0: SUCCESS (0.389s)
[587.906813] Starting dynamic subtest: vecs1-smem0
[588.399425] Dynamic subtest vecs1-smem0: SUCCESS (0.507s)
[588.413366] Starting dynamic subtest: ccs0-lmem0
[588.683501] Dynamic subtest ccs0-lmem0: SUCCESS (0.280s)
[588.701878] Starting dynamic subtest: ccs0-smem0
[589.083100] Dynamic subtest ccs0-smem0: SUCCESS (0.395s)
[589.085027] Subtest crc32: SUCCESS (5.493s)
[589.239102] [097/130] (437s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[589.452878] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[589.454533] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[589.593140] [098/130] (436s left) kms_lease (multimaster-lease)
[589.806501] Starting subtest: multimaster-lease
[589.824665] Subtest multimaster-lease: SUCCESS (0.018s)
[589.956221] [099/130] (436s left) syncobj_timeline (reset-unsignaled)
[590.042055] Starting subtest: reset-unsignaled
[590.043191] Subtest reset-unsignaled: SUCCESS (0.000s)
[590.196272] [100/130] (436s left) gem_lmem_swapping (heavy-random)
[592.987994] Starting subtest: heavy-random
[592.989032] Starting dynamic subtest: lmem0
[598.245092] Dynamic subtest lmem0: SUCCESS (5.257s)
[598.246118] Subtest heavy-random: SUCCESS (5.259s)
[599.820503] [FACT gem_lmem_swapping (heavy-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[599.821552] [FACT gem_lmem_swapping (heavy-random)] deleted: kernel.kmod_is_loaded.i915: true
[599.823592] [101/130] (426s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[601.793290] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[601.795126] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[601.950850] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[601.954126] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[601.955024] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)] new: kernel.kmod_is_loaded.xe: true
[601.957139] [102/130] (424s left) kms_cursor_edge_walk (256x256-top-edge)
[602.165499] Starting subtest: 256x256-top-edge
[602.167660] Starting dynamic subtest: pipe-A-DP-3
[605.660611] Dynamic subtest pipe-A-DP-3: SUCCESS (3.493s)
[605.677048] Starting dynamic subtest: pipe-D-DP-3
[608.998539] Dynamic subtest pipe-D-DP-3: SUCCESS (3.334s)
[608.999492] Subtest 256x256-top-edge: SUCCESS (6.832s)
[609.244758] [103/130] (417s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[609.456944] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[611.725146] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.268s)
[611.898666] [104/130] (414s left) gem_mmap_wc (write)
[611.978462] Subtest write: SKIP (0.000s)
[612.052785] [105/130] (414s left) sw_sync (timeline_closed)
[612.105344] Starting subtest: timeline_closed
[612.106261] Subtest timeline_closed: SUCCESS (0.000s)
[612.187171] [106/130] (414s left) gem_partial_pwrite_pread (write-display)
[612.279363] Subtest write-display: SKIP (0.000s)
[612.348407] [107/130] (414s left) syncobj_timeline (transfer-timeline-point)
[612.430006] Starting subtest: transfer-timeline-point
[612.430954] Subtest transfer-timeline-point: SUCCESS (0.000s)
[612.587130] [108/130] (414s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[612.794047] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[612.795784] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[612.929559] [109/130] (414s left) syncobj_timeline (invalid-signal-illegal-handle)
[613.013985] Starting subtest: invalid-signal-illegal-handle
[613.014816] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[613.172392] [110/130] (413s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[613.381488] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[613.383784] Starting dynamic subtest: pipe-A-DP-3
[613.392419] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[613.401812] Starting dynamic subtest: pipe-B-DP-3
[613.410612] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[613.419817] Starting dynamic subtest: pipe-C-DP-3
[613.428225] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[613.437375] Starting dynamic subtest: pipe-D-DP-3
[613.448364] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[613.450381] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[613.849344] [111/130] (413s left) gem_exec_schedule (u-fairslice-all)
[613.954522] Starting subtest: u-fairslice-all
[616.068786] Subtest u-fairslice-all: SUCCESS (2.114s)
[616.535342] [112/130] (410s left) gem_ctx_engines (invalid-engines)
[616.629451] Starting subtest: invalid-engines
[616.658503] Subtest invalid-engines: SUCCESS (0.029s)
[616.934913] [113/130] (410s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[617.139873] Starting subtest: 2x-long-flip-vs-cursor-legacy
[617.143057] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[617.235066] [114/130] (410s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[617.440496] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[617.442653] Starting dynamic subtest: pipe-A-DP-3
[617.451293] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[617.461058] Starting dynamic subtest: pipe-B-DP-3
[617.469707] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[617.479234] Starting dynamic subtest: pipe-C-DP-3
[617.487684] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[617.497078] Starting dynamic subtest: pipe-D-DP-3
[617.507900] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[617.510064] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[617.887076] [115/130] (409s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[618.094503] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[618.095418] Starting dynamic subtest: pipe-A
[620.239314] Dynamic subtest pipe-A: SUCCESS (2.144s)
[620.263083] Starting dynamic subtest: pipe-B
[622.392952] Dynamic subtest pipe-B: SUCCESS (2.152s)
[622.412129] Starting dynamic subtest: pipe-C
[622.711824] Dynamic subtest pipe-C: SUCCESS (0.317s)
[622.737969] Starting dynamic subtest: pipe-D
[623.030806] Dynamic subtest pipe-D: SUCCESS (0.317s)
[623.032087] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (4.937s)
[623.368208] [116/130] (404s left) gem_exec_schedule (lateslice)
[623.465223] Starting subtest: lateslice
[623.466242] Starting dynamic subtest: rcs0
[623.509384] Dynamic subtest rcs0: SUCCESS (0.044s)
[623.519526] Starting dynamic subtest: bcs0
[623.529445] Dynamic subtest bcs0: SUCCESS (0.019s)
[623.539536] Starting dynamic subtest: vcs0
[623.549714] Dynamic subtest vcs0: SUCCESS (0.019s)
[623.559827] Starting dynamic subtest: vcs1
[623.571225] Dynamic subtest vcs1: SUCCESS (0.021s)
[623.581188] Starting dynamic subtest: vecs0
[623.591062] Dynamic subtest vecs0: SUCCESS (0.019s)
[623.601084] Starting dynamic subtest: vecs1
[623.612947] Dynamic subtest vecs1: SUCCESS (0.021s)
[623.623085] Starting dynamic subtest: ccs0
[623.632817] Dynamic subtest ccs0: SUCCESS (0.019s)
[623.633869] Subtest lateslice: SUCCESS (0.168s)
[624.132357] [117/130] (403s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[624.219437] Starting subtest: invalid-multi-wait-all-unsubmitted
[624.220455] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[624.385680] [118/130] (403s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[624.600505] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[624.602731] Starting dynamic subtest: pipe-A-DP-3
[633.657375] Dynamic subtest pipe-A-DP-3: SUCCESS (9.051s)
[633.671486] Starting dynamic subtest: pipe-B-DP-3
[634.429117] Dynamic subtest pipe-B-DP-3: SUCCESS (0.766s)
[634.463869] Starting dynamic subtest: pipe-C-DP-3
[635.250973] Dynamic subtest pipe-C-DP-3: SUCCESS (0.814s)
[635.286718] Starting dynamic subtest: pipe-D-DP-3
[636.067479] Dynamic subtest pipe-D-DP-3: SUCCESS (0.812s)
[636.068627] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SUCCESS (11.464s)
[636.431493] [119/130] (391s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[636.637529] Starting subtest: primary-yf-tiled-reflect-x-270
[636.639291] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[636.736123] [120/130] (391s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[636.948852] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[636.950551] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[637.086407] [121/130] (390s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[637.294955] Starting subtest: fbcpsr-2p-rte
[637.296732] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[637.443469] [122/130] (390s left) kms_cursor_crc (cursor-random-128x42)
[637.806548] Starting subtest: cursor-random-128x42
[637.811559] Starting dynamic subtest: pipe-A-DP-3
[642.244368] Dynamic subtest pipe-A-DP-3: SUCCESS (4.432s)
[642.296035] Starting dynamic subtest: pipe-D-DP-3
[646.745969] Dynamic subtest pipe-D-DP-3: SUCCESS (4.459s)
[646.746901] Subtest cursor-random-128x42: SUCCESS (8.939s)
[647.197410] [123/130] (380s left) gem_exec_flush (basic-uc-rw-default)
[647.283270] Subtest basic-uc-rw-default: SKIP (0.000s)
[647.362495] [124/130] (380s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[647.444499] Starting subtest: etime-multi-wait-available-unsubmitted
[647.552586] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[647.673631] [125/130] (380s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[647.888556] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[647.890891] Starting dynamic subtest: pipe-A-valid-mode
[647.964869] Dynamic subtest pipe-A-valid-mode: SKIP (0.074s)
[647.966754] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.076s)
[648.180128] [126/130] (380s left) prime_busy (hang-wait)
[648.264892] Starting subtest: hang-wait
[648.267159] Starting dynamic subtest: rcs0
[674.514181] Dynamic subtest rcs0: SUCCESS (26.245s)
[674.524270] Starting dynamic subtest: bcs0
[681.670832] Dynamic subtest bcs0: SUCCESS (7.157s)
[681.680905] Starting dynamic subtest: vcs0
[688.641035] Dynamic subtest vcs0: SUCCESS (6.969s)
[688.651248] Starting dynamic subtest: vcs1
[695.696473] Dynamic subtest vcs1: SUCCESS (7.053s)
[695.706702] Starting dynamic subtest: vecs0
[702.659085] Dynamic subtest vecs0: SUCCESS (6.963s)
[702.669142] Starting dynamic subtest: vecs1
[709.641944] Dynamic subtest vecs1: SUCCESS (6.982s)
[709.651852] Starting dynamic subtest: ccs0
[723.545208] Dynamic subtest ccs0: SUCCESS (13.901s)
[723.546160] Subtest hang-wait: SUCCESS (75.278s)
[723.678733] [127/130] (304s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[723.895042] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[723.957759] [128/130] (304s left) kms_psr (fbc-pr-suspend)
[724.170446] Subtest fbc-pr-suspend: SKIP (0.000s)
[724.222939] [129/130] (304s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[724.310418] Subtest tiled-to-tiled: SKIP (0.000s)
[724.391550] [130/130] (304s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[724.610511] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[725.816118] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.204s)
[725.983796] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: i915_hangman
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: gem_close_race
results: parsing output: 6/ for test: gem_ctx_param
results: parsing output: 7/ for test: sw_sync
results: parsing output: 8/ for test: kms_atomic_transition
results: parsing output: 9/ for test: i915_pm_rpm
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_prop_blob
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_vm_create
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_async_flips
results: parsing output: 18/ for test: kms_psr2_su
results: parsing output: 19/ for test: drm_fdinfo
results: parsing output: 20/ for test: gem_exec_whisper
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_chamelium_hpd
results: parsing output: 23/ for test: gem_mmap_wc
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_media_fill
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: syncobj_basic
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: kms_vblank
results: parsing output: 41/ for test: prime_busy
results: parsing output: 42/ for test: gem_ctx_sseu
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_pxp
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_busy
results: parsing output: 52/ for test: i915_selftest
results: parsing output: 53/ for test: gem_userptr_blits
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: kms_addfb_basic
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: prime_mmap
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_atomic_transition
results: parsing output: 61/ for test: gem_ctx_exec
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_pxp
results: parsing output: 66/ for test: kms_joiner
results: parsing output: 67/ for test: kms_dsc
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: kms_chamelium_frames
results: parsing output: 70/ for test: kms_sequence
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_chamelium_frames
results: parsing output: 74/ for test: fbdev
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: kms_universal_plane
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_plane_cursor
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_lease
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: gem_lmem_swapping
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_cursor_edge_walk
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_mmap_wc
results: parsing output: 104/ for test: sw_sync
results: parsing output: 105/ for test: gem_partial_pwrite_pread
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: gem_ctx_engines
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_plane_scaling
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: gem_exec_flush
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: prime_busy
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_set_tiling_vs_blt
results: parsing output: 129/ for test: kms_big_fb
Done.