[57.297564] Initializing watchdogs
[57.297686]   /dev/watchdog0
[57.312679] [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]
[57.317188] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.319631] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.322985] [001/133] (960s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[57.449028] Starting subtest: flip-vs-dpms-on-nop-interruptible
[57.451397] Starting dynamic subtest: A-eDP1
[59.361661] Dynamic subtest A-eDP1: SUCCESS (1.929s)
[59.371658] Starting dynamic subtest: B-eDP1
[61.195554] Dynamic subtest B-eDP1: SUCCESS (1.830s)
[61.203069] Starting dynamic subtest: C-eDP1
[62.984283] Dynamic subtest C-eDP1: SUCCESS (1.813s)
[62.991812] Starting dynamic subtest: D-eDP1
[64.810496] Dynamic subtest D-eDP1: SUCCESS (1.834s)
[64.812933] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.415s)
[65.977255] [002/133] (951s left) kms_joiner (invalid-modeset-big-joiner)
[66.079110] Starting subtest: invalid-modeset-big-joiner
[66.083852] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[66.143769] [003/133] (951s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[66.516276] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[67.297803] [004/133] (950s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[67.659229] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[67.663746] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[67.944788] [005/133] (950s left) gem_exec_params (batch-first)
[68.112252] Starting subtest: batch-first
[68.114734] Subtest batch-first: SUCCESS (0.005s)
[68.223985] [006/133] (949s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[68.307814] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[68.310197] Starting dynamic subtest: pipe-A-eDP-1
[68.333280] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.342882] Starting dynamic subtest: pipe-B-eDP-1
[68.365042] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.373948] Starting dynamic subtest: pipe-C-eDP-1
[68.394589] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.401729] Starting dynamic subtest: pipe-D-eDP-1
[68.423527] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.427708] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[70.556184] [007/133] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[70.653383] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[70.657643] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[70.755336] [008/133] (947s left) i915_drm_fdinfo (virtual-idle)
[70.801963] Starting subtest: virtual-idle
[73.868458] Subtest virtual-idle: SUCCESS (3.069s)
[73.941955] [009/133] (944s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[74.036934] Starting subtest: plane-scaler-unity-scaling-with-rotation
[74.038955] Starting dynamic subtest: pipe-A
[74.273933] Dynamic subtest pipe-A: SUCCESS (0.239s)
[74.282206] Starting dynamic subtest: pipe-B
[75.534405] Dynamic subtest pipe-B: SUCCESS (1.261s)
[75.543925] Starting dynamic subtest: pipe-C
[76.873270] Dynamic subtest pipe-C: SUCCESS (1.340s)
[76.882882] Starting dynamic subtest: pipe-D
[78.216099] Dynamic subtest pipe-D: SUCCESS (1.343s)
[78.218473] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.185s)
[79.447409] [010/133] (938s left) perf_pmu (busy-check-all)
[79.514932] Starting subtest: busy-check-all
[79.517061] Starting dynamic subtest: rcs0
[80.064688] Dynamic subtest rcs0: SUCCESS (0.551s)
[80.075352] Starting dynamic subtest: bcs0
[80.614065] Dynamic subtest bcs0: SUCCESS (0.548s)
[80.624723] Starting dynamic subtest: vcs0
[81.941664] Dynamic subtest vcs0: SUCCESS (1.326s)
[81.952709] Starting dynamic subtest: vcs1
[83.928385] Dynamic subtest vcs1: SUCCESS (1.984s)
[83.938983] Starting dynamic subtest: vecs0
[85.911394] Dynamic subtest vecs0: SUCCESS (1.981s)
[85.923843] Starting dynamic subtest: ccs0
[86.464979] Dynamic subtest ccs0: SUCCESS (0.554s)
[86.467468] Subtest busy-check-all: SUCCESS (6.951s)
[86.566178] [011/133] (931s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[86.684514] Starting subtest: x-tiled-64bpp-rotate-180
[88.330339] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.646s)
[88.492638] [012/133] (929s left) gem_exec_params (no-blt)
[88.561418] Starting subtest: no-blt
[88.563640] Subtest no-blt: SUCCESS (0.002s)
[88.678629] [013/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[88.777939] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[88.781398] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[88.868939] [014/133] (929s left) kms_cursor_edge_walk (64x64-right-edge)
[88.952190] Starting subtest: 64x64-right-edge
[88.954208] Starting dynamic subtest: pipe-A-eDP-1
[92.379431] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.425s)
[92.388697] Starting dynamic subtest: pipe-D-eDP-1
[95.500839] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[95.503225] Subtest 64x64-right-edge: SUCCESS (6.548s)
[96.303965] [015/133] (922s left) gem_mmap_gtt (hang)
[96.360214] Subtest hang: SKIP (0.000s)
[96.416218] [016/133] (922s left) kms_psr (fbc-psr-sprite-blt)
[96.505985] Starting subtest: fbc-psr-sprite-blt
[96.508388] Starting dynamic subtest: eDP-1
[96.512730] Dynamic subtest eDP-1: SKIP (0.000s)
[96.517292] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[96.577294] [017/133] (921s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[96.663891] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[96.666193] Starting dynamic subtest: pipe-A-default-mode
[97.784159] Dynamic subtest pipe-A-default-mode: SKIP (1.119s)
[97.788178] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.120s)
[97.917872] [018/133] (920s left) gem_pwrite (basic-exhaustion)
[97.982448] Subtest basic-exhaustion: SKIP (0.000s)
[98.044554] [019/133] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[98.149744] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[102.849870] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.704s)
[104.069224] [020/133] (914s left) kms_big_fb (linear-8bpp-rotate-270)
[104.175316] Starting subtest: linear-8bpp-rotate-270
[104.195168] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[104.330752] [021/133] (914s left) vgem_basic (second-client)
[104.429208] Starting subtest: second-client
[104.453033] Subtest second-client: SUCCESS (0.022s)
[104.519929] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[104.523664] [022/133] (914s left) gem_mmap (short-mmap)
[104.582960] Subtest short-mmap: SKIP (0.000s)
[104.657653] [023/133] (914s left) kms_hdr (bpc-switch-suspend)
[104.738921] Starting subtest: bpc-switch-suspend
[105.815876] Starting dynamic subtest: pipe-A-eDP-1
[125.266133] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.690s)
[125.268433] Subtest bpc-switch-suspend: SUCCESS (5.767s)
[125.365408] [024/133] (893s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[125.483748] Starting subtest: stress-xrgb8888-xtiled
[131.230354] Subtest stress-xrgb8888-xtiled: SUCCESS (5.901s)
[131.284843] [025/133] (887s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[131.337645] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[131.339734] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[131.438068] [026/133] (887s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[131.537003] Starting subtest: plane-ctm3x4-lut1d
[131.680169] Starting dynamic subtest: pipe-A-plane-0
[131.854912] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[131.863294] Starting dynamic subtest: pipe-A-plane-1
[132.021726] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[132.037839] Starting dynamic subtest: pipe-A-plane-2
[132.184243] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[133.354088] Starting dynamic subtest: pipe-B-plane-0
[133.511785] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[133.521319] Starting dynamic subtest: pipe-B-plane-1
[133.676579] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[133.685796] Starting dynamic subtest: pipe-B-plane-2
[133.841576] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[135.050750] Starting dynamic subtest: pipe-C-plane-0
[135.186639] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[135.195888] Starting dynamic subtest: pipe-C-plane-1
[135.329501] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[135.338069] Starting dynamic subtest: pipe-C-plane-2
[135.482999] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[136.676717] Starting dynamic subtest: pipe-D-plane-0
[136.834788] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[136.844181] Starting dynamic subtest: pipe-D-plane-1
[136.977776] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[136.986830] Starting dynamic subtest: pipe-D-plane-2
[137.132286] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[137.418905] Subtest plane-ctm3x4-lut1d: SUCCESS (5.953s)
[138.229898] [027/133] (880s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[138.328677] Starting subtest: addfb25-yf-tiled-legacy
[138.330663] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[138.425959] [028/133] (880s left) kms_chamelium_edid (dp-mode-timings)
[138.809819] Subtest dp-mode-timings: SKIP (0.000s)
[139.615955] [029/133] (879s left) gem_lmem_swapping (parallel-random-verify-ccs)
[139.665267] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[139.710315] [030/133] (879s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[139.809821] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[139.812130] Starting dynamic subtest: pipe-A-eDP-1
[139.820819] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[139.830509] Starting dynamic subtest: pipe-B-eDP-1
[139.839155] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[139.848058] Starting dynamic subtest: pipe-C-eDP-1
[139.856921] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[139.865395] Starting dynamic subtest: pipe-D-eDP-1
[139.873779] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[139.877995] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[142.102176] [031/133] (876s left) gem_exec_balancer (busy)
[142.177410] Starting subtest: busy
[143.711846] Subtest busy: SUCCESS (1.539s)
[144.026596] [032/133] (875s left) kms_cursor_crc (cursor-onscreen-64x21)
[144.220845] Starting subtest: cursor-onscreen-64x21
[144.269071] Subtest cursor-onscreen-64x21: SKIP (0.045s)
[144.525895] [033/133] (874s left) kms_plane_multiple (2x-tiling-yf)
[144.620511] Starting subtest: 2x-tiling-yf
[144.624500] Subtest 2x-tiling-yf: SKIP (0.000s)
[144.725973] [034/133] (874s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[144.771454] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[144.880858] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.109s)
[144.959491] [035/133] (874s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[145.064647] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[149.083319] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.032s)
[150.261296] [036/133] (869s left) gem_mmap_wc (coherency)
[150.321339] Subtest coherency: SKIP (0.000s)
[150.408838] [037/133] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[150.504841] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[150.509505] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[150.613792] [038/133] (868s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[150.717164] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[150.721129] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[150.830014] [039/133] (868s left) gem_eio (wait-wedge-10ms)
[151.065527] Starting subtest: wait-wedge-10ms
[152.738589] Subtest wait-wedge-10ms: SUCCESS (1.674s)
[152.868850] [040/133] (866s left) perf_pmu (semaphore-busy)
[152.910024] Starting subtest: semaphore-busy
[152.912163] Starting dynamic subtest: rcs0
[154.552513] Dynamic subtest rcs0: SUCCESS (1.640s)
[154.564038] Starting dynamic subtest: bcs0
[156.181958] Dynamic subtest bcs0: SUCCESS (1.627s)
[156.193088] Starting dynamic subtest: vcs0
[160.214133] Dynamic subtest vcs0: SUCCESS (4.028s)
[160.225182] Starting dynamic subtest: vcs1
[166.229368] Dynamic subtest vcs1: SUCCESS (6.013s)
[166.239088] Starting dynamic subtest: vecs0
[172.182105] Dynamic subtest vecs0: SUCCESS (5.951s)
[172.194028] Starting dynamic subtest: ccs0
[175.321483] Dynamic subtest ccs0: SUCCESS (3.137s)
[175.323805] Subtest semaphore-busy: SUCCESS (22.410s)
[175.434588] [041/133] (844s left) gem_exec_whisper (basic-contexts-all)
[175.510195] Starting subtest: basic-contexts-all
[188.607173] Subtest basic-contexts-all: SUCCESS (13.098s)
[188.791723] [042/133] (830s left) gem_pxp (reject-modify-context-protection-on)
[188.911800] Starting subtest: reject-modify-context-protection-on
[188.914278] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[189.026945] [043/133] (830s left) gem_exec_params (sol-reset-not-gen7)
[189.086490] Starting subtest: sol-reset-not-gen7
[189.092932] Subtest sol-reset-not-gen7: SUCCESS (0.006s)
[189.200242] [044/133] (830s left) kms_pm_rpm (pm-caching)
[191.844105] Starting subtest: pm-caching
[191.849165] Subtest pm-caching: SKIP (0.000s)
[192.238512] [045/133] (827s left) api_intel_bb (bb-with-allocator)
[192.295618] Starting subtest: bb-with-allocator
[192.298107] Subtest bb-with-allocator: SUCCESS (0.005s)
[192.406055] [046/133] (827s left) gem_exec_reloc (basic-concurrent16)
[192.465366] Subtest basic-concurrent16: SKIP (0.000s)
[192.536780] [047/133] (827s left) gem_exec_whisper (basic-queues-priority)
[192.610594] Starting subtest: basic-queues-priority
[215.756110] Subtest basic-queues-priority: SUCCESS (23.150s)
[215.952548] [048/133] (803s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[216.086457] Starting subtest: flip-vs-cursor-busy-crc-legacy
[216.900022] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.814s)
[217.732559] [049/133] (802s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[217.839785] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[218.862552] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.024s)
[218.962808] [050/133] (800s left) kms_big_fb (yf-tiled-addfb)
[219.051292] Starting subtest: yf-tiled-addfb
[219.055004] Subtest yf-tiled-addfb: SKIP (0.000s)
[219.142050] [051/133] (800s left) vgem_basic (bad-handle)
[219.195356] Starting subtest: bad-handle
[219.197057] Subtest bad-handle: SUCCESS (0.000s)
[219.257708] [052/133] (800s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[219.339025] Starting subtest: fbc-pr-cursor-mmap-gtt
[219.342802] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[219.413926] [053/133] (800s left) drm_read (short-buffer-wakeup)
[219.561345] Starting subtest: short-buffer-wakeup
[251.788013] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[251.923666] [054/133] (768s left) kms_pm_rpm (basic-pci-d3-state)
[253.849967] Starting subtest: basic-pci-d3-state
[255.337998] Subtest basic-pci-d3-state: SUCCESS (1.491s)
[255.425915] [055/133] (764s left) kms_plane (pixel-format-4-tiled-modifier)
[255.522498] Starting subtest: pixel-format-4-tiled-modifier
[255.551052] Starting dynamic subtest: pipe-A-plane-0
[256.196791] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s)
[256.207262] Starting dynamic subtest: pipe-A-plane-3
[256.650792] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[256.662271] Starting dynamic subtest: pipe-A-plane-5
[256.666065] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[257.791616] Starting dynamic subtest: pipe-B-plane-0
[258.450270] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[258.462760] Starting dynamic subtest: pipe-B-plane-3
[258.872621] Dynamic subtest pipe-B-plane-3: SUCCESS (0.420s)
[258.882037] Starting dynamic subtest: pipe-B-plane-5
[258.885655] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[259.185445] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.661s)
[259.972659] [056/133] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[260.071308] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[260.075390] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[260.162742] [057/133] (760s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[260.258315] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[260.260453] Starting dynamic subtest: pipe-A-eDP-1
[260.282693] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[260.293445] Starting dynamic subtest: pipe-B-eDP-1
[260.314927] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[260.324405] Starting dynamic subtest: pipe-C-eDP-1
[260.345765] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[260.354788] Starting dynamic subtest: pipe-D-eDP-1
[260.376452] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[260.380406] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[262.462338] [058/133] (757s left) gem_ctx_isolation (preservation)
[262.522739] Starting subtest: preservation
[262.525144] Starting dynamic subtest: rcs0
[262.656233] Dynamic subtest rcs0: SUCCESS (0.133s)
[262.668490] Starting dynamic subtest: bcs0
[262.781016] Dynamic subtest bcs0: SUCCESS (0.124s)
[262.794551] Starting dynamic subtest: vcs0
[262.938639] Dynamic subtest vcs0: SUCCESS (0.156s)
[262.951038] Starting dynamic subtest: vcs1
[264.783110] Dynamic subtest vcs1: SUCCESS (1.844s)
[264.792715] Starting dynamic subtest: vecs0
[266.852949] Dynamic subtest vecs0: SUCCESS (2.068s)
[266.865399] Starting dynamic subtest: ccs0
[268.835674] Dynamic subtest ccs0: SUCCESS (1.982s)
[268.838293] Subtest preservation: SUCCESS (6.313s)
[269.079497] [059/133] (751s left) kms_selftest (drm_plane_helper)
[269.123194] Starting subtest: drm_plane_helper
[269.154139] Starting dynamic subtest: drm_test_check_plane_state
[269.264370] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.110s)
[269.276105] Starting dynamic subtest: drm_test_check_invalid_plane_state
[269.374884] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.110s)
[269.377069] Subtest drm_plane_helper: SUCCESS (0.251s)
[269.515605] [060/133] (750s left) gem_exec_reloc (basic-write-cpu-noreloc)
[269.571975] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[269.642399] [061/133] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[269.736651] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[269.740738] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[269.821053] [062/133] (750s left) gen7_exec_parse (basic-rejected)
[269.876709] Subtest basic-rejected: SKIP (0.000s)
[269.948810] [063/133] (750s left) gem_spin_batch (resubmit-new-all)
[269.999851] Starting subtest: resubmit-new-all
[270.002572] Starting dynamic subtest: rcs0
[270.012923] Dynamic subtest rcs0: SUCCESS (0.013s)
[270.024027] Starting dynamic subtest: bcs0
[270.026258] Dynamic subtest bcs0: SUCCESS (0.009s)
[270.035596] Starting dynamic subtest: vcs0
[270.037475] Dynamic subtest vcs0: SUCCESS (0.009s)
[270.046282] Starting dynamic subtest: vcs1
[270.048610] Dynamic subtest vcs1: SUCCESS (0.013s)
[270.058062] Starting dynamic subtest: vecs0
[270.059892] Dynamic subtest vecs0: SUCCESS (0.008s)
[270.069077] Starting dynamic subtest: ccs0
[270.071245] Dynamic subtest ccs0: SUCCESS (0.010s)
[270.073378] Subtest resubmit-new-all: SUCCESS (0.067s)
[271.752861] [064/133] (748s left) kms_lease (lease-revoke)
[271.856401] Starting subtest: lease-revoke
[271.858742] Starting dynamic subtest: pipe-A-eDP-1
[271.890503] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.033s)
[271.902307] Starting dynamic subtest: pipe-B-eDP-1
[271.915698] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[271.925380] Starting dynamic subtest: pipe-C-eDP-1
[271.945063] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[271.957504] Starting dynamic subtest: pipe-D-eDP-1
[271.978239] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.032s)
[271.980685] Subtest lease-revoke: SUCCESS (0.125s)
[272.118357] [065/133] (748s left) kms_flip (2x-flip-vs-modeset)
[272.224534] Starting subtest: 2x-flip-vs-modeset
[272.237536] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[272.314056] [066/133] (748s left) tools_test (sysfs_l3_parity)
[272.363238] Starting subtest: sysfs_l3_parity
[272.425856] Subtest sysfs_l3_parity: SKIP (0.074s)
[272.482366] [067/133] (748s left) gem_eio (in-flight-internal-10ms)
[272.708081] Starting subtest: in-flight-internal-10ms
[273.772604] Subtest in-flight-internal-10ms: SUCCESS (1.062s)
[273.887100] [068/133] (746s left) kms_cursor_crc (cursor-random-512x170)
[274.184242] Starting subtest: cursor-random-512x170
[274.188056] Subtest cursor-random-512x170: SKIP (0.001s)
[274.339871] [069/133] (746s left) gem_wait (write-wait)
[274.409986] Starting subtest: write-wait
[274.412406] Starting dynamic subtest: all-engines
[275.517283] Dynamic subtest all-engines: SUCCESS (1.106s)
[275.533677] Starting dynamic subtest: rcs0
[276.576597] Dynamic subtest rcs0: SUCCESS (1.057s)
[276.593260] Starting dynamic subtest: bcs0
[277.632234] Dynamic subtest bcs0: SUCCESS (1.054s)
[277.648087] Starting dynamic subtest: vcs0
[278.685850] Dynamic subtest vcs0: SUCCESS (1.051s)
[278.703065] Starting dynamic subtest: vcs1
[279.739703] Dynamic subtest vcs1: SUCCESS (1.051s)
[279.756804] Starting dynamic subtest: vecs0
[280.795022] Dynamic subtest vecs0: SUCCESS (1.053s)
[280.811271] Starting dynamic subtest: ccs0
[281.851788] Dynamic subtest ccs0: SUCCESS (1.055s)
[281.854286] Subtest write-wait: SUCCESS (7.443s)
[282.051052] [070/133] (738s left) kms_flip (dpms-off-confusion)
[282.146290] Starting subtest: dpms-off-confusion
[282.148446] Starting dynamic subtest: A-eDP1
[290.859888] Dynamic subtest A-eDP1: SUCCESS (8.716s)
[290.871043] Starting dynamic subtest: B-eDP1
[299.511517] Dynamic subtest B-eDP1: SUCCESS (8.651s)
[299.524340] Starting dynamic subtest: C-eDP1
[308.136926] Dynamic subtest C-eDP1: SUCCESS (8.626s)
[308.148904] Starting dynamic subtest: D-eDP1
[316.773587] Dynamic subtest D-eDP1: SUCCESS (8.636s)
[316.778528] Subtest dpms-off-confusion: SUCCESS (34.643s)
[317.942042] [071/133] (702s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[318.040597] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[318.042859] Starting dynamic subtest: pipe-A-eDP-1
[318.063157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[318.075169] Starting dynamic subtest: pipe-B-eDP-1
[318.093924] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[318.102824] Starting dynamic subtest: pipe-C-eDP-1
[318.121305] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[318.130419] Starting dynamic subtest: pipe-D-eDP-1
[318.150929] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[318.152948] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[320.308640] [072/133] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[320.410343] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[320.414523] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[320.505610] [073/133] (700s left) gem_ctx_persistence (heartbeat-many)
[320.560538] Starting subtest: heartbeat-many
[320.565287] Subtest heartbeat-many: SKIP (0.000s)
[320.661748] [074/133] (700s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[322.890346] Starting subtest: gem-execbuf-stress-pc8
[322.928130] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[323.262507] [075/133] (697s left) gem_exec_fence (basic-wait)
[323.439173] Starting subtest: basic-wait
[323.441396] Starting dynamic subtest: rcs0
[323.526880] Dynamic subtest rcs0: SUCCESS (0.087s)
[323.538914] Starting dynamic subtest: bcs0
[323.594555] Dynamic subtest bcs0: SUCCESS (0.065s)
[323.606100] Starting dynamic subtest: vcs0
[323.656345] Dynamic subtest vcs0: SUCCESS (0.060s)
[323.667727] Starting dynamic subtest: vcs1
[323.710865] Dynamic subtest vcs1: SUCCESS (0.052s)
[323.724922] Starting dynamic subtest: vecs0
[323.770872] Dynamic subtest vecs0: SUCCESS (0.058s)
[323.782109] Starting dynamic subtest: ccs0
[323.825474] Dynamic subtest ccs0: SUCCESS (0.052s)
[323.827921] Subtest basic-wait: SUCCESS (0.388s)
[325.776656] [076/133] (695s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[325.906486] Starting subtest: 2x-cursor-vs-flip-atomic
[325.910917] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[326.051456] [077/133] (694s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[326.149850] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[326.153936] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[326.249855] [078/133] (694s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[326.309425] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[326.374624] [079/133] (694s left) gen9_exec_parse (unaligned-access)
[326.436105] Subtest unaligned-access: SKIP (0.000s)
[326.514975] [080/133] (694s left) kms_properties (invalid-properties-atomic)
[326.601445] Starting subtest: invalid-properties-atomic
[326.904855] Subtest invalid-properties-atomic: SUCCESS (0.304s)
[326.978242] [081/133] (694s left) gem_ctx_shared (q-in-order)
[327.038462] Starting subtest: Q-in-order
[327.040796] Starting dynamic subtest: rcs0
[327.148024] Dynamic subtest rcs0: SUCCESS (0.109s)
[327.165526] Starting dynamic subtest: vcs0
[327.230642] Dynamic subtest vcs0: SUCCESS (0.081s)
[327.247067] Starting dynamic subtest: vcs1
[327.306583] Dynamic subtest vcs1: SUCCESS (0.075s)
[327.322974] Starting dynamic subtest: vecs0
[327.382580] Dynamic subtest vecs0: SUCCESS (0.076s)
[327.397220] Starting dynamic subtest: ccs0
[327.476848] Dynamic subtest ccs0: SUCCESS (0.093s)
[327.479333] Subtest Q-in-order: SUCCESS (0.439s)
[328.820783] [082/133] (692s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[328.922888] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[328.927280] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[329.019154] [083/133] (692s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[329.118453] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[329.120660] Starting dynamic subtest: pipe-A-eDP-1
[329.866715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[329.881601] Starting dynamic subtest: pipe-B-eDP-1
[331.691323] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.823s)
[331.702488] Starting dynamic subtest: pipe-C-eDP-1
[333.532266] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.839s)
[333.543560] Starting dynamic subtest: pipe-D-eDP-1
[335.367930] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.835s)
[335.370093] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.244s)
[336.501427] [084/133] (684s left) kms_feature_discovery (chamelium)
[336.594247] Starting subtest: chamelium
[336.598504] Subtest chamelium: SKIP (0.000s)
[336.681810] [085/133] (684s left) gem_ctx_engines (none)
[336.752652] Starting subtest: none
[336.754983] Subtest none: SUCCESS (0.001s)
[336.953054] [086/133] (684s left) kms_flip (dpms-vs-vblank-race-interruptible)
[337.064572] Starting subtest: dpms-vs-vblank-race-interruptible
[337.067044] Starting dynamic subtest: A-eDP1
[341.980439] Dynamic subtest A-eDP1: SUCCESS (4.916s)
[341.990373] Starting dynamic subtest: B-eDP1
[346.581549] Dynamic subtest B-eDP1: SUCCESS (4.600s)
[346.592297] Starting dynamic subtest: C-eDP1
[351.221998] Dynamic subtest C-eDP1: SUCCESS (4.637s)
[351.232337] Starting dynamic subtest: D-eDP1
[355.861505] Dynamic subtest D-eDP1: SUCCESS (4.638s)
[355.866509] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.803s)
[356.753741] [087/133] (664s left) api_intel_bb (simple-bb-ctx)
[356.837988] Starting subtest: simple-bb-ctx
[356.843822] Subtest simple-bb-ctx: SUCCESS (0.008s)
[356.987657] [088/133] (664s left) gem_fenced_exec_thrash (too-many-fences)
[357.045449] Subtest too-many-fences: SKIP (0.000s)
[357.120365] [089/133] (664s left) gem_exec_schedule (semaphore-resolve)
[357.197701] Starting subtest: semaphore-resolve
[357.233106] Subtest semaphore-resolve: SUCCESS (0.043s)
[357.562020] [090/133] (664s left) kms_psr (pr-no-drrs)
[357.659250] Starting subtest: pr-no-drrs
[357.663584] Subtest pr-no-drrs: SKIP (0.000s)
[357.746139] [091/133] (663s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[357.847054] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[357.851176] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[357.957393] [092/133] (663s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[358.046715] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[358.048970] Starting dynamic subtest: pipe-A-eDP-1
[358.145478] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[358.158260] Starting dynamic subtest: pipe-B-eDP-1
[359.319603] Dynamic subtest pipe-B-eDP-1: SKIP (1.172s)
[359.324243] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.274s)
[360.502195] [093/133] (661s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[361.043905] Starting subtest: syncobj-stationary-timeline-chain-engines
[361.177559] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.137s)
[362.789538] [094/133] (658s left) kms_dp_link_training (non-uhbr-mst)
[362.883317] Starting subtest: non-uhbr-mst
[362.891367] Subtest non-uhbr-mst: SKIP (0.000s)
[362.955085] [095/133] (658s left) gem_userptr_blits (create-destroy-sync)
[363.018829] Starting subtest: create-destroy-sync
[368.035753] Subtest create-destroy-sync: SUCCESS (5.014s)
[368.167577] [096/133] (653s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[368.224455] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[368.226773] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[368.327792] [097/133] (653s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[368.431865] Starting subtest: 2x-plain-flip-ts-check-interruptible
[368.444973] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.012s)
[368.525405] [098/133] (653s left) kms_psr (psr2-primary-blt)
[368.621795] Starting subtest: psr2-primary-blt
[368.624138] Starting dynamic subtest: eDP-1
[370.388278] Dynamic subtest eDP-1: SUCCESS (1.767s)
[370.390553] Subtest psr2-primary-blt: SUCCESS (1.768s)
[371.264927] [099/133] (650s left) i915_pm_rps (waitboost)
[371.350340] Starting subtest: waitboost
[377.428749] Subtest waitboost: SUCCESS (6.077s)
[377.564612] [100/133] (644s left) perf_pmu (rc6)
[377.615892] Starting subtest: rc6
[377.618261] Starting dynamic subtest: gt0
[383.981910] Dynamic subtest gt0: SUCCESS (6.361s)
[383.994121] Starting dynamic subtest: runtime-pm-gt0
[391.705745] Dynamic subtest runtime-pm-gt0: SUCCESS (7.722s)
[391.717261] Starting dynamic subtest: runtime-pm-long-gt0
[404.220291] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.511s)
[404.233103] Starting dynamic subtest: other-idle-gt0
[410.565147] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[410.578145] Starting dynamic subtest: gt1
[416.909083] Dynamic subtest gt1: SUCCESS (6.341s)
[416.921326] Starting dynamic subtest: runtime-pm-gt1
[424.413409] Dynamic subtest runtime-pm-gt1: SUCCESS (7.501s)
[424.426889] Starting dynamic subtest: runtime-pm-long-gt1
[436.851786] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.436s)
[436.863649] Starting dynamic subtest: other-idle-gt1
[443.195710] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[443.198543] Subtest rc6: SUCCESS (65.576s)
[444.363325] [101/133] (577s left) sw_sync (timeline_closed_signaled)
[444.422552] Starting subtest: timeline_closed_signaled
[444.424826] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[444.469998] [102/133] (577s left) kms_atomic (test-only)
[444.581312] Starting subtest: test-only
[444.635816] Starting dynamic subtest: pipe-A-eDP-1
[447.203207] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.570s)
[447.205150] Subtest test-only: SUCCESS (2.621s)
[448.049980] [103/133] (574s left) kms_psr (fbc-pr-sprite-plane-onoff)
[448.133824] Starting subtest: fbc-pr-sprite-plane-onoff
[448.138394] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[448.187279] [104/133] (574s left) gem_fence_thrash (bo-write-verify-x)
[448.221802] Starting subtest: bo-write-verify-x
[448.237625] Subtest bo-write-verify-x: SKIP (0.013s)
[448.298333] [105/133] (573s left) perf_pmu (busy-hang)
[448.337889] Starting subtest: busy-hang
[448.340372] Starting dynamic subtest: rcs0
[449.607260] Dynamic subtest rcs0: SUCCESS (1.267s)
[449.619942] Starting dynamic subtest: bcs0
[450.842965] Dynamic subtest bcs0: SUCCESS (1.234s)
[450.854411] Starting dynamic subtest: vcs0
[453.213241] Dynamic subtest vcs0: SUCCESS (2.368s)
[453.224856] Starting dynamic subtest: vcs1
[455.198595] Dynamic subtest vcs1: SUCCESS (1.987s)
[455.210739] Starting dynamic subtest: vecs0
[457.191080] Dynamic subtest vecs0: SUCCESS (1.988s)
[457.202796] Starting dynamic subtest: ccs0
[458.442246] Dynamic subtest ccs0: SUCCESS (1.249s)
[458.444241] Subtest busy-hang: SUCCESS (10.104s)
[458.523337] [106/133] (563s left) gem_exec_suspend (basic)
[458.603833] Starting subtest: basic
[458.606220] Starting dynamic subtest: smem
[460.700636] Dynamic subtest smem: SUCCESS (2.094s)
[460.703553] Subtest basic: SUCCESS (2.097s)
[460.865626] [107/133] (561s left) sw_sync (alloc_fence)
[460.909679] Starting subtest: alloc_fence
[460.911578] Subtest alloc_fence: SUCCESS (0.000s)
[460.950817] [108/133] (561s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[461.053706] Starting subtest: psr-rgb101010-draw-pwrite
[468.773457] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.723s)
[468.856048] [109/133] (553s left) testdisplay
[469.144613] [110/133] (553s left) gem_eio (wait-immediate)
[469.376661] Starting subtest: wait-immediate
[469.765635] Subtest wait-immediate: SUCCESS (0.391s)
[469.893500] [111/133] (552s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[469.987487] Starting subtest: psr-1p-pri-indfb-multidraw
[493.057866] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.076s)
[493.184396] [112/133] (529s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[493.249701] Starting subtest: invalid-multi-wait-unsubmitted
[493.251523] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[493.348667] [113/133] (529s left) gem_ccs (block-copy-compressed)
[493.413508] Starting subtest: block-copy-compressed
[493.417351] Subtest block-copy-compressed: SKIP (0.000s)
[493.491010] [114/133] (529s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[493.600592] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[497.343426] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.746s)
[498.497078] [115/133] (524s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[498.608084] Starting subtest: y-tiled-8bpp-rotate-270
[498.612615] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[498.680493] [116/133] (524s left) syncobj_timeline (single-wait-all-signaled)
[498.731731] Starting subtest: single-wait-all-signaled
[498.734347] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[498.810351] [117/133] (523s left) kms_addfb_basic (invalid-get-prop)
[498.871047] Starting subtest: invalid-get-prop
[498.873044] Subtest invalid-get-prop: SUCCESS (0.000s)
[498.972248] [118/133] (523s left) gem_render_copy (y-tiled-to-vebox-linear)
[499.032830] Starting subtest: y-tiled-to-vebox-linear
[499.037532] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[499.198394] [119/133] (523s left) kms_busy (extended-pageflip-hang-oldfb)
[499.297589] Starting subtest: extended-pageflip-hang-oldfb
[499.299913] Starting dynamic subtest: pipe-A
[499.693008] Dynamic subtest pipe-A: SUCCESS (0.392s)
[499.704368] Starting dynamic subtest: pipe-D
[500.830517] Dynamic subtest pipe-D: SUCCESS (1.137s)
[500.832860] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.533s)
[501.653869] [120/133] (521s left) kms_vblank (ts-continuation-idle-hang)
[501.740972] Starting subtest: ts-continuation-idle-hang
[501.743224] Starting dynamic subtest: pipe-A-eDP-1
[528.535787] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.797s)
[528.553161] Starting dynamic subtest: pipe-D-eDP-1
[552.482710] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.949s)
[552.484945] Subtest ts-continuation-idle-hang: SUCCESS (50.750s)
[553.319266] [121/133] (469s left) kms_scaling_modes (scaling-mode-full)
[553.425673] Starting subtest: scaling-mode-full
[553.427980] Starting dynamic subtest: pipe-A-eDP-1
[553.519948] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[553.533229] Starting dynamic subtest: pipe-B-eDP-1
[554.666116] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s)
[554.676388] Starting dynamic subtest: pipe-C-eDP-1
[555.789672] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[555.800249] Starting dynamic subtest: pipe-D-eDP-1
[556.915438] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[556.917801] Subtest scaling-mode-full: SUCCESS (3.493s)
[558.064225] [122/133] (464s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[558.120303] Starting subtest: etime-single-wait-for-submit-unsubmitted
[558.224594] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[558.280152] [123/133] (464s left) kms_content_protection (dp-mst-type-0)
[558.422102] Starting subtest: dp-mst-type-0
[558.426367] Subtest dp-mst-type-0: SKIP (0.000s)
[558.523142] [124/133] (464s left) gem_exec_schedule (preempt-hang)
[558.695555] Starting subtest: preempt-hang
[558.698044] Starting dynamic subtest: rcs0
[558.909160] Dynamic subtest rcs0: SUCCESS (0.216s)
[558.918908] Starting dynamic subtest: bcs0
[559.138997] Dynamic subtest bcs0: SUCCESS (0.227s)
[559.150400] Starting dynamic subtest: vcs0
[559.373525] Dynamic subtest vcs0: SUCCESS (0.232s)
[559.386108] Starting dynamic subtest: vcs1
[559.602067] Dynamic subtest vcs1: SUCCESS (0.229s)
[559.614533] Starting dynamic subtest: vecs0
[559.831766] Dynamic subtest vecs0: SUCCESS (0.229s)
[559.845085] Starting dynamic subtest: ccs0
[560.060916] Dynamic subtest ccs0: SUCCESS (0.226s)
[560.063269] Subtest preempt-hang: SUCCESS (1.369s)
[560.748960] [125/133] (462s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[560.852844] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[568.346719] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.498s)
[568.463381] [126/133] (454s left) gem_sync (basic-many-each)
[568.541961] Starting subtest: basic-many-each
[570.859072] Subtest basic-many-each: SUCCESS (2.327s)
[571.032710] [127/133] (452s left) gem_userptr_blits (coherency-unsync)
[571.109573] Subtest coherency-unsync: SKIP (0.000s)
[571.199838] [128/133] (452s left) syncobj_wait (multi-wait-all-signaled)
[571.251510] Starting subtest: multi-wait-all-signaled
[571.253714] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[571.330816] [129/133] (451s left) syncobj_wait (invalid-signal-one-illegal-handle)
[571.382012] Starting subtest: invalid-signal-one-illegal-handle
[571.384191] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[571.458979] [130/133] (451s left) gem_mmap_offset (clear)
[571.512190] Starting subtest: clear
[571.515016] Starting dynamic subtest: smem0
[594.755519] Dynamic subtest smem0: SUCCESS (23.244s)
[594.757445] Subtest clear: SUCCESS (23.245s)
[594.841305] [131/133] (428s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[595.000959] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[595.005409] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[595.060482] [132/133] (428s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[595.151517] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[595.153811] Starting dynamic subtest: pipe-A
[595.214764] Dynamic subtest pipe-A: SUCCESS (0.065s)
[595.227236] Starting dynamic subtest: pipe-B
[596.346932] Dynamic subtest pipe-B: SUCCESS (1.131s)
[596.360498] Starting dynamic subtest: pipe-C
[597.452685] Dynamic subtest pipe-C: SUCCESS (1.104s)
[597.465655] Starting dynamic subtest: pipe-D
[598.588395] Dynamic subtest pipe-D: SUCCESS (1.135s)
[598.590580] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.440s)
[599.746504] [133/133] (423s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[599.849167] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[600.551246] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.703s)
[600.678710] 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.