[59.197040] Initializing watchdogs
[59.197086]   /dev/watchdog0
[59.211207] [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]
[59.215545] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.217768] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.221139] [001/133] (960s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[59.328840] Starting subtest: plane-downscale-factor-0-5-with-rotation
[59.331103] Starting dynamic subtest: pipe-A
[59.350253] Dynamic subtest pipe-A: SKIP (0.017s)
[59.357597] Starting dynamic subtest: pipe-B
[59.383054] Dynamic subtest pipe-B: SKIP (0.034s)
[59.390171] Starting dynamic subtest: pipe-C
[59.416317] Dynamic subtest pipe-C: SKIP (0.034s)
[59.422838] Starting dynamic subtest: pipe-D
[59.449933] Dynamic subtest pipe-D: SKIP (0.034s)
[59.454253] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.120s)
[59.557131] [002/133] (960s left) kms_big_fb (linear-64bpp-rotate-0)
[59.655104] Starting subtest: linear-64bpp-rotate-0
[61.301313] Subtest linear-64bpp-rotate-0: SUCCESS (1.656s)
[61.473946] [003/133] (958s left) gem_exec_reloc (basic-wc-noreloc)
[61.554099] Subtest basic-wc-noreloc: SKIP (0.000s)
[61.626176] [004/133] (958s left) gem_exec_fence (expired-history)
[62.073604] Starting subtest: expired-history
[69.579225] Subtest expired-history: SUCCESS (7.527s)
[70.180733] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[70.183797] [005/133] (949s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[70.460867] Starting subtest: cursor-rapid-movement-128x128
[70.463257] Starting dynamic subtest: pipe-A-eDP-1
[71.026704] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[71.057764] Starting dynamic subtest: pipe-D-eDP-1
[72.280529] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[72.282916] Subtest cursor-rapid-movement-128x128: SUCCESS (1.822s)
[73.144694] [006/133] (946s left) gem_exec_reloc (basic-write-gtt-active)
[73.203338] Subtest basic-write-gtt-active: SKIP (0.000s)
[73.263691] [007/133] (946s left) syncobj_wait (wait-all-for-submit-complex)
[73.317072] Starting subtest: wait-all-for-submit-complex
[73.530867] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[73.615518] [008/133] (946s left) gem_exec_schedule (deep)
[73.787691] Starting subtest: deep
[73.790122] Starting dynamic subtest: rcs0
[78.880021] Dynamic subtest rcs0: SKIP (5.092s)
[78.887301] Starting dynamic subtest: vcs0
[89.027688] Dynamic subtest vcs0: SUCCESS (10.147s)
[89.042077] Starting dynamic subtest: vcs1
[100.084059] Dynamic subtest vcs1: SUCCESS (11.056s)
[100.094923] Starting dynamic subtest: vecs0
[111.144258] Dynamic subtest vecs0: SUCCESS (11.059s)
[111.155930] Starting dynamic subtest: ccs0
[123.263797] Dynamic subtest ccs0: SUCCESS (12.119s)
[123.267171] Subtest deep: SUCCESS (49.475s)
[125.368075] [009/133] (894s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[125.459419] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[125.463770] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[125.555335] [010/133] (894s left) gem_render_copy_redux (interruptible)
[125.612227] Starting subtest: interruptible
[125.893562] Subtest interruptible: SUCCESS (0.282s)
[126.013560] [011/133] (894s left) gem_exec_fence (syncobj-timeline-chain-engines)
[126.596662] Starting subtest: syncobj-timeline-chain-engines
[126.699693] Subtest syncobj-timeline-chain-engines: SUCCESS (0.102s)
[127.979187] [012/133] (892s left) kms_busy (basic)
[128.070784] Starting subtest: basic
[128.074891] Starting dynamic subtest: flip
[128.650253] Dynamic subtest flip: SUCCESS (0.578s)
[128.659295] Starting dynamic subtest: modeset
[132.055827] Dynamic subtest modeset: SUCCESS (3.406s)
[132.058210] Subtest basic: SUCCESS (3.985s)
[132.846695] [013/133] (887s left) prime_busy (after-wait)
[132.900137] Starting subtest: after-wait
[132.902525] Starting dynamic subtest: rcs0
[132.925863] Dynamic subtest rcs0: SUCCESS (0.024s)
[132.935594] Starting dynamic subtest: bcs0
[132.983248] Dynamic subtest bcs0: SUCCESS (0.057s)
[132.992574] Starting dynamic subtest: vcs0
[133.023903] Dynamic subtest vcs0: SUCCESS (0.041s)
[133.032786] Starting dynamic subtest: vcs1
[133.064362] Dynamic subtest vcs1: SUCCESS (0.040s)
[133.073019] Starting dynamic subtest: vecs0
[133.104749] Dynamic subtest vecs0: SUCCESS (0.040s)
[133.113283] Starting dynamic subtest: ccs0
[133.147672] Dynamic subtest ccs0: SUCCESS (0.043s)
[133.255530] Subtest after-wait: SUCCESS (0.354s)
[133.331012] [014/133] (886s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[133.437095] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[134.072104] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s)
[134.229215] [015/133] (886s left) kms_setmode (invalid-clone-single-crtc-stealing)
[134.289700] Starting subtest: invalid-clone-single-crtc-stealing
[134.296337] Subtest invalid-clone-single-crtc-stealing: SKIP (0.001s)
[134.406167] [016/133] (885s left) prime_self_import (reimport-vs-gem_close-race)
[134.445707] Starting subtest: reimport-vs-gem_close-race
[139.541378] Subtest reimport-vs-gem_close-race: SUCCESS (5.095s)
[139.615078] [017/133] (880s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[139.721985] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[139.726179] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[139.814225] [018/133] (880s left) gem_mmap_gtt (bad-object)
[139.872159] Subtest bad-object: SKIP (0.000s)
[139.925324] [019/133] (880s left) kms_pm_lpsp (screens-disabled)
[141.017093] Starting subtest: screens-disabled
[141.021293] Subtest screens-disabled: SKIP (0.000s)
[141.084072] [020/133] (879s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[141.179076] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[141.181336] Starting dynamic subtest: pipe-A-eDP-1
[141.205364] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[141.213297] Starting dynamic subtest: pipe-B-eDP-1
[141.236637] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[141.243926] Starting dynamic subtest: pipe-C-eDP-1
[141.268407] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[141.275572] Starting dynamic subtest: pipe-D-eDP-1
[141.299968] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[141.304095] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[143.424750] [021/133] (877s left) i915_drm_fdinfo (virtual-busy-idle)
[143.460274] Starting subtest: virtual-busy-idle
[143.464622] Subtest virtual-busy-idle: SKIP (0.000s)
[143.531960] [022/133] (877s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[143.628944] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[151.114855] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.488s)
[151.237636] [023/133] (869s left) gem_eio (throttle)
[151.485039] Starting subtest: throttle
[151.817414] Subtest throttle: SUCCESS (0.333s)
[151.959991] [024/133] (868s left) kms_dp_linktrain_fallback (dp-fallback)
[152.043241] Starting subtest: dp-fallback
[152.048628] Subtest dp-fallback: SKIP (0.000s)
[152.129749] [025/133] (868s left) gem_userptr_blits (stress-mm)
[152.197648] Starting subtest: stress-mm
[157.567250] Subtest stress-mm: SUCCESS (5.369s)
[157.699169] [026/133] (862s left) sysfs_heartbeat_interval (mixed)
[157.756577] Starting subtest: mixed
[157.759079] Starting dynamic subtest: vecs0
[163.028689] Dynamic subtest vecs0: SUCCESS (5.271s)
[163.039604] Starting dynamic subtest: ccs0
[168.221056] Dynamic subtest ccs0: SUCCESS (5.191s)
[168.231575] Starting dynamic subtest: vcs0
[173.439266] Dynamic subtest vcs0: SUCCESS (5.217s)
[173.450315] Starting dynamic subtest: bcs0
[178.626807] Dynamic subtest bcs0: SUCCESS (5.186s)
[178.635421] Starting dynamic subtest: rcs0
[183.816118] Dynamic subtest rcs0: SUCCESS (5.188s)
[183.826411] Starting dynamic subtest: vcs1
[189.069329] Dynamic subtest vcs1: SUCCESS (5.252s)
[189.071800] Subtest mixed: SUCCESS (31.312s)
[189.156790] [027/133] (831s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[189.251057] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[189.255278] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[189.353879] [028/133] (831s left) gem_lmem_swapping (heavy-verify-random)
[189.394644] Subtest heavy-verify-random: SKIP (0.000s)
[189.436957] [029/133] (831s left) prime_udl
[189.513216] [030/133] (831s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[189.891537] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[190.678840] [031/133] (830s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[190.783187] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[191.462495] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[191.623781] [032/133] (829s left) gem_exec_reloc (basic-write-wc-noreloc)
[191.680071] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[191.740699] [033/133] (829s left) fbdev (write)
[191.788037] Starting subtest: write
[192.218774] Subtest write: SUCCESS (0.431s)
[192.284939] [034/133] (828s left) gem_userptr_blits (sd-probe)
[192.354427] Starting subtest: sd-probe
[192.356476] Subtest sd-probe: SUCCESS (0.000s)
[192.470913] [035/133] (828s left) kms_flip (flip-vs-panning-interruptible)
[192.563284] Starting subtest: flip-vs-panning-interruptible
[192.565612] Starting dynamic subtest: A-eDP1
[201.310512] Dynamic subtest A-eDP1: SUCCESS (8.747s)
[201.320640] Starting dynamic subtest: B-eDP1
[210.047084] Dynamic subtest B-eDP1: SUCCESS (8.735s)
[210.059056] Starting dynamic subtest: C-eDP1
[218.770239] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[218.778683] Starting dynamic subtest: D-eDP1
[227.507369] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[227.509469] Subtest flip-vs-panning-interruptible: SUCCESS (34.946s)
[228.673771] [036/133] (792s left) kms_flip (plain-flip-ts-check)
[228.762107] Starting subtest: plain-flip-ts-check
[228.764380] Starting dynamic subtest: A-eDP1
[237.673139] Dynamic subtest A-eDP1: SUCCESS (8.910s)
[237.681601] Starting dynamic subtest: B-eDP1
[246.495493] Dynamic subtest B-eDP1: SUCCESS (8.821s)
[246.507685] Starting dynamic subtest: C-eDP1
[255.324777] Dynamic subtest C-eDP1: SUCCESS (8.825s)
[255.334842] Starting dynamic subtest: D-eDP1
[264.154744] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[264.157118] Subtest plain-flip-ts-check: SUCCESS (35.395s)
[265.339233] [037/133] (755s left) kms_chamelium_frames (dp-crc-single)
[265.727067] Subtest dp-crc-single: SKIP (0.000s)
[266.541107] [038/133] (754s left) kms_psr (pr-cursor-mmap-cpu)
[266.631070] Starting subtest: pr-cursor-mmap-cpu
[266.635505] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[266.692240] [039/133] (754s left) drm_mm (drm_mm)
[266.733088] Starting subtest: drm_mm
[266.770762] Starting dynamic subtest: drm_test_mm_init
[266.863038] Dynamic subtest drm_test_mm_init: SUCCESS (0.093s)
[266.872627] Starting dynamic subtest: drm_test_mm_debug
[266.977961] Dynamic subtest drm_test_mm_debug: SUCCESS (0.109s)
[266.988637] Starting dynamic subtest: drm_test_mm_align32
[267.073080] Dynamic subtest drm_test_mm_align32: SUCCESS (0.095s)
[267.083858] Starting dynamic subtest: drm_test_mm_align64
[267.172936] Dynamic subtest drm_test_mm_align64: SUCCESS (0.100s)
[267.181958] Starting dynamic subtest: drm_test_mm_lowest
[267.276806] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.103s)
[267.285578] Starting dynamic subtest: drm_test_mm_highest
[267.379208] Dynamic subtest drm_test_mm_highest: SUCCESS (0.102s)
[267.381361] Subtest drm_mm: SUCCESS (0.647s)
[267.540697] [040/133] (753s left) gem_pread (exhaustion)
[267.603836] Subtest exhaustion: SKIP (0.000s)
[267.662641] [041/133] (753s left) kms_psr (fbc-psr2-basic)
[267.753217] Starting subtest: fbc-psr2-basic
[267.755509] Starting dynamic subtest: eDP-1
[267.759704] Dynamic subtest eDP-1: SKIP (0.000s)
[267.763998] Subtest fbc-psr2-basic: SKIP (0.001s)
[267.828644] [042/133] (753s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[267.925714] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[267.927969] Starting dynamic subtest: pipe-A-eDP-1
[267.949706] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[267.958059] Starting dynamic subtest: pipe-B-eDP-1
[267.979366] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[267.986641] Starting dynamic subtest: pipe-C-eDP-1
[268.004331] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[268.011603] Starting dynamic subtest: pipe-D-eDP-1
[268.029379] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[268.032752] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[270.136978] [043/133] (751s left) kms_rmfb (close-fd)
[270.252118] Starting subtest: close-fd
[270.254042] Starting dynamic subtest: pipe-A-eDP-1
[270.360124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[270.374919] Starting dynamic subtest: pipe-B-eDP-1
[271.506326] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.144s)
[271.516107] Starting dynamic subtest: pipe-C-eDP-1
[272.635217] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[272.643977] Starting dynamic subtest: pipe-D-eDP-1
[273.774096] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[273.776394] Subtest close-fd: SUCCESS (3.523s)
[274.994041] [044/133] (746s left) syncobj_timeline (multi-wait-all-available-signaled)
[275.066867] Starting subtest: multi-wait-all-available-signaled
[275.069262] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[275.177627] [045/133] (746s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[275.266634] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[275.268941] Starting dynamic subtest: pipe-A-eDP-1
[275.351790] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[275.362836] Starting dynamic subtest: pipe-B-eDP-1
[276.465252] Dynamic subtest pipe-B-eDP-1: SKIP (1.113s)
[276.469666] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.203s)
[277.643212] [046/133] (743s left) gem_userptr_blits (access-control)
[277.721264] Starting subtest: access-control
[277.725451] Subtest access-control: SKIP (0.000s)
[277.846790] [047/133] (743s left) kms_content_protection (dp-mst-type-0-hdcp14)
[277.989730] Starting subtest: dp-mst-type-0-hdcp14
[277.994232] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[278.110730] [048/133] (743s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[278.195249] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[278.197540] Starting dynamic subtest: pipe-A-eDP-1
[278.219279] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[278.229385] Starting dynamic subtest: pipe-B-eDP-1
[278.250056] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[278.257200] Starting dynamic subtest: pipe-C-eDP-1
[278.277821] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[278.285409] Starting dynamic subtest: pipe-D-eDP-1
[278.306096] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[278.310171] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[280.495481] [049/133] (741s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[280.612631] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[287.653065] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.044s)
[287.753178] [050/133] (733s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[287.852524] Starting subtest: fbc-psr2-sprite-mmap-gtt
[287.854662] Starting dynamic subtest: eDP-1
[287.858646] Dynamic subtest eDP-1: SKIP (0.000s)
[287.862582] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[287.937241] [051/133] (733s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[287.992945] Starting subtest: etime-single-wait-for-submit-unsubmitted
[288.097031] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[288.173568] [052/133] (733s left) kms_cursor_edge_walk (128x128-top-bottom)
[288.274664] Starting subtest: 128x128-top-bottom
[288.276809] Starting dynamic subtest: pipe-A-eDP-1
[292.504881] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.227s)
[292.514700] Starting dynamic subtest: pipe-D-eDP-1
[295.187507] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.683s)
[295.189676] Subtest 128x128-top-bottom: SUCCESS (6.914s)
[295.990461] [053/133] (725s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[296.089202] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[302.738737] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.650s)
[302.851844] [054/133] (718s left) gem_partial_pwrite_pread (writes-after-reads-display)
[302.906532] Subtest writes-after-reads-display: SKIP (0.000s)
[302.978671] [055/133] (718s left) perf (gen12-group-exclusive-stream-ctx-handle)
[303.106959] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[303.131123] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.023s)
[303.186598] [056/133] (718s left) vgem_basic (create)
[303.233505] Starting subtest: create
[303.235993] Subtest create: SUCCESS (0.001s)
[303.293340] [057/133] (718s left) gem_exec_reloc (basic-write-wc-active)
[304.893162] Subtest basic-write-wc-active: SKIP (0.000s)
[304.969749] [058/133] (717s left) kms_fbcon_fbt (psr)
[305.030674] Starting subtest: psr
[312.372891] Subtest psr: SUCCESS (7.339s)
[312.449352] [059/133] (709s left) i915_drm_fdinfo (most-busy-check-all)
[312.489030] Starting subtest: most-busy-check-all
[312.491308] Starting dynamic subtest: rcs0
[312.495910] Dynamic subtest rcs0: SKIP (0.004s)
[312.505074] Starting dynamic subtest: bcs0
[312.509347] Dynamic subtest bcs0: SKIP (0.000s)
[312.517304] Starting dynamic subtest: vcs0
[312.521141] Dynamic subtest vcs0: SKIP (0.000s)
[312.529095] Starting dynamic subtest: vcs1
[312.533278] Dynamic subtest vcs1: SKIP (0.000s)
[312.541187] Starting dynamic subtest: vecs0
[312.545311] Dynamic subtest vecs0: SKIP (0.000s)
[312.552747] Starting dynamic subtest: ccs0
[312.556841] Dynamic subtest ccs0: SKIP (0.000s)
[312.561082] Subtest most-busy-check-all: SKIP (0.009s)
[312.597649] [060/133] (709s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[312.705931] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[312.710162] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[312.786212] [061/133] (709s left) gem_exec_schedule (u-independent)
[312.853158] Starting subtest: u-independent
[312.855052] Starting dynamic subtest: rcs0
[314.900427] Dynamic subtest rcs0: SUCCESS (2.053s)
[314.911825] Starting dynamic subtest: vcs0
[316.900049] Dynamic subtest vcs0: SUCCESS (1.996s)
[316.910948] Starting dynamic subtest: vcs1
[318.887102] Dynamic subtest vcs1: SUCCESS (1.984s)
[318.897732] Starting dynamic subtest: vecs0
[320.922520] Dynamic subtest vecs0: SUCCESS (2.033s)
[320.931615] Starting dynamic subtest: ccs0
[322.900461] Dynamic subtest ccs0: SUCCESS (1.974s)
[322.903071] Subtest u-independent: SUCCESS (10.055s)
[323.200413] [062/133] (698s left) syncobj_wait (single-wait-for-submit-submitted)
[323.264681] Starting subtest: single-wait-for-submit-submitted
[323.368894] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[323.449096] [063/133] (698s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[323.556924] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[323.561103] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[323.651999] [064/133] (698s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[323.713281] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[323.717693] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[323.911742] [065/133] (698s left) kms_prop_blob (invalid-get-prop-any)
[323.966107] Starting subtest: invalid-get-prop-any
[323.968338] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[324.065392] [066/133] (698s left) prime_self_import (basic-with_one_bo_two_files)
[324.098925] Starting subtest: basic-with_one_bo_two_files
[324.114020] Subtest basic-with_one_bo_two_files: SUCCESS (0.019s)
[324.215210] [067/133] (698s left) kms_cursor_crc (cursor-onscreen-256x85)
[324.573397] Starting subtest: cursor-onscreen-256x85
[324.630358] Subtest cursor-onscreen-256x85: SKIP (0.056s)
[324.791267] [068/133] (697s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[324.896703] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[324.900117] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[324.992076] [069/133] (697s left) kms_psr (fbc-pr-cursor-blt)
[325.108617] Starting subtest: fbc-pr-cursor-blt
[325.112181] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[325.176396] [070/133] (697s left) gem_exec_reloc (basic-gtt-wc-active)
[325.237457] Subtest basic-gtt-wc-active: SKIP (0.000s)
[325.305379] [071/133] (697s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[325.413759] Starting subtest: fbc-rgb565-draw-mmap-cpu
[329.383053] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.972s)
[330.498469] [072/133] (692s left) kms_flip (plain-flip-interruptible)
[330.588859] Starting subtest: plain-flip-interruptible
[330.591078] Starting dynamic subtest: A-eDP1
[332.281569] Dynamic subtest A-eDP1: SUCCESS (1.691s)
[332.291325] Starting dynamic subtest: B-eDP1
[333.925437] Dynamic subtest B-eDP1: SUCCESS (1.642s)
[333.936642] Starting dynamic subtest: C-eDP1
[335.551589] Dynamic subtest C-eDP1: SUCCESS (1.625s)
[335.564445] Starting dynamic subtest: D-eDP1
[337.169664] Dynamic subtest D-eDP1: SUCCESS (1.616s)
[337.174800] Subtest plain-flip-interruptible: SUCCESS (6.585s)
[338.359893] [073/133] (684s left) gem_userptr_blits (sync-unmap-after-close)
[338.431530] Starting subtest: sync-unmap-after-close
[338.439272] Subtest sync-unmap-after-close: SUCCESS (0.009s)
[338.586300] [074/133] (684s left) sw_sync (sync_multi_producer_single_consumer)
[338.619878] Starting subtest: sync_multi_producer_single_consumer
[339.695082] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[339.757255] [075/133] (682s left) kms_atomic_interruptible (universal-setplane-primary)
[339.855437] Starting subtest: universal-setplane-primary
[339.857703] Starting dynamic subtest: pipe-A-eDP-1
[347.285407] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.430s)
[347.287808] Subtest universal-setplane-primary: SUCCESS (7.432s)
[348.097032] [076/133] (674s left) kms_vblank (wait-idle-hang)
[348.194365] Starting subtest: wait-idle-hang
[348.196292] Starting dynamic subtest: pipe-A-eDP-1
[374.687248] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.493s)
[374.700612] Starting dynamic subtest: pipe-D-eDP-1
[389.665700] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.974s)
[389.667683] Subtest wait-idle-hang: SUCCESS (41.471s)
[390.460401] [077/133] (632s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[390.557103] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[394.922476] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.368s)
[396.098944] [078/133] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[396.200386] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[396.204563] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[396.296837] [079/133] (626s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[396.392839] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[396.397230] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[396.489206] [080/133] (626s left) kms_tiled_display (basic-test-pattern)
[396.600281] Subtest basic-test-pattern: SKIP (0.000s)
[396.647629] [081/133] (626s left) kms_flip (2x-flip-vs-suspend)
[396.735628] Starting subtest: 2x-flip-vs-suspend
[396.739744] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[396.845280] [082/133] (626s left) prime_vgem (fence-write-hang)
[396.934673] Subtest fence-write-hang: SKIP (0.000s)
[397.032458] [083/133] (625s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[397.149037] Starting subtest: cursorA-vs-flipA-legacy
[408.279572] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.128s)
[409.101828] [084/133] (613s left) kms_plane_alpha_blend (alpha-basic)
[409.214913] Starting subtest: alpha-basic
[409.506379] Starting dynamic subtest: pipe-A-eDP-1
[411.432085] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s)
[411.461026] Starting dynamic subtest: pipe-D-eDP-1
[414.102221] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.648s)
[414.104589] Subtest alpha-basic: SUCCESS (4.887s)
[414.981213] [085/133] (608s left) kms_feature_discovery (display-3x)
[415.082071] Starting subtest: display-3x
[415.086632] Subtest display-3x: SKIP (0.000s)
[415.154082] [086/133] (607s left) kms_psr (psr-cursor-mmap-gtt)
[415.253706] Starting subtest: psr-cursor-mmap-gtt
[415.255948] Starting dynamic subtest: eDP-1
[416.962427] Dynamic subtest eDP-1: SUCCESS (1.707s)
[416.964622] Subtest psr-cursor-mmap-gtt: SUCCESS (1.708s)
[417.831644] [087/133] (605s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[417.954865] Starting subtest: verify-pxp-key-change-after-suspend-resume
[425.916808] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.964s)
[426.058921] [088/133] (597s left) kms_plane_multiple (tiling-4)
[426.168745] Starting subtest: tiling-4
[426.170955] Starting dynamic subtest: pipe-A-eDP-1
[429.818984] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.649s)
[429.828823] Starting dynamic subtest: pipe-B-eDP-1
[434.266189] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.448s)
[434.275310] Starting dynamic subtest: pipe-C-eDP-1
[438.608686] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.341s)
[438.617753] Starting dynamic subtest: pipe-D-eDP-1
[442.967225] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.355s)
[442.969481] Subtest tiling-4: SUCCESS (16.798s)
[443.764554] [089/133] (579s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[443.857599] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[443.859912] Starting dynamic subtest: pipe-A-eDP-1
[443.879701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[443.889793] Starting dynamic subtest: pipe-B-eDP-1
[443.909062] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[443.917795] Starting dynamic subtest: pipe-C-eDP-1
[443.936773] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[443.945497] Starting dynamic subtest: pipe-D-eDP-1
[443.964055] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[443.966143] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[446.131856] [090/133] (577s left) kms_psr (psr-sprite-blt)
[446.221827] Starting subtest: psr-sprite-blt
[446.224081] Starting dynamic subtest: eDP-1
[447.950776] Dynamic subtest eDP-1: SUCCESS (1.729s)
[447.953036] Subtest psr-sprite-blt: SUCCESS (1.730s)
[448.796520] [091/133] (574s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[448.890384] Starting subtest: yf-tiled-8bpp-rotate-180
[448.894518] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[448.988226] [092/133] (574s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[449.092762] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[449.097075] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[449.220102] [093/133] (574s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[449.304156] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[449.306490] Starting dynamic subtest: pipe-A-default-mode
[450.460115] Dynamic subtest pipe-A-default-mode: SKIP (1.153s)
[450.464329] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.155s)
[450.602320] [094/133] (572s left) gem_mmap_offset (clear)
[450.655301] Starting subtest: clear
[450.658000] Starting dynamic subtest: smem0
[476.391673] Dynamic subtest smem0: SUCCESS (25.733s)
[476.393992] Subtest clear: SUCCESS (25.734s)
[476.524316] [095/133] (546s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[476.671637] Starting subtest: 4-tiled-16bpp-rotate-180
[478.050763] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.379s)
[478.174219] [096/133] (545s left) gem_create (create-size-update)
[478.225317] Starting subtest: create-size-update
[478.226920] Subtest create-size-update: SUCCESS (0.000s)
[478.440991] [097/133] (545s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[478.567580] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[478.571961] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[478.712503] [098/133] (544s left) perf_pmu (most-busy-check-all)
[478.759471] Starting subtest: most-busy-check-all
[478.761428] Starting dynamic subtest: rcs0
[479.893118] Dynamic subtest rcs0: SUCCESS (1.134s)
[479.905488] Starting dynamic subtest: bcs0
[481.878064] Dynamic subtest bcs0: SUCCESS (1.981s)
[481.891381] Starting dynamic subtest: vcs0
[483.925397] Dynamic subtest vcs0: SUCCESS (2.044s)
[483.938653] Starting dynamic subtest: vcs1
[485.909304] Dynamic subtest vcs1: SUCCESS (1.981s)
[485.922201] Starting dynamic subtest: vecs0
[487.893862] Dynamic subtest vecs0: SUCCESS (1.981s)
[487.907058] Starting dynamic subtest: ccs0
[489.877943] Dynamic subtest ccs0: SUCCESS (1.981s)
[489.880924] Subtest most-busy-check-all: SUCCESS (11.121s)
[489.972792] [099/133] (533s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[490.070648] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[490.075080] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[490.150096] [100/133] (533s left) gem_ctx_persistence (engines-hostile)
[490.208770] Starting subtest: engines-hostile
[490.211182] Starting dynamic subtest: rcs0
[490.294998] Dynamic subtest rcs0: SUCCESS (0.085s)
[490.307379] Starting dynamic subtest: bcs0
[490.387710] Dynamic subtest bcs0: SUCCESS (0.091s)
[490.399977] Starting dynamic subtest: vcs0
[490.487279] Dynamic subtest vcs0: SUCCESS (0.097s)
[490.499993] Starting dynamic subtest: vcs1
[490.578902] Dynamic subtest vcs1: SUCCESS (0.090s)
[490.591380] Starting dynamic subtest: vecs0
[490.666095] Dynamic subtest vecs0: SUCCESS (0.085s)
[490.679028] Starting dynamic subtest: ccs0
[490.742610] Dynamic subtest ccs0: SUCCESS (0.075s)
[490.744900] Subtest engines-hostile: SUCCESS (0.535s)
[490.869167] [101/133] (532s left) api_intel_bb (purge-bb)
[490.921123] Starting subtest: purge-bb
[490.926430] Subtest purge-bb: SUCCESS (0.007s)
[491.051190] [102/133] (532s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[491.148760] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[491.152238] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[491.226740] [103/133] (532s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[491.311247] Starting subtest: plane-lut1d-ctm3x4-lut1d
[491.459771] Starting dynamic subtest: pipe-A-plane-0
[491.680076] Dynamic subtest pipe-A-plane-0: SUCCESS (0.221s)
[491.689976] Starting dynamic subtest: pipe-A-plane-1
[491.869092] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[491.878284] Starting dynamic subtest: pipe-A-plane-2
[492.013763] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[493.221867] Starting dynamic subtest: pipe-B-plane-0
[493.364376] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[493.374300] Starting dynamic subtest: pipe-B-plane-1
[493.498493] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[493.508016] Starting dynamic subtest: pipe-B-plane-2
[493.642239] Dynamic subtest pipe-B-plane-2: SUCCESS (0.143s)
[494.856549] Starting dynamic subtest: pipe-C-plane-0
[495.026885] Dynamic subtest pipe-C-plane-0: SUCCESS (0.178s)
[495.043201] Starting dynamic subtest: pipe-C-plane-1
[495.194367] Dynamic subtest pipe-C-plane-1: SUCCESS (0.165s)
[495.205722] Starting dynamic subtest: pipe-C-plane-2
[495.359536] Dynamic subtest pipe-C-plane-2: SUCCESS (0.165s)
[496.557921] Starting dynamic subtest: pipe-D-plane-0
[496.682677] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[496.692957] Starting dynamic subtest: pipe-D-plane-1
[496.815687] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[496.826048] Starting dynamic subtest: pipe-D-plane-2
[496.960294] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[497.255941] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.943s)
[498.065964] [104/133] (525s left) kms_getfb (getfb-handle-zero)
[498.176950] Starting subtest: getfb-handle-zero
[498.179245] Subtest getfb-handle-zero: SUCCESS (0.000s)
[498.270383] [105/133] (525s left) syncobj_timeline (multi-wait-available-signaled)
[498.331529] Starting subtest: multi-wait-available-signaled
[498.334062] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[498.439033] [106/133] (525s left) kms_atomic_transition (plane-all-transition-fencing)
[498.549287] Starting subtest: plane-all-transition-fencing
[498.551610] Starting dynamic subtest: pipe-A-eDP-1
[501.043150] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[501.356224] Starting dynamic subtest: pipe-B-eDP-1
[504.599202] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.253s)
[504.896124] Subtest plane-all-transition-fencing: SUCCESS (6.348s)
[505.714893] [107/133] (518s left) gem_mmap_wc (write-read-distinct)
[505.770863] Subtest write-read-distinct: SKIP (0.000s)
[505.837511] [108/133] (518s left) gem_exec_schedule (wide)
[506.011074] Starting subtest: wide
[506.013394] Starting dynamic subtest: rcs0
[515.773097] Dynamic subtest rcs0: SUCCESS (9.761s)
[515.787195] Starting dynamic subtest: vcs0
[526.550925] Dynamic subtest vcs0: SUCCESS (10.777s)
[526.564101] Starting dynamic subtest: vcs1
[536.033181] Dynamic subtest vcs1: SUCCESS (9.481s)
[536.045773] Starting dynamic subtest: vecs0
[546.386628] Dynamic subtest vecs0: SUCCESS (10.352s)
[546.399173] Starting dynamic subtest: ccs0
[559.310217] Dynamic subtest ccs0: SUCCESS (12.923s)
[559.313021] Subtest wide: SUCCESS (53.300s)
[561.410557] [109/133] (462s left) gem_spin_batch (spin-all)
[561.491521] Starting subtest: spin-all
[561.514391] Subtest spin-all: SUCCESS (0.022s)
[562.950206] [110/133] (461s left) kms_invalid_mode (uint-max-clock)
[563.047375] Starting subtest: uint-max-clock
[563.049737] Starting dynamic subtest: pipe-A-eDP-1
[563.328711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[563.341273] Starting dynamic subtest: pipe-B-eDP-1
[563.343741] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[563.353053] Starting dynamic subtest: pipe-C-eDP-1
[563.355344] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[563.364162] Starting dynamic subtest: pipe-D-eDP-1
[563.366109] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[563.368463] Subtest uint-max-clock: SUCCESS (0.291s)
[564.135583] [111/133] (459s left) i915_selftest (perf)
[567.512469] Starting subtest: perf
[567.515907] Starting dynamic subtest: engine_cs
[571.975557] Dynamic subtest engine_cs: SUCCESS (4.462s)
[571.985759] Starting dynamic subtest: request
[579.338767] Dynamic subtest request: SUCCESS (7.351s)
[579.347077] Starting dynamic subtest: migrate
[583.639980] Dynamic subtest migrate: SUCCESS (4.311s)
[583.650036] Starting dynamic subtest: region
[587.931414] Dynamic subtest region: SUCCESS (4.290s)
[587.933676] Subtest perf: SUCCESS (20.420s)
[587.960378] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[587.961102] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[587.964711] [112/133] (436s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[589.497064] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[589.501621] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[590.712039] [FACT kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[590.713248] [FACT kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)] new: kernel.kmod_is_loaded.i915: true
[590.717593] [113/133] (433s left) gen7_exec_parse (cmd-crossing-page)
[590.782706] Subtest cmd-crossing-page: SKIP (0.000s)
[590.847571] [114/133] (433s left) kms_big_fb (y-tiled-addfb)
[590.941797] Starting subtest: y-tiled-addfb
[590.946209] Subtest y-tiled-addfb: SKIP (0.000s)
[591.037203] [115/133] (433s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[591.096093] Starting subtest: single-wait-for-submit-available-signaled
[591.098452] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[591.190359] [116/133] (433s left) kms_plane_scaling (planes-downscale-factor-0-75)
[591.291708] Starting subtest: planes-downscale-factor-0-75
[591.293937] Starting dynamic subtest: pipe-A
[591.316693] Dynamic subtest pipe-A: SKIP (0.021s)
[591.326114] Starting dynamic subtest: pipe-B
[591.362757] Dynamic subtest pipe-B: SKIP (0.043s)
[591.371047] Starting dynamic subtest: pipe-C
[591.399698] Dynamic subtest pipe-C: SKIP (0.038s)
[591.408040] Starting dynamic subtest: pipe-D
[591.440791] Dynamic subtest pipe-D: SKIP (0.039s)
[591.445061] Subtest planes-downscale-factor-0-75: SKIP (0.144s)
[591.540051] [117/133] (432s left) gem_pipe_control_store_loop (fresh-buffer)
[591.588298] Starting subtest: fresh-buffer
[593.745544] Subtest fresh-buffer: SUCCESS (2.154s)
[593.846995] [118/133] (430s left) syncobj_wait (wait-all-complex)
[593.914105] Starting subtest: wait-all-complex
[594.128602] Subtest wait-all-complex: SUCCESS (0.215s)
[594.213431] [119/133] (430s left) gem_ctx_shared (exec-single-timeline)
[594.266871] Starting subtest: exec-single-timeline
[594.269336] Starting dynamic subtest: rcs0
[595.311122] Dynamic subtest rcs0: SUCCESS (1.044s)
[595.322385] Starting dynamic subtest: bcs0
[596.337529] Dynamic subtest bcs0: SUCCESS (1.023s)
[596.350618] Starting dynamic subtest: vcs0
[597.425369] Dynamic subtest vcs0: SUCCESS (1.084s)
[597.438065] Starting dynamic subtest: vcs1
[598.514068] Dynamic subtest vcs1: SUCCESS (1.086s)
[598.526750] Starting dynamic subtest: vecs0
[599.603374] Dynamic subtest vecs0: SUCCESS (1.086s)
[599.615931] Starting dynamic subtest: ccs0
[600.690335] Dynamic subtest ccs0: SUCCESS (1.085s)
[600.692873] Subtest exec-single-timeline: SUCCESS (6.424s)
[600.879648] [120/133] (423s left) gem_mmap_gtt (basic-short)
[600.935918] Subtest basic-short: SKIP (0.000s)
[600.993435] [121/133] (423s left) syncobj_eventfd (binary-wait-before-signal)
[601.039397] Starting subtest: binary-wait-before-signal
[601.067963] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[601.172222] [122/133] (423s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[601.261282] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[601.265296] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[601.333935] [123/133] (423s left) gem_exec_schedule (implicit-write-read)
[601.399919] Starting subtest: implicit-write-read
[601.402166] Starting dynamic subtest: rcs0
[601.488305] Dynamic subtest rcs0: SUCCESS (0.100s)
[601.501465] Starting dynamic subtest: vcs0
[601.583029] Dynamic subtest vcs0: SUCCESS (0.093s)
[601.595046] Starting dynamic subtest: vcs1
[601.666416] Dynamic subtest vcs1: SUCCESS (0.083s)
[601.682766] Starting dynamic subtest: vecs0
[601.744529] Dynamic subtest vecs0: SUCCESS (0.077s)
[601.756174] Starting dynamic subtest: ccs0
[601.821375] Dynamic subtest ccs0: SUCCESS (0.076s)
[601.823477] Subtest implicit-write-read: SUCCESS (0.434s)
[603.001847] [124/133] (421s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[603.100326] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[603.104667] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[603.185087] [125/133] (421s left) i915_pm_rpm (system-suspend-devices)
[605.040056] Starting subtest: system-suspend-devices
[612.723928] Subtest system-suspend-devices: SUCCESS (7.687s)
[613.114763] [126/133] (411s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[613.228807] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[613.233100] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[613.315827] [127/133] (411s left) kms_lease (lease-revoke)
[613.394375] Starting subtest: lease-revoke
[613.396783] Starting dynamic subtest: pipe-A-eDP-1
[613.422554] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[613.434900] Starting dynamic subtest: pipe-B-eDP-1
[613.449840] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[613.459657] Starting dynamic subtest: pipe-C-eDP-1
[613.477309] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[613.487244] Starting dynamic subtest: pipe-D-eDP-1
[613.514105] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.032s)
[613.516406] Subtest lease-revoke: SUCCESS (0.120s)
[613.661204] [128/133] (411s left) kms_async_flips (alternate-sync-async-flip-atomic)
[613.771161] Starting subtest: alternate-sync-async-flip-atomic
[614.149269] Starting dynamic subtest: pipe-A-eDP-1
[616.896724] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.750s)
[617.266737] Starting dynamic subtest: pipe-B-eDP-1
[620.029758] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.771s)
[620.397611] Starting dynamic subtest: pipe-C-eDP-1
[623.163843] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.774s)
[623.531665] Starting dynamic subtest: pipe-D-eDP-1
[626.294856] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.773s)
[626.297288] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.527s)
[627.471232] [129/133] (397s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[627.572176] Starting subtest: fbc-tiling-linear
[631.244585] Subtest fbc-tiling-linear: SUCCESS (3.677s)
[632.366464] [130/133] (392s left) gem_ctx_shared (create-shared-gtt)
[632.428964] Starting subtest: create-shared-gtt
[634.579051] Subtest create-shared-gtt: SUCCESS (2.152s)
[634.917155] [131/133] (390s left) kms_pm_rpm (pc8-residency)
[637.050036] Starting subtest: pc8-residency
[637.055403] Subtest pc8-residency: SKIP (0.000s)
[637.422044] [132/133] (387s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[637.507556] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[637.511852] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[637.608521] [133/133] (387s left) gem_exec_balancer (nohangcheck)
[637.864302] Starting subtest: nohangcheck
[638.725110] Subtest nohangcheck: SUCCESS (0.861s)
[638.826964] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: gem_exec_fence
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: gem_exec_reloc
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_render_copy_redux
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: kms_busy
results: parsing output: 12/ for test: prime_busy
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_setmode
results: parsing output: 15/ for test: prime_self_import
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: kms_pm_lpsp
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: i915_drm_fdinfo
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: kms_dp_linktrain_fallback
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: sysfs_heartbeat_interval
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_lmem_swapping
results: parsing output: 28/ for test: prime_udl
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: fbdev
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: kms_chamelium_frames
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: drm_mm
results: parsing output: 39/ for test: gem_pread
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_rmfb
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_cursor_edge_walk
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_partial_pwrite_pread
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: vgem_basic
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: kms_fbcon_fbt
results: parsing output: 58/ for test: i915_drm_fdinfo
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: kms_prop_blob
results: parsing output: 65/ for test: prime_self_import
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: sw_sync
results: parsing output: 74/ for test: kms_atomic_interruptible
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_tiled_display
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: prime_vgem
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_plane_alpha_blend
results: parsing output: 84/ for test: kms_feature_discovery
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_pxp
results: parsing output: 87/ for test: kms_plane_multiple
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: gem_mmap_offset
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_create
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_ctx_persistence
results: parsing output: 100/ for test: api_intel_bb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_color_pipeline
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_atomic_transition
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: gem_spin_batch
results: parsing output: 109/ for test: kms_invalid_mode
results: parsing output: 110/ for test: i915_selftest
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: gen7_exec_parse
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: gem_pipe_control_store_loop
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: gem_ctx_shared
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_plane
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: i915_pm_rpm
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_lease
results: parsing output: 127/ for test: kms_async_flips
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_ctx_shared
results: parsing output: 130/ for test: kms_pm_rpm
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_balancer
Done.