[51.959646] Initializing watchdogs
[51.959699]   /dev/watchdog0
[51.974743] [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]
[51.979460] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.982156] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[51.985977] [001/133] (960s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[52.116647] Starting subtest: flip-vs-dpms-on-nop-interruptible
[52.119189] Starting dynamic subtest: A-eDP1
[53.968834] Dynamic subtest A-eDP1: SUCCESS (1.850s)
[53.980069] Starting dynamic subtest: B-eDP1
[55.778395] Dynamic subtest B-eDP1: SUCCESS (1.810s)
[55.788697] Starting dynamic subtest: C-eDP1
[57.607551] Dynamic subtest C-eDP1: SUCCESS (1.828s)
[57.617724] Starting dynamic subtest: D-eDP1
[59.436137] Dynamic subtest D-eDP1: SUCCESS (1.828s)
[59.438485] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.323s)
[60.625320] [002/133] (951s left) kms_joiner (invalid-modeset-big-joiner)
[60.736427] Starting subtest: invalid-modeset-big-joiner
[60.740858] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[60.800975] [003/133] (951s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[61.179350] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[62.018865] [004/133] (950s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[62.120190] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[62.124203] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[62.183863] [005/133] (950s left) gem_exec_params (batch-first)
[62.247980] Starting subtest: batch-first
[62.254313] Subtest batch-first: SUCCESS (0.006s)
[62.373764] [006/133] (950s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[62.475069] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[62.477430] Starting dynamic subtest: pipe-A-eDP-1
[62.500409] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[62.510085] Starting dynamic subtest: pipe-B-eDP-1
[62.531165] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[62.538464] Starting dynamic subtest: pipe-C-eDP-1
[62.559759] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[62.569618] Starting dynamic subtest: pipe-D-eDP-1
[62.592601] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[62.597099] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[64.724573] [007/133] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[64.839182] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[64.843183] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[64.945294] [008/133] (947s left) i915_drm_fdinfo (virtual-idle)
[64.991173] Starting subtest: virtual-idle
[68.060706] Subtest virtual-idle: SUCCESS (3.069s)
[68.133664] [009/133] (944s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[68.233894] Starting subtest: plane-scaler-unity-scaling-with-rotation
[68.236199] Starting dynamic subtest: pipe-A
[68.459394] Dynamic subtest pipe-A: SUCCESS (0.228s)
[68.469959] Starting dynamic subtest: pipe-B
[69.742965] Dynamic subtest pipe-B: SUCCESS (1.283s)
[69.752101] Starting dynamic subtest: pipe-C
[71.063983] Dynamic subtest pipe-C: SUCCESS (1.320s)
[71.073304] Starting dynamic subtest: pipe-D
[72.378485] Dynamic subtest pipe-D: SUCCESS (1.314s)
[72.380844] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.147s)
[73.585739] [010/133] (939s left) perf_pmu (busy-check-all)
[73.633467] Starting subtest: busy-check-all
[73.635711] Starting dynamic subtest: rcs0
[74.197710] Dynamic subtest rcs0: SUCCESS (0.565s)
[74.208278] Starting dynamic subtest: bcs0
[74.747829] Dynamic subtest bcs0: SUCCESS (0.549s)
[74.758713] Starting dynamic subtest: vcs0
[75.927577] Dynamic subtest vcs0: SUCCESS (1.177s)
[75.938424] Starting dynamic subtest: vcs1
[77.910239] Dynamic subtest vcs1: SUCCESS (1.982s)
[77.920062] Starting dynamic subtest: vecs0
[79.894505] Dynamic subtest vecs0: SUCCESS (1.983s)
[79.906742] Starting dynamic subtest: ccs0
[80.448544] Dynamic subtest ccs0: SUCCESS (0.555s)
[80.451098] Subtest busy-check-all: SUCCESS (6.816s)
[80.536340] [011/133] (932s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[80.659713] Starting subtest: x-tiled-64bpp-rotate-180
[82.261696] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.601s)
[82.405786] [012/133] (930s left) gem_exec_params (no-blt)
[82.469807] Starting subtest: no-blt
[82.472215] Subtest no-blt: SUCCESS (0.002s)
[82.586676] [013/133] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[82.688650] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[82.692146] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[82.805279] [014/133] (930s left) kms_cursor_edge_walk (64x64-right-edge)
[82.890203] Starting subtest: 64x64-right-edge
[82.892125] Starting dynamic subtest: pipe-A-eDP-1
[86.331556] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s)
[86.341119] Starting dynamic subtest: pipe-D-eDP-1
[89.449766] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[89.451712] Subtest 64x64-right-edge: SUCCESS (6.558s)
[90.258258] [015/133] (922s left) gem_mmap_gtt (hang)
[90.323606] Subtest hang: SKIP (0.000s)
[90.385606] [016/133] (922s left) kms_psr (fbc-psr-sprite-blt)
[90.479327] Starting subtest: fbc-psr-sprite-blt
[90.481293] Starting dynamic subtest: eDP-1
[90.485474] Dynamic subtest eDP-1: SKIP (0.000s)
[90.489646] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[90.575244] [017/133] (922s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[90.663742] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[90.666120] Starting dynamic subtest: pipe-A-default-mode
[91.839845] Dynamic subtest pipe-A-default-mode: SKIP (1.173s)
[91.844342] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.175s)
[91.983599] [018/133] (921s left) gem_pwrite (basic-exhaustion)
[92.062267] Subtest basic-exhaustion: SKIP (0.000s)
[92.118325] [019/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[92.217589] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[96.788282] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.572s)
[97.991774] [020/133] (915s left) kms_big_fb (linear-8bpp-rotate-270)
[98.100579] Starting subtest: linear-8bpp-rotate-270
[98.121782] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[98.234224] [021/133] (915s left) vgem_basic (second-client)
[98.323591] Starting subtest: second-client
[98.345332] Subtest second-client: SUCCESS (0.022s)
[98.398109] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[98.401186] [022/133] (914s left) gem_mmap (short-mmap)
[98.459767] Subtest short-mmap: SKIP (0.000s)
[98.519605] [023/133] (914s left) kms_hdr (bpc-switch-suspend)
[98.607558] Starting subtest: bpc-switch-suspend
[99.653382] Starting dynamic subtest: pipe-A-eDP-1
[118.860801] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.456s)
[118.863281] Subtest bpc-switch-suspend: SUCCESS (6.504s)
[118.979166] [024/133] (894s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[119.077134] Starting subtest: stress-xrgb8888-xtiled
[124.967924] Subtest stress-xrgb8888-xtiled: SUCCESS (5.891s)
[125.015211] [025/133] (888s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[125.068315] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[125.070291] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[125.169472] [026/133] (888s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[125.260245] Starting subtest: plane-ctm3x4-lut1d
[125.406538] Starting dynamic subtest: pipe-A-plane-0
[125.573136] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[125.582408] Starting dynamic subtest: pipe-A-plane-1
[125.740051] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[125.748684] Starting dynamic subtest: pipe-A-plane-2
[125.906257] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[127.133899] Starting dynamic subtest: pipe-B-plane-0
[127.304659] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[127.313605] Starting dynamic subtest: pipe-B-plane-1
[127.471466] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[127.480155] Starting dynamic subtest: pipe-B-plane-2
[127.637915] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[128.839950] Starting dynamic subtest: pipe-C-plane-0
[128.977448] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[128.986828] Starting dynamic subtest: pipe-C-plane-1
[129.121753] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[129.131179] Starting dynamic subtest: pipe-C-plane-2
[129.266297] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[130.477662] Starting dynamic subtest: pipe-D-plane-0
[130.615264] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[130.626361] Starting dynamic subtest: pipe-D-plane-1
[130.759612] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[130.769064] Starting dynamic subtest: pipe-D-plane-2
[130.903937] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[131.205799] Subtest plane-ctm3x4-lut1d: SUCCESS (5.945s)
[132.061892] [027/133] (881s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[132.155465] Starting subtest: addfb25-yf-tiled-legacy
[132.157775] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[132.255363] [028/133] (881s left) kms_chamelium_edid (dp-mode-timings)
[132.648199] Subtest dp-mode-timings: SKIP (0.000s)
[133.470781] [029/133] (880s left) gem_lmem_swapping (parallel-random-verify-ccs)
[133.515618] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[133.570972] [030/133] (880s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[133.664978] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[133.667318] Starting dynamic subtest: pipe-A-eDP-1
[133.676060] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[133.685968] Starting dynamic subtest: pipe-B-eDP-1
[133.694628] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[133.703646] Starting dynamic subtest: pipe-C-eDP-1
[133.712036] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[133.723924] Starting dynamic subtest: pipe-D-eDP-1
[133.732397] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[133.736503] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[135.863755] [031/133] (877s left) gem_exec_balancer (busy)
[135.934490] Starting subtest: busy
[137.677571] Subtest busy: SUCCESS (1.741s)
[137.986444] [032/133] (875s left) kms_cursor_crc (cursor-onscreen-64x21)
[138.187168] Starting subtest: cursor-onscreen-64x21
[138.237756] Subtest cursor-onscreen-64x21: SKIP (0.045s)
[138.461455] [033/133] (875s left) kms_plane_multiple (2x-tiling-yf)
[138.571387] Starting subtest: 2x-tiling-yf
[138.575388] Subtest 2x-tiling-yf: SKIP (0.000s)
[138.643263] [034/133] (875s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[138.706733] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[138.808743] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[138.897608] [035/133] (874s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[138.986361] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[142.998285] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.013s)
[144.183075] [036/133] (869s left) gem_mmap_wc (coherency)
[144.249564] Subtest coherency: SKIP (0.000s)
[144.304512] [037/133] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[144.393389] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[144.398609] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[144.510913] [038/133] (869s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[144.616805] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[144.621161] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[144.704743] [039/133] (869s left) gem_eio (wait-wedge-10ms)
[144.938190] Starting subtest: wait-wedge-10ms
[146.769671] Subtest wait-wedge-10ms: SUCCESS (1.829s)
[146.910241] [040/133] (867s left) perf_pmu (semaphore-busy)
[146.954060] Starting subtest: semaphore-busy
[146.956407] Starting dynamic subtest: rcs0
[148.591176] Dynamic subtest rcs0: SUCCESS (1.632s)
[148.602268] Starting dynamic subtest: bcs0
[150.224065] Dynamic subtest bcs0: SUCCESS (1.630s)
[150.235543] Starting dynamic subtest: vcs0
[154.184271] Dynamic subtest vcs0: SUCCESS (3.957s)
[154.195512] Starting dynamic subtest: vcs1
[160.203270] Dynamic subtest vcs1: SUCCESS (6.015s)
[160.214561] Starting dynamic subtest: vecs0
[166.151774] Dynamic subtest vecs0: SUCCESS (5.945s)
[166.163340] Starting dynamic subtest: ccs0
[169.292079] Dynamic subtest ccs0: SUCCESS (3.137s)
[169.294556] Subtest semaphore-busy: SUCCESS (22.333s)
[169.424110] [041/133] (844s left) gem_exec_whisper (basic-contexts-all)
[169.495842] Starting subtest: basic-contexts-all
[181.401899] Subtest basic-contexts-all: SUCCESS (11.902s)
[181.586769] [042/133] (832s left) gem_pxp (reject-modify-context-protection-on)
[181.711965] Starting subtest: reject-modify-context-protection-on
[181.714873] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[181.818854] [043/133] (832s left) gem_exec_params (sol-reset-not-gen7)
[181.879845] Starting subtest: sol-reset-not-gen7
[181.885287] Subtest sol-reset-not-gen7: SUCCESS (0.005s)
[181.993499] [044/133] (832s left) kms_pm_rpm (pm-caching)
[183.821751] Starting subtest: pm-caching
[183.826445] Subtest pm-caching: SKIP (0.000s)
[184.217748] [045/133] (830s left) api_intel_bb (bb-with-allocator)
[184.281927] Starting subtest: bb-with-allocator
[184.284492] Subtest bb-with-allocator: SUCCESS (0.005s)
[184.376473] [046/133] (829s left) gem_exec_reloc (basic-concurrent16)
[184.426316] Subtest basic-concurrent16: SKIP (0.000s)
[184.496511] [047/133] (829s left) gem_exec_whisper (basic-queues-priority)
[184.548111] Starting subtest: basic-queues-priority
[208.062118] Subtest basic-queues-priority: SUCCESS (23.508s)
[208.259027] [048/133] (806s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[208.387179] Starting subtest: flip-vs-cursor-busy-crc-legacy
[209.189492] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.803s)
[210.037773] [049/133] (804s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[210.146107] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[211.190640] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.046s)
[211.313899] [050/133] (803s left) kms_big_fb (yf-tiled-addfb)
[211.422484] Starting subtest: yf-tiled-addfb
[211.426260] Subtest yf-tiled-addfb: SKIP (0.000s)
[211.517176] [051/133] (803s left) vgem_basic (bad-handle)
[211.565440] Starting subtest: bad-handle
[211.567314] Subtest bad-handle: SUCCESS (0.000s)
[211.628701] [052/133] (802s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[211.721308] Starting subtest: fbc-pr-cursor-mmap-gtt
[211.724908] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[211.795475] [053/133] (802s left) drm_read (short-buffer-wakeup)
[211.936144] Starting subtest: short-buffer-wakeup
[244.154430] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[244.311159] [054/133] (770s left) kms_pm_rpm (basic-pci-d3-state)
[245.839264] Starting subtest: basic-pci-d3-state
[247.310965] Subtest basic-pci-d3-state: SUCCESS (1.471s)
[247.412671] [055/133] (767s left) kms_plane (pixel-format-4-tiled-modifier)
[247.518098] Starting subtest: pixel-format-4-tiled-modifier
[247.543978] Starting dynamic subtest: pipe-A-plane-0
[248.211451] Dynamic subtest pipe-A-plane-0: SUCCESS (0.667s)
[248.222520] Starting dynamic subtest: pipe-A-plane-3
[248.676710] Dynamic subtest pipe-A-plane-3: SUCCESS (0.465s)
[248.685842] Starting dynamic subtest: pipe-A-plane-5
[248.689260] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[249.763194] Starting dynamic subtest: pipe-B-plane-0
[250.432824] Dynamic subtest pipe-B-plane-0: SUCCESS (0.677s)
[250.442638] Starting dynamic subtest: pipe-B-plane-3
[250.877038] Dynamic subtest pipe-B-plane-3: SUCCESS (0.443s)
[250.886789] Starting dynamic subtest: pipe-B-plane-5
[250.890300] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[251.185808] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.667s)
[252.031705] [056/133] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[252.139757] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[252.143932] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[252.236007] [057/133] (762s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[252.343977] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[252.346187] Starting dynamic subtest: pipe-A-eDP-1
[252.368493] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[252.379734] Starting dynamic subtest: pipe-B-eDP-1
[252.401406] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[252.410734] Starting dynamic subtest: pipe-C-eDP-1
[252.432602] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[252.442292] Starting dynamic subtest: pipe-D-eDP-1
[252.464461] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[252.468482] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[254.604876] [058/133] (760s left) gem_ctx_isolation (preservation)
[254.664372] Starting subtest: preservation
[254.666757] Starting dynamic subtest: rcs0
[254.806061] Dynamic subtest rcs0: SUCCESS (0.141s)
[254.822525] Starting dynamic subtest: bcs0
[254.963184] Dynamic subtest bcs0: SUCCESS (0.156s)
[254.973838] Starting dynamic subtest: vcs0
[255.112647] Dynamic subtest vcs0: SUCCESS (0.149s)
[255.129351] Starting dynamic subtest: vcs1
[256.778909] Dynamic subtest vcs1: SUCCESS (1.665s)
[256.790775] Starting dynamic subtest: vecs0
[258.762207] Dynamic subtest vecs0: SUCCESS (1.982s)
[258.775177] Starting dynamic subtest: ccs0
[260.756890] Dynamic subtest ccs0: SUCCESS (1.993s)
[260.759971] Subtest preservation: SUCCESS (6.092s)
[260.995227] [059/133] (753s left) kms_selftest (drm_plane_helper)
[261.035291] Starting subtest: drm_plane_helper
[261.075317] Starting dynamic subtest: drm_test_check_plane_state
[261.169256] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.096s)
[261.179609] Starting dynamic subtest: drm_test_check_invalid_plane_state
[261.278676] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.109s)
[261.280882] Subtest drm_plane_helper: SUCCESS (0.245s)
[261.456360] [060/133] (753s left) gem_exec_reloc (basic-write-cpu-noreloc)
[261.525004] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[261.609471] [061/133] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[261.706728] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[261.710785] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[261.809712] [062/133] (753s left) gen7_exec_parse (basic-rejected)
[261.878691] Subtest basic-rejected: SKIP (0.000s)
[261.963429] [063/133] (753s left) gem_spin_batch (resubmit-new-all)
[262.022035] Starting subtest: resubmit-new-all
[262.024427] Starting dynamic subtest: rcs0
[262.036292] Dynamic subtest rcs0: SUCCESS (0.014s)
[262.045863] Starting dynamic subtest: bcs0
[262.048136] Dynamic subtest bcs0: SUCCESS (0.009s)
[262.057648] Starting dynamic subtest: vcs0
[262.059927] Dynamic subtest vcs0: SUCCESS (0.009s)
[262.069728] Starting dynamic subtest: vcs1
[262.071701] Dynamic subtest vcs1: SUCCESS (0.008s)
[262.081742] Starting dynamic subtest: vecs0
[262.083961] Dynamic subtest vecs0: SUCCESS (0.008s)
[262.093308] Starting dynamic subtest: ccs0
[262.095170] Dynamic subtest ccs0: SUCCESS (0.010s)
[262.097036] Subtest resubmit-new-all: SUCCESS (0.064s)
[263.670678] [064/133] (751s left) kms_lease (lease-revoke)
[263.767678] Starting subtest: lease-revoke
[263.769988] Starting dynamic subtest: pipe-A-eDP-1
[263.800079] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[263.812119] Starting dynamic subtest: pipe-B-eDP-1
[263.826332] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[263.839280] Starting dynamic subtest: pipe-C-eDP-1
[263.859796] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.030s)
[263.871215] Starting dynamic subtest: pipe-D-eDP-1
[263.889601] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.031s)
[263.892014] Subtest lease-revoke: SUCCESS (0.125s)
[264.039358] [065/133] (751s left) kms_flip (2x-flip-vs-modeset)
[264.125651] Starting subtest: 2x-flip-vs-modeset
[264.135104] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[264.218112] [066/133] (750s left) tools_test (sysfs_l3_parity)
[264.270462] Starting subtest: sysfs_l3_parity
[264.349813] Subtest sysfs_l3_parity: SKIP (0.091s)
[264.404922] [067/133] (750s left) gem_eio (in-flight-internal-10ms)
[264.629203] Starting subtest: in-flight-internal-10ms
[265.750249] Subtest in-flight-internal-10ms: SUCCESS (1.118s)
[265.914117] [068/133] (749s left) kms_cursor_crc (cursor-random-512x170)
[266.228609] Starting subtest: cursor-random-512x170
[266.232908] Subtest cursor-random-512x170: SKIP (0.001s)
[266.368488] [069/133] (748s left) gem_wait (write-wait)
[266.428738] Starting subtest: write-wait
[266.430701] Starting dynamic subtest: all-engines
[267.514518] Dynamic subtest all-engines: SUCCESS (1.088s)
[267.532423] Starting dynamic subtest: rcs0
[268.573260] Dynamic subtest rcs0: SUCCESS (1.057s)
[268.590990] Starting dynamic subtest: bcs0
[269.632939] Dynamic subtest bcs0: SUCCESS (1.057s)
[269.650626] Starting dynamic subtest: vcs0
[270.685831] Dynamic subtest vcs0: SUCCESS (1.051s)
[270.703111] Starting dynamic subtest: vcs1
[271.739155] Dynamic subtest vcs1: SUCCESS (1.051s)
[271.753996] Starting dynamic subtest: vecs0
[272.790456] Dynamic subtest vecs0: SUCCESS (1.049s)
[272.808103] Starting dynamic subtest: ccs0
[273.848825] Dynamic subtest ccs0: SUCCESS (1.056s)
[273.851702] Subtest write-wait: SUCCESS (7.423s)
[274.052547] [070/133] (741s left) kms_flip (dpms-off-confusion)
[274.165579] Starting subtest: dpms-off-confusion
[274.167949] Starting dynamic subtest: A-eDP1
[282.808674] Dynamic subtest A-eDP1: SUCCESS (8.642s)
[282.822925] Starting dynamic subtest: B-eDP1
[291.450111] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[291.462092] Starting dynamic subtest: C-eDP1
[300.076087] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[300.089378] Starting dynamic subtest: D-eDP1
[308.709429] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[308.714347] Subtest dpms-off-confusion: SUCCESS (34.546s)
[309.872162] [071/133] (705s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[309.982282] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[309.984566] Starting dynamic subtest: pipe-A-eDP-1
[310.004575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[310.016039] Starting dynamic subtest: pipe-B-eDP-1
[310.035930] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[310.045672] Starting dynamic subtest: pipe-C-eDP-1
[310.064361] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[310.073799] Starting dynamic subtest: pipe-D-eDP-1
[310.092730] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[310.094899] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[312.238703] [072/133] (703s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[312.349774] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[312.354180] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[312.455657] [073/133] (703s left) gem_ctx_persistence (heartbeat-many)
[312.522981] Starting subtest: heartbeat-many
[312.527550] Subtest heartbeat-many: SKIP (0.000s)
[312.636617] [074/133] (702s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[314.773273] Starting subtest: gem-execbuf-stress-pc8
[314.817856] Subtest gem-execbuf-stress-pc8: SKIP (0.042s)
[315.160719] [075/133] (700s left) gem_exec_fence (basic-wait)
[315.339995] Starting subtest: basic-wait
[315.342780] Starting dynamic subtest: rcs0
[315.422433] Dynamic subtest rcs0: SUCCESS (0.082s)
[315.434841] Starting dynamic subtest: bcs0
[315.478582] Dynamic subtest bcs0: SUCCESS (0.053s)
[315.490958] Starting dynamic subtest: vcs0
[315.532786] Dynamic subtest vcs0: SUCCESS (0.052s)
[315.547245] Starting dynamic subtest: vcs1
[315.587632] Dynamic subtest vcs1: SUCCESS (0.052s)
[315.599873] Starting dynamic subtest: vecs0
[315.639462] Dynamic subtest vecs0: SUCCESS (0.050s)
[315.653755] Starting dynamic subtest: ccs0
[315.697798] Dynamic subtest ccs0: SUCCESS (0.056s)
[315.700442] Subtest basic-wait: SUCCESS (0.360s)
[317.719581] [076/133] (697s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[317.839829] Starting subtest: 2x-cursor-vs-flip-atomic
[317.844427] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[317.989237] [077/133] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[318.087506] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[318.091990] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[318.179633] [078/133] (697s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[318.238001] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[318.295576] [079/133] (697s left) gen9_exec_parse (unaligned-access)
[318.354116] Subtest unaligned-access: SKIP (0.000s)
[318.422055] [080/133] (697s left) kms_properties (invalid-properties-atomic)
[318.506866] Starting subtest: invalid-properties-atomic
[318.821003] Subtest invalid-properties-atomic: SUCCESS (0.314s)
[318.897704] [081/133] (696s left) gem_ctx_shared (q-in-order)
[318.956526] Starting subtest: Q-in-order
[318.958928] Starting dynamic subtest: rcs0
[319.068765] Dynamic subtest rcs0: SUCCESS (0.111s)
[319.089418] Starting dynamic subtest: vcs0
[319.155160] Dynamic subtest vcs0: SUCCESS (0.085s)
[319.171244] Starting dynamic subtest: vcs1
[319.231681] Dynamic subtest vcs1: SUCCESS (0.076s)
[319.249047] Starting dynamic subtest: vecs0
[319.317711] Dynamic subtest vecs0: SUCCESS (0.085s)
[319.335666] Starting dynamic subtest: ccs0
[319.410147] Dynamic subtest ccs0: SUCCESS (0.092s)
[319.412677] Subtest Q-in-order: SUCCESS (0.453s)
[320.739151] [082/133] (695s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[320.848620] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[320.852891] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[320.934038] [083/133] (694s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[321.018938] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[321.021168] Starting dynamic subtest: pipe-A-eDP-1
[321.765765] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[321.777356] Starting dynamic subtest: pipe-B-eDP-1
[323.589887] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.822s)
[323.601094] Starting dynamic subtest: pipe-C-eDP-1
[325.431827] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.841s)
[325.443065] Starting dynamic subtest: pipe-D-eDP-1
[327.261799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.828s)
[327.263785] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.236s)
[328.393612] [084/133] (687s left) kms_feature_discovery (chamelium)
[328.478671] Starting subtest: chamelium
[328.482910] Subtest chamelium: SKIP (0.000s)
[328.567010] [085/133] (687s left) gem_ctx_engines (none)
[328.643251] Starting subtest: none
[328.645676] Subtest none: SUCCESS (0.001s)
[328.832407] [086/133] (687s left) kms_flip (dpms-vs-vblank-race-interruptible)
[328.928283] Starting subtest: dpms-vs-vblank-race-interruptible
[328.930529] Starting dynamic subtest: A-eDP1
[333.863005] Dynamic subtest A-eDP1: SUCCESS (4.931s)
[333.873798] Starting dynamic subtest: B-eDP1
[338.487928] Dynamic subtest B-eDP1: SUCCESS (4.621s)
[338.498644] Starting dynamic subtest: C-eDP1
[343.112314] Dynamic subtest C-eDP1: SUCCESS (4.623s)
[343.123417] Starting dynamic subtest: D-eDP1
[347.764924] Dynamic subtest D-eDP1: SUCCESS (4.651s)
[347.770503] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.841s)
[348.635862] [087/133] (667s left) api_intel_bb (simple-bb-ctx)
[348.705744] Starting subtest: simple-bb-ctx
[348.712669] Subtest simple-bb-ctx: SUCCESS (0.008s)
[348.846103] [088/133] (667s left) gem_fenced_exec_thrash (too-many-fences)
[348.905530] Subtest too-many-fences: SKIP (0.000s)
[348.988466] [089/133] (667s left) gem_exec_schedule (semaphore-resolve)
[349.058952] Starting subtest: semaphore-resolve
[349.088557] Subtest semaphore-resolve: SUCCESS (0.038s)
[349.429274] [090/133] (666s left) kms_psr (pr-no-drrs)
[349.530246] Starting subtest: pr-no-drrs
[349.534624] Subtest pr-no-drrs: SKIP (0.000s)
[349.611790] [091/133] (666s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[349.703464] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[349.707895] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[349.812797] [092/133] (666s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[349.916674] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[349.918865] Starting dynamic subtest: pipe-A-eDP-1
[350.013108] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[350.025306] Starting dynamic subtest: pipe-B-eDP-1
[351.206063] Dynamic subtest pipe-B-eDP-1: SKIP (1.191s)
[351.210715] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.294s)
[352.393972] [093/133] (663s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[352.925918] Starting subtest: syncobj-stationary-timeline-chain-engines
[353.053772] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.128s)
[354.737175] [094/133] (661s left) kms_dp_link_training (non-uhbr-mst)
[354.825179] Starting subtest: non-uhbr-mst
[354.834178] Subtest non-uhbr-mst: SKIP (0.000s)
[354.909649] [095/133] (661s left) gem_userptr_blits (create-destroy-sync)
[354.982358] Starting subtest: create-destroy-sync
[359.997273] Subtest create-destroy-sync: SUCCESS (5.016s)
[360.117550] [096/133] (656s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[360.180195] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[360.182537] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[360.291796] [097/133] (656s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[360.400375] Starting subtest: 2x-plain-flip-ts-check-interruptible
[360.412811] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[360.508283] [098/133] (656s left) kms_psr (psr2-primary-blt)
[360.604933] Starting subtest: psr2-primary-blt
[360.607187] Starting dynamic subtest: eDP-1
[362.371804] Dynamic subtest eDP-1: SUCCESS (1.766s)
[362.373990] Subtest psr2-primary-blt: SUCCESS (1.767s)
[363.241438] [099/133] (653s left) i915_pm_rps (waitboost)
[363.313809] Starting subtest: waitboost
[369.408966] Subtest waitboost: SUCCESS (6.094s)
[369.523413] [100/133] (647s left) perf_pmu (rc6)
[369.561633] Starting subtest: rc6
[369.563801] Starting dynamic subtest: gt0
[375.919589] Dynamic subtest gt0: SUCCESS (6.357s)
[375.933402] Starting dynamic subtest: runtime-pm-gt0
[383.688936] Dynamic subtest runtime-pm-gt0: SUCCESS (7.766s)
[383.702091] Starting dynamic subtest: runtime-pm-long-gt0
[396.126080] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.434s)
[396.139062] Starting dynamic subtest: other-idle-gt0
[402.468293] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[402.482013] Starting dynamic subtest: gt1
[408.810142] Dynamic subtest gt1: SUCCESS (6.338s)
[408.823264] Starting dynamic subtest: runtime-pm-gt1
[416.331769] Dynamic subtest runtime-pm-gt1: SUCCESS (7.519s)
[416.344518] Starting dynamic subtest: runtime-pm-long-gt1
[428.767278] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.433s)
[428.780820] Starting dynamic subtest: other-idle-gt1
[435.110943] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[435.114063] Subtest rc6: SUCCESS (65.547s)
[436.274216] [101/133] (580s left) sw_sync (timeline_closed_signaled)
[436.325446] Starting subtest: timeline_closed_signaled
[436.327358] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[436.368239] [102/133] (580s left) kms_atomic (test-only)
[436.472777] Starting subtest: test-only
[436.524011] Starting dynamic subtest: pipe-A-eDP-1
[439.094280] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.571s)
[439.096568] Subtest test-only: SUCCESS (2.622s)
[439.938914] [103/133] (576s left) kms_psr (fbc-pr-sprite-plane-onoff)
[440.049314] Starting subtest: fbc-pr-sprite-plane-onoff
[440.053743] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[440.106078] [104/133] (576s left) gem_fence_thrash (bo-write-verify-x)
[440.142865] Starting subtest: bo-write-verify-x
[440.160447] Subtest bo-write-verify-x: SKIP (0.017s)
[440.221638] [105/133] (576s left) perf_pmu (busy-hang)
[440.273243] Starting subtest: busy-hang
[440.275408] Starting dynamic subtest: rcs0
[441.557332] Dynamic subtest rcs0: SUCCESS (1.283s)
[441.568726] Starting dynamic subtest: bcs0
[442.792103] Dynamic subtest bcs0: SUCCESS (1.236s)
[442.803891] Starting dynamic subtest: vcs0
[445.197499] Dynamic subtest vcs0: SUCCESS (2.403s)
[445.207951] Starting dynamic subtest: vcs1
[447.181590] Dynamic subtest vcs1: SUCCESS (1.982s)
[447.193922] Starting dynamic subtest: vecs0
[449.168155] Dynamic subtest vecs0: SUCCESS (1.982s)
[449.180082] Starting dynamic subtest: ccs0
[450.397675] Dynamic subtest ccs0: SUCCESS (1.230s)
[450.400327] Subtest busy-hang: SUCCESS (10.127s)
[450.487939] [106/133] (566s left) gem_exec_suspend (basic)
[450.560575] Starting subtest: basic
[450.562906] Starting dynamic subtest: smem
[452.685799] Dynamic subtest smem: SUCCESS (2.123s)
[452.689038] Subtest basic: SUCCESS (2.125s)
[452.853481] [107/133] (564s left) sw_sync (alloc_fence)
[452.886558] Starting subtest: alloc_fence
[452.888715] Subtest alloc_fence: SUCCESS (0.000s)
[452.928761] [108/133] (564s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[453.033550] Starting subtest: psr-rgb101010-draw-pwrite
[460.802125] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.771s)
[460.882535] [109/133] (556s left) testdisplay
[461.162274] [110/133] (555s left) gem_eio (wait-immediate)
[461.400160] Starting subtest: wait-immediate
[461.801700] Subtest wait-immediate: SUCCESS (0.402s)
[461.893019] [111/133] (555s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[461.983009] Starting subtest: psr-1p-pri-indfb-multidraw
[484.844232] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.862s)
[484.927739] [112/133] (532s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[484.997374] Starting subtest: invalid-multi-wait-unsubmitted
[484.999339] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[485.079177] [113/133] (532s left) gem_ccs (block-copy-compressed)
[485.133327] Starting subtest: block-copy-compressed
[485.136961] Subtest block-copy-compressed: SKIP (0.000s)
[485.205134] [114/133] (532s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[485.305757] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[489.085096] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.782s)
[490.226260] [115/133] (527s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[490.341064] Starting subtest: y-tiled-8bpp-rotate-270
[490.345525] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[490.418730] [116/133] (526s left) syncobj_timeline (single-wait-all-signaled)
[490.480528] Starting subtest: single-wait-all-signaled
[490.482703] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[490.554715] [117/133] (526s left) kms_addfb_basic (invalid-get-prop)
[490.616963] Starting subtest: invalid-get-prop
[490.619381] Subtest invalid-get-prop: SUCCESS (0.000s)
[490.735998] [118/133] (526s left) gem_render_copy (y-tiled-to-vebox-linear)
[490.793717] Starting subtest: y-tiled-to-vebox-linear
[490.798212] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[490.956650] [119/133] (526s left) kms_busy (extended-pageflip-hang-oldfb)
[491.053623] Starting subtest: extended-pageflip-hang-oldfb
[491.055920] Starting dynamic subtest: pipe-A
[491.449625] Dynamic subtest pipe-A: SUCCESS (0.394s)
[491.461072] Starting dynamic subtest: pipe-D
[492.550180] Dynamic subtest pipe-D: SUCCESS (1.099s)
[492.552515] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.498s)
[493.365675] [120/133] (524s left) kms_vblank (ts-continuation-idle-hang)
[493.464291] Starting subtest: ts-continuation-idle-hang
[493.466537] Starting dynamic subtest: pipe-A-eDP-1
[519.503105] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.036s)
[519.518875] Starting dynamic subtest: pipe-D-eDP-1
[534.411015] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.904s)
[534.413016] Subtest ts-continuation-idle-hang: SUCCESS (40.945s)
[535.226799] [121/133] (482s left) kms_scaling_modes (scaling-mode-full)
[535.315682] Starting subtest: scaling-mode-full
[535.318108] Starting dynamic subtest: pipe-A-eDP-1
[535.412774] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[535.426022] Starting dynamic subtest: pipe-B-eDP-1
[536.563461] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.149s)
[536.578021] Starting dynamic subtest: pipe-C-eDP-1
[537.702867] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.136s)
[537.713445] Starting dynamic subtest: pipe-D-eDP-1
[538.818853] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.115s)
[538.821146] Subtest scaling-mode-full: SUCCESS (3.504s)
[539.964572] [122/133] (477s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[540.022191] Starting subtest: etime-single-wait-for-submit-unsubmitted
[540.129489] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[540.186251] [123/133] (477s left) kms_content_protection (dp-mst-type-0)
[540.328151] Starting subtest: dp-mst-type-0
[540.332102] Subtest dp-mst-type-0: SKIP (0.000s)
[540.435359] [124/133] (477s left) gem_exec_schedule (preempt-hang)
[540.618000] Starting subtest: preempt-hang
[540.620283] Starting dynamic subtest: rcs0
[540.832653] Dynamic subtest rcs0: SUCCESS (0.216s)
[540.844272] Starting dynamic subtest: bcs0
[541.051995] Dynamic subtest bcs0: SUCCESS (0.218s)
[541.063878] Starting dynamic subtest: vcs0
[541.288598] Dynamic subtest vcs0: SUCCESS (0.235s)
[541.301275] Starting dynamic subtest: vcs1
[541.552276] Dynamic subtest vcs1: SUCCESS (0.261s)
[541.564663] Starting dynamic subtest: vecs0
[541.789245] Dynamic subtest vecs0: SUCCESS (0.236s)
[541.802412] Starting dynamic subtest: ccs0
[542.016787] Dynamic subtest ccs0: SUCCESS (0.227s)
[542.019046] Subtest preempt-hang: SUCCESS (1.401s)
[542.736572] [125/133] (474s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[542.833539] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[550.088349] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.259s)
[550.194162] [126/133] (467s left) gem_sync (basic-many-each)
[550.265167] Starting subtest: basic-many-each
[552.553750] Subtest basic-many-each: SUCCESS (2.298s)
[552.721843] [127/133] (465s left) gem_userptr_blits (coherency-unsync)
[552.782698] Subtest coherency-unsync: SKIP (0.000s)
[552.887707] [128/133] (464s left) syncobj_wait (multi-wait-all-signaled)
[552.935480] Starting subtest: multi-wait-all-signaled
[552.937818] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[553.017023] [129/133] (464s left) syncobj_wait (invalid-signal-one-illegal-handle)
[553.068141] Starting subtest: invalid-signal-one-illegal-handle
[553.070387] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[553.140039] [130/133] (464s left) gem_mmap_offset (clear)
[553.194515] Starting subtest: clear
[553.197047] Starting dynamic subtest: smem0
[577.616594] Dynamic subtest smem0: SUCCESS (24.417s)
[577.619110] Subtest clear: SUCCESS (24.418s)
[577.723689] [131/133] (440s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[577.874061] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[577.878408] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[577.957490] [132/133] (440s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[578.053440] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[578.055705] Starting dynamic subtest: pipe-A
[578.116353] Dynamic subtest pipe-A: SUCCESS (0.065s)
[578.127156] Starting dynamic subtest: pipe-B
[579.229609] Dynamic subtest pipe-B: SUCCESS (1.112s)
[579.246060] Starting dynamic subtest: pipe-C
[580.347518] Dynamic subtest pipe-C: SUCCESS (1.117s)
[580.361192] Starting dynamic subtest: pipe-D
[581.484803] Dynamic subtest pipe-D: SUCCESS (1.136s)
[581.487304] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.434s)
[582.630629] [133/133] (435s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[582.735886] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[583.437671] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.703s)
[583.554710] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_joiner
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_cursor_edge_walk
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: gem_pwrite
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: vgem_basic
results: parsing output: 21/ for test: gem_mmap
results: parsing output: 22/ for test: kms_hdr
results: parsing output: 23/ for test: kms_pipe_stress
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_color_pipeline
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_chamelium_edid
results: parsing output: 28/ for test: gem_lmem_swapping
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_exec_balancer
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: kms_plane_multiple
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_mmap_wc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: gem_exec_whisper
results: parsing output: 41/ for test: gem_pxp
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: kms_pm_rpm
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: gem_exec_whisper
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: vgem_basic
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: drm_read
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_ctx_isolation
results: parsing output: 58/ for test: kms_selftest
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gen7_exec_parse
results: parsing output: 62/ for test: gem_spin_batch
results: parsing output: 63/ for test: kms_lease
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: tools_test
results: parsing output: 66/ for test: gem_eio
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: gem_wait
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: i915_pm_rpm
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pipe_b_c_ivb
results: parsing output: 78/ for test: gen9_exec_parse
results: parsing output: 79/ for test: kms_properties
results: parsing output: 80/ for test: gem_ctx_shared
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_feature_discovery
results: parsing output: 84/ for test: gem_ctx_engines
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: api_intel_bb
results: parsing output: 87/ for test: gem_fenced_exec_thrash
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_dp_link_training
results: parsing output: 94/ for test: gem_userptr_blits
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: i915_pm_rps
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: sw_sync
results: parsing output: 101/ for test: kms_atomic
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_fence_thrash
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_exec_suspend
results: parsing output: 106/ for test: sw_sync
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: testdisplay
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_ccs
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: kms_vblank
results: parsing output: 120/ for test: kms_scaling_modes
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_sync
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_mmap_offset
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: kms_big_fb
Done.