[67.290729] Initializing watchdogs
[67.290774]   /dev/watchdog0
[67.302701] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[67.307573] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[67.309789] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.313813] [001/134] (960s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[67.426977] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[72.179230] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.757s)
[73.357090] [002/134] (954s left) kms_psr (psr2-cursor-mmap-gtt)
[73.454986] Starting subtest: psr2-cursor-mmap-gtt
[73.457205] Starting dynamic subtest: eDP-1
[75.124044] Dynamic subtest eDP-1: SUCCESS (1.669s)
[75.125950] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.670s)
[75.913876] [003/134] (951s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[76.007911] Starting subtest: addfb25-y-tiled-legacy
[76.010059] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[76.135312] [004/134] (951s left) api_intel_bb (intel-bb-blit-x)
[76.194846] Starting subtest: intel-bb-blit-x
[79.552112] Subtest intel-bb-blit-x: SUCCESS (3.357s)
[79.707483] [005/134] (948s left) gem_tiled_fence_blits (basic)
[79.770114] Subtest basic: SKIP (0.000s)
[79.835195] [006/134] (948s left) gem_mmap_gtt (big-copy-xy)
[79.893682] Subtest big-copy-XY: SKIP (0.000s)
[79.957617] [007/134] (948s left) drm_read (empty-nonblock)
[80.124385] Starting subtest: empty-nonblock
[80.126729] Subtest empty-nonblock: SUCCESS (0.000s)
[80.271509] [008/134] (947s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[80.370388] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[80.374726] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[80.488025] [009/134] (947s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[80.575076] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[80.576971] Starting dynamic subtest: pipe-A-eDP-1
[80.596285] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[80.604668] Starting dynamic subtest: pipe-B-eDP-1
[80.622092] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[80.628771] Starting dynamic subtest: pipe-C-eDP-1
[80.646151] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[80.652669] Starting dynamic subtest: pipe-D-eDP-1
[80.670897] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[80.674277] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[82.865965] [010/134] (945s left) syncobj_wait (invalid-wait-illegal-handle)
[82.927557] Starting subtest: invalid-wait-illegal-handle
[82.929574] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[83.042762] [011/134] (945s left) gem_partial_pwrite_pread (write)
[83.102886] Subtest write: SKIP (0.000s)
[83.189301] [012/134] (945s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[83.283971] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[83.288665] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[84.419723] [013/134] (943s left) gem_exec_whisper (basic-contexts-priority)
[84.473176] Starting subtest: basic-contexts-priority
[107.379586] Subtest basic-contexts-priority: SUCCESS (23.231s)
[107.567455] [014/134] (920s left) kms_psr (psr-primary-mmap-cpu)
[107.682038] Starting subtest: psr-primary-mmap-cpu
[107.684415] Starting dynamic subtest: eDP-1
[109.446954] Dynamic subtest eDP-1: SUCCESS (1.768s)
[109.449250] Subtest psr-primary-mmap-cpu: SUCCESS (1.769s)
[110.319539] [015/134] (917s left) kms_getfb (getfb2-handle-not-fb)
[110.415862] Starting subtest: getfb2-handle-not-fb
[110.418047] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[110.530197] [016/134] (917s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[110.586908] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[110.588926] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[110.723319] [017/134] (917s left) gem_pwrite_snooped
[110.834155] [018/134] (917s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[110.926438] Starting subtest: plane-primary-toggle-with-vblank-wait
[110.928812] Starting dynamic subtest: pipe-A-eDP-1
[111.100673] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.177s)
[111.421453] Starting dynamic subtest: pipe-B-eDP-1
[112.312675] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.901s)
[112.612172] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.690s)
[113.471187] [019/134] (914s left) kms_content_protection (uevent)
[113.620730] Starting subtest: uevent
[113.625393] Subtest uevent: SKIP (0.000s)
[113.794119] [020/134] (914s left) i915_hangman (engine-error-state-capture)
[113.862643] Starting subtest: engine-error-state-capture
[113.864869] Starting dynamic subtest: rcs0
[117.876642] Dynamic subtest rcs0: SUCCESS (4.017s)
[117.885814] Starting dynamic subtest: bcs0
[123.891378] Dynamic subtest bcs0: SUCCESS (6.013s)
[123.902888] Starting dynamic subtest: vcs0
[129.844735] Dynamic subtest vcs0: SUCCESS (5.951s)
[129.854454] Starting dynamic subtest: vcs1
[135.796087] Dynamic subtest vcs1: SUCCESS (5.949s)
[135.804777] Starting dynamic subtest: vecs0
[140.851053] Dynamic subtest vecs0: SUCCESS (5.054s)
[140.861747] Starting dynamic subtest: ccs0
[146.868576] Dynamic subtest ccs0: SUCCESS (6.016s)
[146.871536] Subtest engine-error-state-capture: SUCCESS (33.005s)
[146.959699] [021/134] (881s left) kms_atomic_transition (plane-toggle-modeset-transition)
[147.058898] Starting subtest: plane-toggle-modeset-transition
[147.060881] Starting dynamic subtest: pipe-A-eDP-1
[159.777438] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.718s)
[159.787809] Starting dynamic subtest: pipe-B-eDP-1
[172.149847] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.369s)
[172.152870] Subtest plane-toggle-modeset-transition: SUCCESS (25.093s)
[172.975349] [022/134] (855s left) gem_lmem_swapping (massive-random)
[173.014780] Subtest massive-random: SKIP (0.000s)
[173.063585] [023/134] (855s left) perf (global-sseu-config-invalid)
[173.183065] Starting subtest: global-sseu-config-invalid
[173.187171] Subtest global-sseu-config-invalid: SKIP (0.000s)
[173.225183] [024/134] (855s left) kms_plane_alpha_blend (constant-alpha-mid)
[173.324607] Starting subtest: constant-alpha-mid
[173.596607] Starting dynamic subtest: pipe-A-eDP-1
[174.496044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.898s)
[174.505653] Starting dynamic subtest: pipe-D-eDP-1
[175.951582] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.455s)
[175.953797] Subtest constant-alpha-mid: SUCCESS (2.629s)
[176.824524] [025/134] (851s left) kms_cursor_crc (cursor-onscreen-256x85)
[177.068668] Starting subtest: cursor-onscreen-256x85
[177.117651] Subtest cursor-onscreen-256x85: SKIP (0.044s)
[177.326796] [026/134] (851s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[182.300479] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[182.305056] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[183.168394] [027/134] (845s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[183.222617] Starting subtest: etime-single-wait-all-for-submit-submitted
[183.328846] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[183.423840] [028/134] (845s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[188.448134] Starting subtest: pr-cursor-plane-update-sf
[188.453630] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[189.289925] [029/134] (839s left) perf (disabled-read-error)
[189.397723] Starting subtest: disabled-read-error
[189.413089] Subtest disabled-read-error: SUCCESS (0.015s)
[189.455123] [030/134] (839s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[189.567995] Starting subtest: fbcpsr-1p-rte
[196.636746] Subtest fbcpsr-1p-rte: SUCCESS (7.075s)
[196.827837] [031/134] (832s left) i915_drm_fdinfo (most-busy-check-all)
[196.867899] Starting subtest: most-busy-check-all
[196.870288] Starting dynamic subtest: rcs0
[196.874794] Dynamic subtest rcs0: SKIP (0.004s)
[196.884525] Starting dynamic subtest: bcs0
[196.888550] Dynamic subtest bcs0: SKIP (0.000s)
[196.896394] Starting dynamic subtest: vcs0
[196.900637] Dynamic subtest vcs0: SKIP (0.000s)
[196.908333] Starting dynamic subtest: vcs1
[196.912785] Dynamic subtest vcs1: SKIP (0.000s)
[196.922228] Starting dynamic subtest: vecs0
[196.926370] Dynamic subtest vecs0: SKIP (0.000s)
[196.933970] Starting dynamic subtest: ccs0
[196.938117] Dynamic subtest ccs0: SKIP (0.000s)
[196.942201] Subtest most-busy-check-all: SKIP (0.007s)
[196.976056] [032/134] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[197.098868] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[197.103426] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[197.222619] [033/134] (831s left) gem_flink_basic (bad-flink)
[197.273817] Starting subtest: bad-flink
[197.276125] Subtest bad-flink: SUCCESS (0.000s)
[197.398260] [034/134] (831s left) prime_vgem (basic-fence-blt)
[197.555320] Starting subtest: basic-fence-blt
[197.633257] Subtest basic-fence-blt: SUCCESS (0.078s)
[197.799281] [FACT prime_vgem (basic-fence-blt)] new: kernel.kmod_is_loaded.vgem: true
[197.802024] [035/134] (831s left) gem_exec_reloc (basic-gtt-active)
[197.858940] Subtest basic-gtt-active: SKIP (0.000s)
[197.951912] [036/134] (831s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[198.071325] Starting subtest: cursorB-vs-flipB-atomic
[198.075249] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[198.232832] [037/134] (830s left) gen3_render_linear_blits
[198.348464] [038/134] (830s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[198.404034] Starting subtest: multi-wait-all-for-submit-available-signaled
[198.405894] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[198.531444] [039/134] (830s left) kms_panel_fitting (legacy)
[198.623973] Starting subtest: legacy
[198.626016] Starting dynamic subtest: pipe-A-eDP-1
[199.177124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[199.204728] Starting dynamic subtest: pipe-B-eDP-1
[200.694553] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.498s)
[200.721492] Starting dynamic subtest: pipe-C-eDP-1
[202.205926] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.491s)
[202.231497] Starting dynamic subtest: pipe-D-eDP-1
[203.736061] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.510s)
[203.738431] Subtest legacy: SUCCESS (5.112s)
[204.978475] [040/134] (824s left) gem_spin_batch (resubmit-new-all)
[205.038047] Starting subtest: resubmit-new-all
[205.040354] Starting dynamic subtest: rcs0
[205.051551] Dynamic subtest rcs0: SUCCESS (0.013s)
[205.059435] Starting dynamic subtest: bcs0
[205.063753] Dynamic subtest bcs0: SUCCESS (0.011s)
[205.072433] Starting dynamic subtest: vcs0
[205.074739] Dynamic subtest vcs0: SUCCESS (0.010s)
[205.082360] Starting dynamic subtest: vcs1
[205.084646] Dynamic subtest vcs1: SUCCESS (0.008s)
[205.092734] Starting dynamic subtest: vecs0
[205.094652] Dynamic subtest vecs0: SUCCESS (0.008s)
[205.106613] Starting dynamic subtest: ccs0
[205.108832] Dynamic subtest ccs0: SUCCESS (0.008s)
[205.111066] Subtest resubmit-new-all: SUCCESS (0.062s)
[206.982860] [041/134] (822s left) gem_exec_balancer (parallel-contexts)
[207.230597] Starting subtest: parallel-contexts
[210.990356] Subtest parallel-contexts: SUCCESS (3.760s)
[211.130414] [042/134] (818s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[211.181278] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[211.256260] [043/134] (818s left) gem_exec_schedule (submit-late-slice)
[211.332634] Starting subtest: submit-late-slice
[211.334619] Starting dynamic subtest: rcs0
[211.382388] Dynamic subtest rcs0: SUCCESS (0.057s)
[211.393651] Starting dynamic subtest: bcs0
[211.424366] Dynamic subtest bcs0: SUCCESS (0.042s)
[211.432250] Starting dynamic subtest: vcs0
[211.475991] Dynamic subtest vcs0: SUCCESS (0.050s)
[211.486488] Starting dynamic subtest: vcs1
[211.524053] Dynamic subtest vcs1: SUCCESS (0.048s)
[211.534320] Starting dynamic subtest: vecs0
[211.567405] Dynamic subtest vecs0: SUCCESS (0.043s)
[211.577469] Starting dynamic subtest: ccs0
[211.619014] Dynamic subtest ccs0: SUCCESS (0.051s)
[211.622053] Subtest submit-late-slice: SUCCESS (0.294s)
[213.014351] [044/134] (816s left) gem_exec_schedule (preempt)
[213.093274] Starting subtest: preempt
[213.095329] Starting dynamic subtest: rcs0
[213.120644] Dynamic subtest rcs0: SUCCESS (0.035s)
[213.131383] Starting dynamic subtest: bcs0
[213.149047] Dynamic subtest bcs0: SUCCESS (0.028s)
[213.160825] Starting dynamic subtest: vcs0
[213.175271] Dynamic subtest vcs0: SUCCESS (0.026s)
[213.185049] Starting dynamic subtest: vcs1
[213.200213] Dynamic subtest vcs1: SUCCESS (0.024s)
[213.210280] Starting dynamic subtest: vecs0
[213.220939] Dynamic subtest vecs0: SUCCESS (0.020s)
[213.228862] Starting dynamic subtest: ccs0
[213.251256] Dynamic subtest ccs0: SUCCESS (0.030s)
[213.253540] Subtest preempt: SUCCESS (0.166s)
[215.067844] [045/134] (814s left) syncobj_basic (bad-flags-handle-to-fd)
[215.120498] Starting subtest: bad-flags-handle-to-fd
[215.122882] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[215.256903] [046/134] (814s left) gem_ctx_param (non-root-set)
[215.305928] Starting subtest: non-root-set
[215.332866] Subtest non-root-set: SUCCESS (0.027s)
[215.455938] [047/134] (814s left) kms_big_fb (linear-32bpp-rotate-180)
[215.555615] Starting subtest: linear-32bpp-rotate-180
[216.989324] Subtest linear-32bpp-rotate-180: SUCCESS (1.433s)
[217.153524] [048/134] (812s left) syncobj_eventfd (timeline-wait)
[217.212324] Starting subtest: timeline-wait
[217.221240] Subtest timeline-wait: SUCCESS (0.010s)
[217.303063] [049/134] (812s left) kms_vblank (wait-forked-hang)
[217.394351] Starting subtest: wait-forked-hang
[217.396150] Starting dynamic subtest: pipe-A-eDP-1
[224.348864] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.953s)
[224.366889] Starting dynamic subtest: pipe-D-eDP-1
[231.323538] Dynamic subtest pipe-D-eDP-1: SUCCESS (6.974s)
[231.326083] Subtest wait-forked-hang: SUCCESS (13.932s)
[232.135984] [050/134] (797s left) kms_psr (fbc-psr-sprite-blt)
[232.233669] Starting subtest: fbc-psr-sprite-blt
[232.236222] Starting dynamic subtest: eDP-1
[232.241101] Dynamic subtest eDP-1: SKIP (0.000s)
[232.245673] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[232.313168] [051/134] (797s left) gem_mmap_offset (pf-nonblock)
[232.376507] Starting subtest: pf-nonblock
[232.386864] Subtest pf-nonblock: SUCCESS (0.012s)
[232.553214] [052/134] (797s left) gem_userptr_blits (relocations)
[232.613826] Starting subtest: relocations
[232.618275] Subtest relocations: SKIP (0.000s)
[232.757502] [053/134] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[232.860157] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[232.864125] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[233.001437] [054/134] (796s left) perf (blocking)
[233.087311] Starting subtest: blocking
[233.089486] Starting dynamic subtest: 0-rcs0
[243.116994] Dynamic subtest 0-rcs0: SUCCESS (10.027s)
[243.125127] Starting dynamic subtest: 1-vecs0
[253.137910] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[253.140505] Subtest blocking: SUCCESS (20.048s)
[253.185059] [055/134] (776s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[253.297761] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[259.915680] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.619s)
[260.090090] [056/134] (769s left) kms_plane_multiple (tiling-none)
[260.191208] Starting subtest: tiling-none
[260.193530] Starting dynamic subtest: pipe-A-eDP-1
[263.986955] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.796s)
[263.995253] Starting dynamic subtest: pipe-B-eDP-1
[268.430290] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.440s)
[268.440901] Starting dynamic subtest: pipe-C-eDP-1
[272.766481] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.334s)
[272.774836] Starting dynamic subtest: pipe-D-eDP-1
[277.109286] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.342s)
[277.111753] Subtest tiling-none: SUCCESS (16.918s)
[277.920580] [057/134] (751s left) gem_userptr_blits (set-cache-level)
[277.987412] Starting subtest: set-cache-level
[277.991606] Subtest set-cache-level: SKIP (0.000s)
[278.134898] [058/134] (751s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[278.233317] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[285.615554] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.384s)
[285.775578] [059/134] (744s left) syncobj_timeline (multi-wait-signaled)
[285.834463] Starting subtest: multi-wait-signaled
[285.836765] Subtest multi-wait-signaled: SUCCESS (0.001s)
[285.962656] [060/134] (744s left) gem_tiled_swapping (non-threaded)
[286.011782] Subtest non-threaded: SKIP (0.000s)
[286.070376] [061/134] (743s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[286.162470] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[286.166481] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[286.272698] [062/134] (743s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[286.357800] Starting subtest: fbc-indfb-scaledprimary
[289.299036] Subtest fbc-indfb-scaledprimary: SUCCESS (2.944s)
[290.462360] [063/134] (739s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[290.556051] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[290.558411] Starting dynamic subtest: pipe-A-default-mode
[290.847978] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[290.852715] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.289s)
[291.661778] [064/134] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[291.762346] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[291.766351] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[291.862212] [065/134] (738s left) kms_writeback (writeback-pixel-formats)
[291.960488] Subtest writeback-pixel-formats: SKIP (0.000s)
[292.001608] [066/134] (738s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[297.028577] Starting subtest: pr-primary-plane-update-sf-dmg-area
[297.033088] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[297.880816] [067/134] (732s left) kms_psr (fbc-pr-primary-page-flip)
[297.975614] Starting subtest: fbc-pr-primary-page-flip
[297.980076] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[298.069890] [068/134] (732s left) kms_async_flips (invalid-async-flip-atomic)
[298.157990] Starting subtest: invalid-async-flip-atomic
[298.528677] Starting dynamic subtest: pipe-A-eDP-1
[299.944070] Dynamic subtest pipe-A-eDP-1: FAIL (0.835s)
[299.955069] Starting dynamic subtest: pipe-B-eDP-1
[300.882276] Dynamic subtest pipe-B-eDP-1: FAIL (0.746s)
[300.890220] Starting dynamic subtest: pipe-C-eDP-1
[301.629668] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.805s)
[301.980675] Starting dynamic subtest: pipe-D-eDP-1
[302.761724] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.787s)
[302.764033] Subtest invalid-async-flip-atomic: FAIL (4.605s)
[303.920624] [069/134] (726s left) gem_mmap_gtt (hang-user)
[303.986764] Subtest hang-user: SKIP (0.000s)
[304.045301] [070/134] (726s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[304.130312] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[304.132682] Starting dynamic subtest: pipe-A-default-mode
[305.285372] Dynamic subtest pipe-A-default-mode: SKIP (1.152s)
[305.289825] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.154s)
[305.476227] [071/134] (724s left) gem_ringfill (engines-basic)
[310.935959] Starting subtest: engines-basic
[310.938837] Starting dynamic subtest: rcs0
[311.004570] Dynamic subtest rcs0: SUCCESS (0.068s)
[311.015724] Starting dynamic subtest: bcs0
[311.049907] Dynamic subtest bcs0: SUCCESS (0.043s)
[311.059316] Starting dynamic subtest: vcs0
[311.093051] Dynamic subtest vcs0: SUCCESS (0.041s)
[311.103037] Starting dynamic subtest: vcs1
[311.135071] Dynamic subtest vcs1: SUCCESS (0.040s)
[311.144493] Starting dynamic subtest: vecs0
[311.179154] Dynamic subtest vecs0: SUCCESS (0.042s)
[311.189483] Starting dynamic subtest: ccs0
[311.224871] Dynamic subtest ccs0: SUCCESS (0.044s)
[311.227344] Subtest engines-basic: SUCCESS (0.291s)
[311.313808] [072/134] (719s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[311.407538] Starting subtest: fbc-rgb565-draw-mmap-cpu
[315.385133] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.981s)
[316.586018] [073/134] (713s left) kms_colorop (plane-xr24-xr24-pq_125_eotf-pq_125_inv_eotf)
[316.723203] Subtest plane-XR24-XR24-pq_125_eotf-pq_125_inv_eotf: SKIP (0.000s)
[316.804791] [074/134] (713s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[316.888770] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[316.891176] Starting dynamic subtest: pipe-A-eDP-1
[317.177983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.261s)
[317.186445] Starting dynamic subtest: pipe-B-eDP-1
[318.428521] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.246s)
[318.438022] Starting dynamic subtest: pipe-C-eDP-1
[319.636038] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s)
[319.644797] Starting dynamic subtest: pipe-D-eDP-1
[320.888374] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.255s)
[320.890592] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.974s)
[322.000247] [075/134] (708s left) kms_flip (flip-vs-panning-interruptible)
[322.089450] Starting subtest: flip-vs-panning-interruptible
[322.091789] Starting dynamic subtest: A-eDP1
[330.795029] Dynamic subtest A-eDP1: SUCCESS (8.705s)
[330.805423] Starting dynamic subtest: B-eDP1
[339.529367] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[339.540478] Starting dynamic subtest: C-eDP1
[348.250661] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[348.260454] Starting dynamic subtest: D-eDP1
[356.974954] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[356.979102] Subtest flip-vs-panning-interruptible: SUCCESS (34.890s)
[358.161406] [076/134] (672s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[358.538634] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[359.351370] [077/134] (671s left) syncobj_timeline (wait-for-submit-delayed-submit)
[359.412562] Starting subtest: wait-for-submit-delayed-submit
[359.515133] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[359.608361] [078/134] (671s left) gem_mmap_gtt (cpuset-big-copy-xy)
[359.665419] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[359.728706] [079/134] (671s left) gem_ctx_persistence (file)
[359.788825] Starting subtest: file
[359.934336] Subtest file: SUCCESS (0.145s)
[360.094372] [080/134] (670s left) gem_exec_balancer (bonded-dual)
[360.156897] Starting subtest: bonded-dual
[360.161342] Subtest bonded-dual: SKIP (0.000s)
[360.462136] [081/134] (670s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[360.559319] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[360.563631] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[360.668625] [082/134] (670s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[360.752581] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[360.754464] Starting dynamic subtest: pipe-A-eDP-1
[361.603425] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.846s)
[361.613190] Starting dynamic subtest: pipe-B-eDP-1
[363.121336] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.514s)
[363.130304] Starting dynamic subtest: pipe-C-eDP-1
[364.630878] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.508s)
[364.640297] Starting dynamic subtest: pipe-D-eDP-1
[366.138722] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.505s)
[366.140667] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.378s)
[367.325805] [083/134] (663s left) prime_mmap (test_refcounting)
[367.382583] Starting subtest: test_refcounting
[367.384481] Starting dynamic subtest: test_refcounting-smem
[367.410166] Dynamic subtest test_refcounting-smem: SUCCESS (0.030s)
[367.412599] Subtest test_refcounting: SUCCESS (0.030s)
[367.523904] [084/134] (663s left) i915_query (engine-info)
[367.578084] Starting subtest: engine-info
[367.580791] Subtest engine-info: SUCCESS (0.005s)
[367.713879] [085/134] (663s left) gem_ctx_engines (execute-one)
[367.765924] Starting subtest: execute-one
[369.956062] Subtest execute-one: SUCCESS (2.190s)
[370.163139] [086/134] (660s left) kms_pm_backlight (bad-brightness)
[370.263303] Starting subtest: bad-brightness
[370.310037] Starting dynamic subtest: eDP-1
[370.617146] Dynamic subtest eDP-1: SUCCESS (0.305s)
[370.619450] Subtest bad-brightness: SUCCESS (0.355s)
[371.468661] [087/134] (659s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[371.584860] Starting subtest: basic-flip-before-cursor-varying-size
[372.513660] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.925s)
[373.401846] [088/134] (657s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[373.509259] Starting subtest: yf-tiled-64bpp-rotate-0
[373.513138] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[373.636591] [089/134] (657s left) kms_plane_scaling (planes-upscale-20x20)
[373.722988] Starting subtest: planes-upscale-20x20
[373.725280] Starting dynamic subtest: pipe-A
[373.795235] Dynamic subtest pipe-A: SUCCESS (0.074s)
[373.804030] Starting dynamic subtest: pipe-B
[374.911926] Dynamic subtest pipe-B: SUCCESS (1.116s)
[374.922912] Starting dynamic subtest: pipe-C
[376.021623] Dynamic subtest pipe-C: SUCCESS (1.108s)
[376.030007] Starting dynamic subtest: pipe-D
[377.162797] Dynamic subtest pipe-D: SUCCESS (1.139s)
[377.165127] Subtest planes-upscale-20x20: SUCCESS (3.442s)
[378.323258] [090/134] (652s left) kms_color (ctm-green-to-red)
[378.417330] Starting subtest: ctm-green-to-red
[378.419536] Starting dynamic subtest: pipe-A-eDP-1
[379.111311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.692s)
[379.120785] Starting dynamic subtest: pipe-B-eDP-1
[380.493656] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s)
[380.501780] Starting dynamic subtest: pipe-C-eDP-1
[381.746735] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.252s)
[381.755966] Starting dynamic subtest: pipe-D-eDP-1
[383.107864] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.362s)
[383.110305] Subtest ctm-green-to-red: SUCCESS (4.693s)
[383.949634] [091/134] (647s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[384.054783] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[385.200615] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.145s)
[385.340018] [092/134] (645s left) kms_cursor_legacy (torture-move)
[385.461497] Starting subtest: torture-move
[385.463484] Starting dynamic subtest: pipe-A
[391.084715] Dynamic subtest pipe-A: SUCCESS (5.618s)
[391.095962] Starting dynamic subtest: pipe-B
[397.139218] Dynamic subtest pipe-B: SUCCESS (6.052s)
[397.151336] Starting dynamic subtest: pipe-C
[402.929289] Dynamic subtest pipe-C: SUCCESS (5.787s)
[402.941366] Starting dynamic subtest: pipe-D
[409.275755] Dynamic subtest pipe-D: SUCCESS (6.344s)
[409.288201] Starting dynamic subtest: all-pipes
[415.357613] Dynamic subtest all-pipes: SUCCESS (6.078s)
[415.360160] Subtest torture-move: SUCCESS (29.892s)
[415.538977] [093/134] (615s left) gem_userptr_blits (usage-restrictions)
[415.605847] Starting subtest: usage-restrictions
[415.607653] Subtest usage-restrictions: SUCCESS (0.000s)
[415.740882] [094/134] (615s left) i915_pm_rpm (debugfs-read)
[417.275301] Starting subtest: debugfs-read
[418.426504] Subtest debugfs-read: SUCCESS (1.149s)
[418.822727] [095/134] (612s left) gem_exec_schedule (deep)
[418.994059] Starting subtest: deep
[418.996252] Starting dynamic subtest: rcs0
[423.720654] Dynamic subtest rcs0: SKIP (4.724s)
[423.729292] Starting dynamic subtest: vcs0
[433.697724] Dynamic subtest vcs0: SUCCESS (9.978s)
[433.709597] Starting dynamic subtest: vcs1
[444.813802] Dynamic subtest vcs1: SUCCESS (11.114s)
[444.824315] Starting dynamic subtest: vecs0
[455.386859] Dynamic subtest vecs0: SUCCESS (10.573s)
[455.396785] Starting dynamic subtest: ccs0
[466.980363] Dynamic subtest ccs0: SUCCESS (11.591s)
[466.982796] Subtest deep: SUCCESS (47.985s)
[468.083892] [096/134] (563s left) gem_fence_thrash (bo-write-verify-y)
[468.120049] Starting subtest: bo-write-verify-y
[468.140625] Subtest bo-write-verify-y: SKIP (0.017s)
[468.203459] [097/134] (563s left) gem_busy (busy)
[468.269140] Starting subtest: busy
[468.271427] Starting dynamic subtest: all-engines
[468.363728] Dynamic subtest all-engines: SUCCESS (0.094s)
[468.372427] Starting dynamic subtest: rcs0
[469.916797] Dynamic subtest rcs0: SUCCESS (1.552s)
[469.925023] Starting dynamic subtest: bcs0
[469.980317] Dynamic subtest bcs0: SUCCESS (0.061s)
[469.990662] Starting dynamic subtest: vcs0
[470.019976] Dynamic subtest vcs0: SUCCESS (0.039s)
[470.028711] Starting dynamic subtest: vcs1
[471.897714] Dynamic subtest vcs1: SUCCESS (1.874s)
[471.906674] Starting dynamic subtest: vecs0
[473.880952] Dynamic subtest vecs0: SUCCESS (1.982s)
[473.894691] Starting dynamic subtest: ccs0
[475.928245] Dynamic subtest ccs0: SUCCESS (2.046s)
[475.930629] Subtest busy: SUCCESS (7.658s)
[476.315591] [098/134] (555s left) kms_scaling_modes (scaling-mode-none)
[476.411827] Starting subtest: scaling-mode-none
[476.413696] Starting dynamic subtest: pipe-A-eDP-1
[476.510305] Dynamic subtest pipe-A-eDP-1: SKIP (0.097s)
[476.519819] Starting dynamic subtest: pipe-B-eDP-1
[476.543989] Dynamic subtest pipe-B-eDP-1: SKIP (0.032s)
[476.553307] Starting dynamic subtest: pipe-C-eDP-1
[476.575816] Dynamic subtest pipe-C-eDP-1: SKIP (0.030s)
[476.587482] Starting dynamic subtest: pipe-D-eDP-1
[476.606212] Dynamic subtest pipe-D-eDP-1: SKIP (0.029s)
[476.610144] Subtest scaling-mode-none: SKIP (0.194s)
[476.762170] [099/134] (554s left) kms_pm_rpm (modeset-non-lpsp)
[479.104981] Starting subtest: modeset-non-lpsp
[480.258235] Subtest modeset-non-lpsp: SKIP (1.154s)
[480.643490] [100/134] (550s left) api_intel_allocator (fork-simple-stress-signal)
[480.697725] Starting subtest: fork-simple-stress-signal
[486.098533] Subtest fork-simple-stress-signal: SUCCESS (5.402s)
[486.241880] [101/134] (545s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[486.847142] Starting subtest: syncobj-backward-timeline-chain-engines
[487.035200] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.188s)
[488.027248] [102/134] (543s left) kms_busy (extended-pageflip-hang-oldfb)
[488.134873] Starting subtest: extended-pageflip-hang-oldfb
[488.137210] Starting dynamic subtest: pipe-A
[488.557791] Dynamic subtest pipe-A: SUCCESS (0.421s)
[488.570501] Starting dynamic subtest: pipe-D
[489.651975] Dynamic subtest pipe-D: SUCCESS (1.091s)
[489.654589] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.516s)
[490.497473] [103/134] (541s left) gem_pread (display)
[490.559458] Subtest display: SKIP (0.000s)
[490.624057] [104/134] (541s left) kms_lease (lease-revoke)
[490.716373] Starting subtest: lease-revoke
[490.718640] Starting dynamic subtest: pipe-A-eDP-1
[490.751523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[490.761027] Starting dynamic subtest: pipe-B-eDP-1
[490.780142] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[490.789456] Starting dynamic subtest: pipe-C-eDP-1
[490.805750] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[490.820027] Starting dynamic subtest: pipe-D-eDP-1
[490.835171] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[490.837081] Subtest lease-revoke: SUCCESS (0.117s)
[491.002495] [105/134] (540s left) gem_ctx_isolation (clean)
[491.062891] Starting subtest: clean
[491.065359] Starting dynamic subtest: rcs0
[491.114115] Dynamic subtest rcs0: SUCCESS (0.051s)
[491.122784] Starting dynamic subtest: bcs0
[491.151290] Dynamic subtest bcs0: SUCCESS (0.036s)
[491.160265] Starting dynamic subtest: vcs0
[491.242345] Dynamic subtest vcs0: SUCCESS (0.090s)
[491.252764] Starting dynamic subtest: vcs1
[492.889347] Dynamic subtest vcs1: SUCCESS (1.646s)
[492.899997] Starting dynamic subtest: vecs0
[494.983430] Dynamic subtest vecs0: SUCCESS (2.094s)
[494.991811] Starting dynamic subtest: ccs0
[496.969160] Dynamic subtest ccs0: SUCCESS (1.984s)
[496.971521] Subtest clean: SUCCESS (5.906s)
[497.219513] [106/134] (534s left) kms_cursor_edge_walk (128x128-top-edge)
[497.312551] Starting subtest: 128x128-top-edge
[497.314897] Starting dynamic subtest: pipe-A-eDP-1
[500.742608] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s)
[500.752044] Starting dynamic subtest: pipe-D-eDP-1
[503.874992] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[503.877215] Subtest 128x128-top-edge: SUCCESS (6.564s)
[504.681285] [107/134] (527s left) gem_pxp (reject-modify-context-protection-off-1)
[504.808952] Starting subtest: reject-modify-context-protection-off-1
[504.811458] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[504.922354] [108/134] (526s left) kms_flip (nonexisting-fb-interruptible)
[505.029529] Starting subtest: nonexisting-fb-interruptible
[505.031890] Starting dynamic subtest: A-eDP1
[506.150314] Dynamic subtest A-eDP1: SUCCESS (1.120s)
[506.158862] Starting dynamic subtest: B-eDP1
[507.272168] Dynamic subtest B-eDP1: SUCCESS (1.121s)
[507.282563] Starting dynamic subtest: C-eDP1
[508.406245] Dynamic subtest C-eDP1: SUCCESS (1.133s)
[508.415815] Starting dynamic subtest: D-eDP1
[509.531845] Dynamic subtest D-eDP1: SUCCESS (1.125s)
[509.536549] Subtest nonexisting-fb-interruptible: SUCCESS (4.508s)
[510.723401] [109/134] (521s left) gem_ctx_shared (detached-shared-gtt)
[510.781506] Starting subtest: detached-shared-gtt
[512.934829] Subtest detached-shared-gtt: SUCCESS (2.152s)
[513.360989] [110/134] (518s left) kms_cursor_crc (cursor-sliding-128x128)
[513.557807] Starting subtest: cursor-sliding-128x128
[513.563033] Starting dynamic subtest: pipe-A-eDP-1
[516.796510] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.233s)
[516.822377] Starting dynamic subtest: pipe-D-eDP-1
[520.693142] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.876s)
[520.695374] Subtest cursor-sliding-128x128: SUCCESS (7.134s)
[521.582610] [111/134] (510s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[521.688108] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[521.692342] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[521.816461] [112/134] (510s left) dmabuf_sync_file (export-multiwait)
[521.857481] Starting subtest: export-multiwait
[521.859520] Subtest export-multiwait: SUCCESS (0.000s)
[521.939616] [113/134] (510s left) syncobj_basic (bad-destroy)
[521.996169] Starting subtest: bad-destroy
[521.998450] Subtest bad-destroy: SUCCESS (0.000s)
[522.121027] [114/134] (509s left) sysfs_timeslice_duration (duration)
[522.174659] Starting subtest: duration
[522.177150] Starting dynamic subtest: vecs0
[535.794785] Dynamic subtest vecs0: SUCCESS (13.617s)
[535.806586] Starting dynamic subtest: ccs0
[548.968096] Dynamic subtest ccs0: SUCCESS (13.171s)
[548.978349] Starting dynamic subtest: vcs0
[563.826596] Dynamic subtest vcs0: SUCCESS (14.853s)
[563.838223] Starting dynamic subtest: bcs0
[576.973290] Dynamic subtest bcs0: SUCCESS (13.145s)
[576.988417] Starting dynamic subtest: rcs0
[590.142327] Dynamic subtest rcs0: SUCCESS (13.165s)
[590.157602] Starting dynamic subtest: vcs1
[604.850555] Dynamic subtest vcs1: SUCCESS (14.703s)
[604.854505] Subtest duration: SUCCESS (82.673s)
[604.943279] [115/134] (427s left) kms_colorop (plane-xr30-xr30-gamma_2_2_inv_oetf-gamma_2_2_oetf)
[605.079689] Subtest plane-XR30-XR30-gamma_2_2_inv_oetf-gamma_2_2_oetf: SKIP (0.000s)
[605.159074] [116/134] (427s left) kms_psr (fbc-psr-no-drrs)
[605.253100] Starting subtest: fbc-psr-no-drrs
[605.255390] Starting dynamic subtest: eDP-1
[605.259394] Dynamic subtest eDP-1: SKIP (0.000s)
[605.263507] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[605.344214] [117/134] (426s left) kms_chamelium_frames (dp-crc-fast)
[605.728271] Subtest dp-crc-fast: SKIP (0.000s)
[606.558905] [118/134] (425s left) kms_flip (nonexisting-fb)
[606.648157] Starting subtest: nonexisting-fb
[606.650415] Starting dynamic subtest: A-eDP1
[607.772522] Dynamic subtest A-eDP1: SUCCESS (1.123s)
[607.785656] Starting dynamic subtest: B-eDP1
[608.901451] Dynamic subtest B-eDP1: SUCCESS (1.128s)
[608.910325] Starting dynamic subtest: C-eDP1
[610.043152] Dynamic subtest C-eDP1: SUCCESS (1.141s)
[610.051672] Starting dynamic subtest: D-eDP1
[611.174199] Dynamic subtest D-eDP1: SUCCESS (1.130s)
[611.176635] Subtest nonexisting-fb: SUCCESS (4.529s)
[612.366699] [119/134] (419s left) gem_linear_blits (normal)
[612.885828] Starting subtest: normal
[616.321633] Subtest normal: SUCCESS (3.435s)
[616.447401] [120/134] (415s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[616.605569] Starting subtest: yf-tiled-8bpp-rotate-180
[616.610099] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[616.752115] [121/134] (415s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[616.861669] Starting subtest: flip-vs-cursor-busy-crc-legacy
[617.712967] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.848s)
[618.584190] [122/134] (413s left) kms_lease (atomic-implicit-crtc)
[618.680889] Starting subtest: atomic-implicit-crtc
[618.683150] Starting dynamic subtest: pipe-A-eDP-1
[618.693931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[618.703830] Starting dynamic subtest: pipe-B-eDP-1
[618.715037] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[618.723719] Starting dynamic subtest: pipe-C-eDP-1
[618.734153] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[618.742543] Starting dynamic subtest: pipe-D-eDP-1
[618.752996] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[618.755028] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[618.854546] [123/134] (413s left) kms_chamelium_color (ctm-limited-range)
[618.940456] Subtest ctm-limited-range: SKIP (0.000s)
[618.984374] [124/134] (413s left) syncobj_wait (wait-all-for-submit-snapshot)
[619.047587] Starting subtest: wait-all-for-submit-snapshot
[619.129796] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[619.228310] [125/134] (413s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[619.331362] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[619.335863] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[619.471109] [126/134] (413s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[619.570277] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[619.573712] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[619.707419] [127/134] (412s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[619.759430] Starting subtest: invalid-multi-wait-all-unsubmitted
[619.761371] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[619.864109] [128/134] (412s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[619.954138] Starting subtest: 4-tiled-8bpp-rotate-90
[619.974956] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[620.134356] [129/134] (412s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[620.250506] Starting subtest: basic-flip-after-cursor-legacy
[621.172092] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.921s)
[622.018936] [130/134] (410s left) gen7_exec_parse (basic-offset)
[622.092417] Subtest basic-offset: SKIP (0.000s)
[622.164893] [131/134] (410s left) kms_feature_discovery (display-3x)
[622.263784] Starting subtest: display-3x
[622.267896] Subtest display-3x: SKIP (0.000s)
[622.348240] [132/134] (410s left) kms_flip (flip-vs-absolute-wf_vblank)
[622.448257] Starting subtest: flip-vs-absolute-wf_vblank
[622.450434] Starting dynamic subtest: A-eDP1
[631.352161] Dynamic subtest A-eDP1: SUCCESS (8.905s)
[631.363870] Starting dynamic subtest: B-eDP1
[640.284553] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[640.293868] Starting dynamic subtest: C-eDP1
[649.204694] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[649.215717] Starting dynamic subtest: D-eDP1
[658.135773] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[658.142823] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.692s)
[659.378423] [133/134] (373s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[659.484704] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[663.400337] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.919s)
[664.589042] [134/134] (368s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[664.684468] Starting subtest: y-tiled-32bpp-rotate-90
[664.688883] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[664.797573] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_addfb_basic
results: parsing output: 3/ for test: api_intel_bb
results: parsing output: 4/ for test: gem_tiled_fence_blits
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: drm_read
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: gem_partial_pwrite_pread
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: gem_exec_whisper
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_getfb
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_pwrite_snooped
results: parsing output: 17/ for test: kms_atomic_transition
results: parsing output: 18/ for test: kms_content_protection
results: parsing output: 19/ for test: i915_hangman
results: parsing output: 20/ for test: kms_atomic_transition
results: parsing output: 21/ for test: gem_lmem_swapping
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_plane_alpha_blend
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: i915_drm_fdinfo
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_flink_basic
results: parsing output: 33/ for test: prime_vgem
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: gen3_render_linear_blits
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_panel_fitting
results: parsing output: 39/ for test: gem_spin_batch
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: syncobj_basic
results: parsing output: 45/ for test: gem_ctx_param
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: syncobj_eventfd
results: parsing output: 48/ for test: kms_vblank
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_mmap_offset
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_plane_multiple
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_tiled_swapping
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_writeback
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_async_flips
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: gem_ringfill
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_colorop
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_chamelium_hpd
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: gem_mmap_gtt
results: parsing output: 78/ for test: gem_ctx_persistence
results: parsing output: 79/ for test: gem_exec_balancer
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: prime_mmap
results: parsing output: 83/ for test: i915_query
results: parsing output: 84/ for test: gem_ctx_engines
results: parsing output: 85/ for test: kms_pm_backlight
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: i915_pm_rpm
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: gem_fence_thrash
results: parsing output: 96/ for test: gem_busy
results: parsing output: 97/ for test: kms_scaling_modes
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: api_intel_allocator
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: kms_busy
results: parsing output: 102/ for test: gem_pread
results: parsing output: 103/ for test: kms_lease
results: parsing output: 104/ for test: gem_ctx_isolation
results: parsing output: 105/ for test: kms_cursor_edge_walk
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_ctx_shared
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: dmabuf_sync_file
results: parsing output: 112/ for test: syncobj_basic
results: parsing output: 113/ for test: sysfs_timeslice_duration
results: parsing output: 114/ for test: kms_colorop
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_chamelium_frames
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: gem_linear_blits
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_lease
results: parsing output: 122/ for test: kms_chamelium_color
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: gen7_exec_parse
results: parsing output: 130/ for test: kms_feature_discovery
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_big_fb
Done.