[60.652057] Initializing watchdogs
[60.652203]   /dev/watchdog0
[60.667386] [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]
[60.671852] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.674173] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.678158] [001/133] (960s left) kms_cursor_crc (cursor-random-32x32)
[60.862776] Starting subtest: cursor-random-32x32
[60.911934] Subtest cursor-random-32x32: SKIP (0.047s)
[61.180265] [002/133] (960s left) gem_exec_schedule (timeslicing)
[61.259645] Starting subtest: timeslicing
[61.261960] Starting dynamic subtest: rcs0
[61.273432] Dynamic subtest rcs0: SUCCESS (0.019s)
[61.282324] Starting dynamic subtest: bcs0
[61.293329] Dynamic subtest bcs0: SUCCESS (0.020s)
[61.301003] Starting dynamic subtest: vcs0
[61.314097] Dynamic subtest vcs0: SUCCESS (0.020s)
[61.321443] Starting dynamic subtest: vcs1
[61.333676] Dynamic subtest vcs1: SUCCESS (0.019s)
[61.340885] Starting dynamic subtest: vecs0
[61.354833] Dynamic subtest vecs0: SUCCESS (0.020s)
[61.363569] Starting dynamic subtest: ccs0
[61.378191] Dynamic subtest ccs0: SUCCESS (0.022s)
[61.380508] Subtest timeslicing: SUCCESS (0.124s)
[62.971793] [003/133] (958s left) kms_plane (plane-panning-top-left)
[63.063166] Starting subtest: plane-panning-top-left
[63.065359] Starting dynamic subtest: pipe-A
[64.799320] Dynamic subtest pipe-A: SUCCESS (1.731s)
[64.811514] Starting dynamic subtest: pipe-B
[67.147569] Dynamic subtest pipe-B: SUCCESS (2.343s)
[67.150138] Subtest plane-panning-top-left: SUCCESS (4.075s)
[67.964474] [004/133] (953s left) kms_busy (basic)
[68.062875] Starting subtest: basic
[68.065224] Starting dynamic subtest: flip
[68.676793] Dynamic subtest flip: SUCCESS (0.613s)
[68.686922] Starting dynamic subtest: modeset
[72.098756] Dynamic subtest modeset: SUCCESS (3.418s)
[72.101187] Subtest basic: SUCCESS (4.032s)
[72.897938] [005/133] (948s left) kms_addfb_basic (basic-x-tiled-legacy)
[72.961091] Starting subtest: basic-x-tiled-legacy
[72.965931] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[73.091276] [006/133] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[73.190692] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[77.430484] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.241s)
[78.616727] [007/133] (942s left) gem_vm_create (execbuf)
[78.674946] Starting subtest: execbuf
[78.682863] Subtest execbuf: SUCCESS (0.008s)
[78.791587] [008/133] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[78.891791] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[87.535696] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.644s)
[87.659559] [009/133] (933s left) gem_ctx_param (basic-default)
[87.712360] Starting subtest: basic-default
[87.714768] Subtest basic-default: SUCCESS (0.000s)
[87.781917] [010/133] (933s left) kms_properties (crtc-properties-atomic)
[87.877046] Starting subtest: crtc-properties-atomic
[87.879489] Starting dynamic subtest: pipe-A-eDP-1
[88.309811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.430s)
[88.319459] Starting dynamic subtest: pipe-B-eDP-1
[89.453501] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.144s)
[89.463717] Starting dynamic subtest: pipe-C-eDP-1
[90.577722] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[90.587901] Starting dynamic subtest: pipe-D-eDP-1
[91.709045] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[91.711705] Subtest crtc-properties-atomic: SUCCESS (3.829s)
[92.529955] [011/133] (929s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[92.635194] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[92.637862] Starting dynamic subtest: pipe-A-default-mode
[95.349244] Dynamic subtest pipe-A-default-mode: SUCCESS (2.712s)
[95.351692] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.714s)
[96.213313] [012/133] (925s left) gem_pread (bench)
[96.275931] Subtest bench: SKIP (0.000s)
[96.338785] [013/133] (925s left) prime_mmap_coherency (write)
[96.402575] Starting subtest: write
[101.782855] Subtest write: SUCCESS (5.376s)
[101.924532] [014/133] (919s left) gem_exec_reloc (basic-cpu)
[101.985712] Subtest basic-cpu: SKIP (0.000s)
[102.048896] [015/133] (919s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[102.152988] Starting subtest: fbc-tiling-linear
[105.839552] Subtest fbc-tiling-linear: SUCCESS (3.689s)
[107.032805] [016/133] (914s left) kms_psr (fbc-psr2-basic)
[107.130654] Starting subtest: fbc-psr2-basic
[107.133039] Starting dynamic subtest: eDP-1
[107.137689] Dynamic subtest eDP-1: SKIP (0.000s)
[107.142369] Subtest fbc-psr2-basic: SKIP (0.001s)
[107.199807] [017/133] (914s left) kms_chamelium_frames (dp-crc-single)
[107.591339] Subtest dp-crc-single: SKIP (0.000s)
[108.428158] [018/133] (913s left) kms_vblank (wait-forked)
[108.527449] Starting subtest: wait-forked
[108.529945] Starting dynamic subtest: pipe-A-eDP-1
[110.358446] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.828s)
[110.373709] Starting dynamic subtest: pipe-D-eDP-1
[112.859819] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.498s)
[112.861800] Subtest wait-forked: SUCCESS (4.330s)
[113.731906] [019/133] (908s left) i915_hangman (gt-engine-hang)
[113.801834] Starting subtest: gt-engine-hang
[113.804231] Starting dynamic subtest: rcs0
[114.870053] Dynamic subtest rcs0: SUCCESS (1.068s)
[114.881449] Starting dynamic subtest: bcs0
[116.852630] Dynamic subtest bcs0: SUCCESS (1.981s)
[116.863836] Starting dynamic subtest: vcs0
[118.901320] Dynamic subtest vcs0: SUCCESS (2.047s)
[118.913509] Starting dynamic subtest: vcs1
[120.883515] Dynamic subtest vcs1: SUCCESS (1.980s)
[120.894750] Starting dynamic subtest: vecs0
[122.868461] Dynamic subtest vecs0: SUCCESS (1.983s)
[122.879797] Starting dynamic subtest: ccs0
[124.852063] Dynamic subtest ccs0: SUCCESS (1.981s)
[124.854934] Subtest gt-engine-hang: SUCCESS (11.050s)
[124.961900] [020/133] (896s left) syncobj_eventfd (timeline-wait-signaled)
[125.021785] Starting subtest: timeline-wait-signaled
[125.024100] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[125.134467] [021/133] (896s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[125.231377] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[125.235466] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[125.293295] [022/133] (896s left) api_intel_allocator (fork-simple-stress)
[125.345674] Starting subtest: fork-simple-stress
[130.741581] Subtest fork-simple-stress: SUCCESS (5.396s)
[130.853008] [023/133] (891s left) gem_mmap_wc (coherency)
[130.913855] Subtest coherency: SKIP (0.000s)
[130.980471] [024/133] (891s left) gem_exec_schedule (pi-common)
[131.174857] Starting subtest: pi-common
[131.177369] Starting dynamic subtest: rcs0
[131.260927] Dynamic subtest rcs0: SUCCESS (0.090s)
[131.269416] Starting dynamic subtest: bcs0
[131.293889] Dynamic subtest bcs0: SUCCESS (0.033s)
[131.301787] Starting dynamic subtest: vcs0
[131.326042] Dynamic subtest vcs0: SUCCESS (0.032s)
[131.333904] Starting dynamic subtest: vcs1
[131.358678] Dynamic subtest vcs1: SUCCESS (0.032s)
[131.367258] Starting dynamic subtest: vecs0
[131.392328] Dynamic subtest vecs0: SUCCESS (0.033s)
[131.399905] Starting dynamic subtest: ccs0
[131.426201] Dynamic subtest ccs0: SUCCESS (0.033s)
[131.429695] Subtest pi-common: SUCCESS (0.256s)
[131.674302] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[131.677652] [025/133] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[131.781503] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[131.786045] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[131.900428] [026/133] (890s left) gem_mmap (basic)
[131.972104] Subtest basic: SKIP (0.000s)
[132.034926] [027/133] (890s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[132.159965] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[132.164354] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[132.288780] [028/133] (889s left) syncobj_wait (invalid-reset-one-illegal-handle)
[132.359225] Starting subtest: invalid-reset-one-illegal-handle
[132.361624] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[132.471034] [029/133] (889s left) gem_readwrite (new-obj)
[132.531261] Subtest new-obj: SKIP (0.000s)
[132.605686] [030/133] (889s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[132.723283] Starting subtest: yf-tiled-8bpp-rotate-0
[132.726959] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[132.838081] [031/133] (889s left) sysfs_heartbeat_interval (invalid)
[132.917619] Starting subtest: invalid
[132.919834] Starting dynamic subtest: vecs0
[132.922041] Dynamic subtest vecs0: SUCCESS (0.000s)
[132.933531] Starting dynamic subtest: ccs0
[132.935456] Dynamic subtest ccs0: SUCCESS (0.000s)
[132.946804] Starting dynamic subtest: vcs0
[132.948966] Dynamic subtest vcs0: SUCCESS (0.000s)
[132.959771] Starting dynamic subtest: bcs0
[132.961877] Dynamic subtest bcs0: SUCCESS (0.000s)
[132.973217] Starting dynamic subtest: rcs0
[132.975018] Dynamic subtest rcs0: SUCCESS (0.000s)
[132.986253] Starting dynamic subtest: vcs1
[132.988275] Dynamic subtest vcs1: SUCCESS (0.000s)
[132.990161] Subtest invalid: SUCCESS (0.007s)
[133.032921] [032/133] (889s left) gem_sync (basic-all)
[133.099633] Starting subtest: basic-all
[136.854240] Subtest basic-all: SUCCESS (3.759s)
[137.045076] [033/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[137.144651] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[137.148810] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[137.241236] [034/133] (885s left) kms_hdr (bpc-switch-suspend)
[137.334847] Starting subtest: bpc-switch-suspend
[138.391229] Starting dynamic subtest: pipe-A-eDP-1
[158.116086] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.627s)
[158.118987] Subtest bpc-switch-suspend: SUCCESS (6.682s)
[158.243939] [035/133] (864s left) gem_spin_batch (legacy-resubmit)
[158.325070] Starting subtest: legacy-resubmit
[158.328060] Starting dynamic subtest: default
[158.333815] Dynamic subtest default: SUCCESS (0.007s)
[158.344357] Starting dynamic subtest: render
[158.347130] Dynamic subtest render: SUCCESS (0.001s)
[158.355368] Starting dynamic subtest: bsd
[158.357737] Dynamic subtest bsd: SUCCESS (0.003s)
[158.366325] Starting dynamic subtest: bsd1
[158.368767] Dynamic subtest bsd1: SUCCESS (0.001s)
[158.376954] Starting dynamic subtest: bsd2
[158.379641] Dynamic subtest bsd2: SUCCESS (0.003s)
[158.387754] Starting dynamic subtest: blt
[158.390067] Dynamic subtest blt: SUCCESS (0.003s)
[158.398179] Starting dynamic subtest: vebox
[158.400712] Dynamic subtest vebox: SUCCESS (0.003s)
[158.402930] Subtest legacy-resubmit: SUCCESS (0.024s)
[158.583762] [036/133] (863s left) kms_vrr (seamless-rr-switch-drrs)
[158.676837] Starting subtest: seamless-rr-switch-drrs
[158.684034] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[158.756256] [037/133] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[158.853202] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[158.858078] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[158.962283] [038/133] (863s left) gem_exec_balancer (bonded-semaphore)
[159.024887] Starting subtest: bonded-semaphore
[159.029831] Subtest bonded-semaphore: SKIP (0.000s)
[159.321420] [039/133] (863s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[159.368875] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[159.411919] [040/133] (863s left) kms_content_protection (dp-mst-lic-type-1)
[159.552172] Starting subtest: dp-mst-lic-type-1
[159.557081] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[159.667149] [041/133] (863s left) kms_atomic (plane-overlay-legacy)
[159.761921] Starting subtest: plane-overlay-legacy
[159.764799] Starting dynamic subtest: pipe-A-eDP-1
[160.196942] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[160.199528] Subtest plane-overlay-legacy: SUCCESS (0.422s)
[161.081405] [042/133] (861s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[161.193955] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[168.089023] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.804s)
[168.202204] [043/133] (854s left) kms_plane_multiple (tiling-x)
[168.291974] Starting subtest: tiling-x
[168.294643] Starting dynamic subtest: pipe-A-eDP-1
[172.024251] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.708s)
[172.036038] Starting dynamic subtest: pipe-B-eDP-1
[176.388736] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.344s)
[176.398057] Starting dynamic subtest: pipe-C-eDP-1
[180.722298] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.321s)
[180.733559] Starting dynamic subtest: pipe-D-eDP-1
[185.078193] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.350s)
[185.081084] Subtest tiling-x: SUCCESS (16.727s)
[185.893957] [044/133] (836s left) gem_mmap_offset (close-race)
[185.955903] Starting subtest: close-race
[206.071727] Subtest close-race: SUCCESS (20.112s)
[206.191909] [045/133] (816s left) perf_pmu (semaphore-busy)
[206.232349] Starting subtest: semaphore-busy
[206.234892] Starting dynamic subtest: rcs0
[207.879945] Dynamic subtest rcs0: SUCCESS (1.646s)
[207.891928] Starting dynamic subtest: bcs0
[209.521930] Dynamic subtest bcs0: SUCCESS (1.637s)
[209.532295] Starting dynamic subtest: vcs0
[213.518864] Dynamic subtest vcs0: SUCCESS (3.994s)
[213.530102] Starting dynamic subtest: vcs1
[219.470906] Dynamic subtest vcs1: SUCCESS (5.946s)
[219.482260] Starting dynamic subtest: vecs0
[225.486975] Dynamic subtest vecs0: SUCCESS (6.011s)
[225.498483] Starting dynamic subtest: ccs0
[227.566495] Dynamic subtest ccs0: FAIL (2.015s)
[227.568959] Subtest semaphore-busy: FAIL (21.265s)
[227.616091] [046/133] (795s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[227.716880] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[227.721665] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[227.830543] [047/133] (795s left) gem_exec_reloc (basic-write-cpu-noreloc)
[227.889022] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[227.966391] [048/133] (795s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[228.064532] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[228.899595] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[229.063524] [049/133] (794s left) kms_flip (dpms-off-confusion-interruptible)
[229.159660] Starting subtest: dpms-off-confusion-interruptible
[229.162049] Starting dynamic subtest: A-eDP1
[237.792701] Dynamic subtest A-eDP1: SUCCESS (8.627s)
[237.807240] Starting dynamic subtest: B-eDP1
[246.425193] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[246.437594] Starting dynamic subtest: C-eDP1
[255.048605] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[255.059076] Starting dynamic subtest: D-eDP1
[263.693695] Dynamic subtest D-eDP1: SUCCESS (8.648s)
[263.698811] Subtest dpms-off-confusion-interruptible: SUCCESS (34.532s)
[264.847873] [050/133] (758s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[264.953457] Starting subtest: crc-primary-basic-y-tiled-ccs
[264.955760] Starting dynamic subtest: pipe-A-eDP-1
[264.977467] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[264.987649] Starting dynamic subtest: pipe-B-eDP-1
[265.012706] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.021047] Starting dynamic subtest: pipe-C-eDP-1
[265.045954] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.054300] Starting dynamic subtest: pipe-D-eDP-1
[265.080011] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.085189] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[267.213789] [051/133] (755s left) gem_exec_gttfill (multigpu-basic)
[267.386430] Starting subtest: multigpu-basic
[280.165525] Subtest multigpu-basic: SUCCESS (12.783s)
[280.220985] [052/133] (743s left) kms_cursor_crc (cursor-alpha-opaque)
[280.364916] Starting subtest: cursor-alpha-opaque
[280.367817] Starting dynamic subtest: pipe-A-eDP-1
[281.029061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.661s)
[281.039082] Starting dynamic subtest: pipe-D-eDP-1
[282.291711] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.264s)
[282.294566] Subtest cursor-alpha-opaque: SUCCESS (1.928s)
[283.091003] [053/133] (740s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[283.180713] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[290.484026] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.306s)
[290.622572] [054/133] (732s left) kms_flip (flip-vs-suspend-interruptible)
[290.721066] Starting subtest: flip-vs-suspend-interruptible
[290.723583] Starting dynamic subtest: A-eDP1
[339.989793] Dynamic subtest A-eDP1: SUCCESS (4.550s)
[340.000179] Starting dynamic subtest: B-eDP1
[389.017633] Dynamic subtest B-eDP1: SUCCESS (4.511s)
[389.032856] Starting dynamic subtest: C-eDP1
[438.002482] Dynamic subtest C-eDP1: SUCCESS (4.512s)
[438.012757] Starting dynamic subtest: D-eDP1
[487.005868] Dynamic subtest D-eDP1: SUCCESS (4.487s)
[487.008529] Subtest flip-vs-suspend-interruptible: SUCCESS (18.069s)
[488.216972] [055/133] (535s left) kms_psr (pr-cursor-plane-onoff)
[488.326274] Starting subtest: pr-cursor-plane-onoff
[488.331256] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[488.400621] [056/133] (535s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[488.499369] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[488.502139] Starting dynamic subtest: pipe-A-eDP-1
[494.455873] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.847s)
[494.465575] Starting dynamic subtest: pipe-B-eDP-1
[501.170067] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.651s)
[501.172648] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.500s)
[502.041995] [057/133] (521s left) kms_dp_link_training (uhbr-sst)
[502.145136] Starting subtest: uhbr-sst
[502.155990] Subtest uhbr-sst: SKIP (0.000s)
[502.219897] [058/133] (521s left) gem_ctx_persistence (processes)
[502.285408] Starting subtest: processes
[503.795504] Subtest processes: SUCCESS (1.503s)
[503.879536] [059/133] (519s left) gem_exec_reloc (basic-write-wc-active)
[503.955014] Subtest basic-write-wc-active: SKIP (0.000s)
[504.020695] [060/133] (519s left) kms_addfb_basic (bad-pitch-128)
[504.079940] Starting subtest: bad-pitch-128
[504.082921] Subtest bad-pitch-128: SUCCESS (0.000s)
[504.222749] [061/133] (519s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[504.322831] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[508.807462] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.476s)
[509.969493] [062/133] (513s left) syncobj_timeline (wait-all-complex)
[510.040250] Starting subtest: wait-all-complex
[510.257646] Subtest wait-all-complex: SUCCESS (0.215s)
[510.338063] [063/133] (513s left) gem_eio (in-flight-10ms)
[510.575921] Starting subtest: in-flight-10ms
[518.801708] Subtest in-flight-10ms: SUCCESS (8.216s)
[518.974636] [064/133] (504s left) kms_big_fb (linear-32bpp-rotate-90)
[519.089023] Starting subtest: linear-32bpp-rotate-90
[519.113850] Subtest linear-32bpp-rotate-90: SKIP (0.024s)
[519.217227] [065/133] (504s left) syncobj_timeline (reset-multiple-signaled)
[519.274125] Starting subtest: reset-multiple-signaled
[519.277169] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[519.367662] [066/133] (504s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[519.484204] Starting subtest: 2x-long-flip-vs-cursor-legacy
[519.489615] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[519.630867] [067/133] (504s left) gem_ctx_shared (q-smoketest)
[519.695438] Starting subtest: Q-smoketest
[519.697794] Starting dynamic subtest: rcs0
[525.259694] Dynamic subtest rcs0: SUCCESS (5.509s)
[525.270351] Starting dynamic subtest: bcs0
[530.752462] Dynamic subtest bcs0: SUCCESS (5.490s)
[530.766322] Starting dynamic subtest: vcs0
[536.247233] Dynamic subtest vcs0: SUCCESS (5.490s)
[536.262030] Starting dynamic subtest: vcs1
[541.726164] Dynamic subtest vcs1: SUCCESS (5.479s)
[541.738416] Starting dynamic subtest: vecs0
[547.219395] Dynamic subtest vecs0: SUCCESS (5.494s)
[547.233900] Starting dynamic subtest: ccs0
[552.729901] Dynamic subtest ccs0: SUCCESS (5.504s)
[552.732169] Subtest Q-smoketest: SUCCESS (32.972s)
[552.905539] [068/133] (471s left) kms_plane_alpha_blend (alpha-transparent-fb)
[553.012126] Starting subtest: alpha-transparent-fb
[553.306089] Starting dynamic subtest: pipe-A-eDP-1
[553.916912] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[553.927038] Starting dynamic subtest: pipe-D-eDP-1
[555.330848] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.410s)
[555.333599] Subtest alpha-transparent-fb: SUCCESS (2.320s)
[556.128565] [069/133] (467s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[556.250218] Starting subtest: cursorB-vs-flipA-atomic-transitions
[556.255019] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[556.405646] [070/133] (467s left) gem_exec_reloc (basic-wc-gtt-active)
[556.457111] Subtest basic-wc-gtt-active: SKIP (0.000s)
[556.533730] [071/133] (467s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[556.652692] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[567.830878] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.174s)
[568.661170] [072/133] (455s left) gem_exec_whisper (basic-forked)
[568.746506] Starting subtest: basic-forked
[576.703718] Subtest basic-forked: SUCCESS (7.951s)
[576.903099] [073/133] (447s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[577.009960] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[577.019732] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[577.103275] [074/133] (447s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[577.208085] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[577.213523] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[577.313310] [075/133] (446s left) syncobj_wait (single-wait-all-submitted)
[577.373433] Starting subtest: single-wait-all-submitted
[577.478890] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[577.570850] [076/133] (446s left) i915_suspend (debugfs-reader)
[577.641216] Starting subtest: debugfs-reader
[595.973672] Subtest debugfs-reader: SUCCESS (3.127s)
[596.110384] [077/133] (428s left) kms_cursor_edge_walk (128x128-top-edge)
[596.213762] Starting subtest: 128x128-top-edge
[596.216395] Starting dynamic subtest: pipe-A-eDP-1
[599.708751] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.410s)
[599.718929] Starting dynamic subtest: pipe-D-eDP-1
[602.891438] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[602.893740] Subtest 128x128-top-edge: SUCCESS (6.542s)
[603.720087] [078/133] (420s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[603.816830] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[603.819640] Starting dynamic subtest: pipe-A-eDP-1
[604.543143] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[604.559183] Starting dynamic subtest: pipe-B-eDP-1
[606.359813] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.796s)
[606.370745] Starting dynamic subtest: pipe-C-eDP-1
[608.114424] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.740s)
[608.124563] Starting dynamic subtest: pipe-D-eDP-1
[609.860530] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.734s)
[609.863047] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.987s)
[611.022514] [079/133] (413s left) gen9_exec_parse (basic-rejected)
[611.079320] Subtest basic-rejected: SKIP (0.000s)
[611.144132] [080/133] (413s left) api_intel_bb (object-noreloc-keep-cache-simple)
[611.206346] Starting subtest: object-noreloc-keep-cache-simple
[611.209566] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[611.335711] [081/133] (413s left) kms_selftest (drm_cmdline_parser)
[611.380399] Starting subtest: drm_cmdline_parser
[611.412647] Starting dynamic subtest: drm_test_cmdline_force_d_only
[611.500798] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.087s)
[611.512254] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[611.596579] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.094s)
[611.607531] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[611.684472] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.087s)
[611.696234] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[611.781737] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.095s)
[611.791712] Starting dynamic subtest: drm_test_cmdline_force_e_only
[611.859914] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.076s)
[611.871742] Starting dynamic subtest: drm_test_cmdline_res
[611.959053] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.100s)
[611.968909] Starting dynamic subtest: drm_test_cmdline_res_vesa
[612.050442] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.088s)
[612.062294] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[612.136190] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.082s)
[612.146930] Starting dynamic subtest: drm_test_cmdline_res_rblank
[612.229072] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.094s)
[612.238910] Starting dynamic subtest: drm_test_cmdline_res_bpp
[612.330308] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.099s)
[612.340149] Starting dynamic subtest: drm_test_cmdline_res_refresh
[612.422129] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.090s)
[612.431916] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[612.515693] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.090s)
[612.525130] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[612.597529] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.082s)
[612.606971] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[612.695482] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.097s)
[612.705746] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[612.777695] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.082s)
[612.787527] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[612.861676] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.082s)
[612.871483] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[612.960611] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.099s)
[612.972345] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[613.054587] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.093s)
[613.064773] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[613.151165] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.093s)
[613.162205] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[613.250880] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.099s)
[613.261325] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[613.335674] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.083s)
[613.345891] Starting dynamic subtest: drm_test_cmdline_name
[613.428192] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.090s)
[613.437755] Starting dynamic subtest: drm_test_cmdline_name_bpp
[613.520441] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.091s)
[613.530103] Starting dynamic subtest: drm_test_cmdline_name_option
[613.623879] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.101s)
[613.633788] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[613.721637] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.096s)
[613.732952] Starting dynamic subtest: drm_test_cmdline_rotate_0
[613.814656] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.092s)
[613.825565] Starting dynamic subtest: drm_test_cmdline_rotate_90
[613.907741] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.092s)
[613.918258] Starting dynamic subtest: drm_test_cmdline_rotate_180
[613.996711] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.089s)
[614.006770] Starting dynamic subtest: drm_test_cmdline_rotate_270
[614.092681] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.093s)
[614.103683] Starting dynamic subtest: drm_test_cmdline_hmirror
[614.182711] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.089s)
[614.193734] Starting dynamic subtest: drm_test_cmdline_vmirror
[614.276726] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.093s)
[614.287288] Starting dynamic subtest: drm_test_cmdline_margin_options
[614.369693] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.091s)
[614.380530] Starting dynamic subtest: drm_test_cmdline_multiple_options
[614.452582] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.083s)
[614.462731] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[614.541555] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.086s)
[614.552637] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[614.625200] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.083s)
[614.635833] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[614.721479] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.095s)
[614.732755] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[614.807534] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.085s)
[614.817541] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[614.905186] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.094s)
[614.914746] Starting dynamic subtest: drm_test_cmdline_invalid
[614.994572] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.088s)
[615.004608] Starting dynamic subtest: drm_test_cmdline_tv_options
[615.090605] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.095s)
[615.092912] Subtest drm_cmdline_parser: SUCCESS (3.697s)
[615.261224] [082/133] (409s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[615.374526] Starting subtest: x-tiled-16bpp-rotate-270
[615.394534] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[615.497724] [083/133] (409s left) gen3_render_tiledx_blits
[615.620007] [084/133] (409s left) perf (whitelisted-registers-userspace-config)
[615.790209] Starting subtest: whitelisted-registers-userspace-config
[615.792148] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[615.832138] [085/133] (408s left) gem_exec_fence (parallel)
[616.005511] Starting subtest: parallel
[616.008515] Starting dynamic subtest: rcs0
[618.159509] Dynamic subtest rcs0: SUCCESS (2.149s)
[618.170714] Starting dynamic subtest: bcs0
[620.318855] Dynamic subtest bcs0: SUCCESS (2.155s)
[620.330002] Starting dynamic subtest: vcs0
[622.476175] Dynamic subtest vcs0: SUCCESS (2.153s)
[622.491495] Starting dynamic subtest: vcs1
[624.634527] Dynamic subtest vcs1: SUCCESS (2.154s)
[624.645347] Starting dynamic subtest: vecs0
[626.791905] Dynamic subtest vecs0: SUCCESS (2.154s)
[626.803533] Starting dynamic subtest: ccs0
[628.942133] Dynamic subtest ccs0: SUCCESS (2.148s)
[628.944711] Subtest parallel: SUCCESS (12.918s)
[630.169729] [086/133] (394s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[630.267833] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[630.272693] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[630.374141] [087/133] (394s left) dumb_buffer (map-uaf)
[630.435136] Starting subtest: map-uaf
[630.437940] Subtest map-uaf: SUCCESS (0.004s)
[630.529852] [088/133] (394s left) kms_psr (psr-sprite-render)
[630.618801] Starting subtest: psr-sprite-render
[630.621426] Starting dynamic subtest: eDP-1
[632.396140] Dynamic subtest eDP-1: SUCCESS (1.777s)
[632.398784] Subtest psr-sprite-render: SUCCESS (1.778s)
[633.235691] [089/133] (391s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[633.305749] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[633.407038] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[633.489265] [090/133] (391s left) gem_linear_blits (normal)
[633.731539] Starting subtest: normal
[638.232191] Subtest normal: SUCCESS (4.504s)
[638.370576] [091/133] (386s left) perf_pmu (init-wait)
[638.457357] Starting subtest: init-wait
[638.459921] Starting dynamic subtest: rcs0
[638.462791] Dynamic subtest rcs0: SUCCESS (0.001s)
[638.474907] Starting dynamic subtest: bcs0
[638.477310] Dynamic subtest bcs0: SUCCESS (0.001s)
[638.489899] Starting dynamic subtest: vcs0
[638.492574] Dynamic subtest vcs0: SUCCESS (0.001s)
[638.502123] Starting dynamic subtest: vcs1
[638.504427] Dynamic subtest vcs1: SUCCESS (0.001s)
[638.516789] Starting dynamic subtest: vecs0
[638.519587] Dynamic subtest vecs0: SUCCESS (0.001s)
[638.529023] Starting dynamic subtest: ccs0
[638.530900] Dynamic subtest ccs0: SUCCESS (0.001s)
[638.533055] Subtest init-wait: SUCCESS (0.008s)
[638.574183] [092/133] (386s left) i915_drm_fdinfo (context-close-stress)
[638.615790] Starting subtest: context-close-stress
[649.366365] Subtest context-close-stress: SUCCESS (10.747s)
[649.439368] [093/133] (375s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[649.720621] Starting subtest: 2x-long-cursor-vs-flip-legacy
[649.725904] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s)
[649.875067] [094/133] (375s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[649.967820] Starting subtest: bad-aux-stride-y-tiled-ccs
[649.970396] Starting dynamic subtest: pipe-A-eDP-1
[649.995444] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[650.006179] Starting dynamic subtest: pipe-B-eDP-1
[650.032440] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[650.042658] Starting dynamic subtest: pipe-C-eDP-1
[650.069022] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[650.078700] Starting dynamic subtest: pipe-D-eDP-1
[650.105701] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[650.110662] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[652.208971] [095/133] (372s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[652.318744] Starting subtest: 4-tiled-16bpp-rotate-270
[652.338663] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[652.452589] [096/133] (372s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[652.540864] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[652.543620] Starting dynamic subtest: pipe-A-eDP-1
[652.612471] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[652.622757] Starting dynamic subtest: pipe-B-eDP-1
[652.682599] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[652.692648] Starting dynamic subtest: pipe-C-eDP-1
[652.751904] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[652.761405] Starting dynamic subtest: pipe-D-eDP-1
[652.826472] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[652.831416] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[654.704399] [097/133] (370s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[654.798075] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[654.800770] Starting dynamic subtest: pipe-A-eDP-1
[654.870662] Dynamic subtest pipe-A-eDP-1: SKIP (0.076s)
[654.881892] Starting dynamic subtest: pipe-B-eDP-1
[655.979300] Dynamic subtest pipe-B-eDP-1: SKIP (1.106s)
[655.984328] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.185s)
[657.180339] [098/133] (368s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[657.298922] Starting subtest: cursorB-vs-flipB-atomic
[657.303902] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[657.471654] [099/133] (367s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[657.565543] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[657.570615] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[657.676422] [100/133] (367s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[657.734739] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[657.740617] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[657.922603] [101/133] (367s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[658.013964] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[662.442798] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.435s)
[663.597354] [102/133] (361s left) gem_pxp (reject-modify-context-protection-off-3)
[663.725919] Starting subtest: reject-modify-context-protection-off-3
[663.728925] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[663.835275] [103/133] (361s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[663.924566] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[663.929271] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[665.020568] [104/133] (360s left) syncobj_wait (single-wait-submitted)
[665.088764] Starting subtest: single-wait-submitted
[665.191731] Subtest single-wait-submitted: SUCCESS (0.104s)
[665.270788] [105/133] (360s left) kms_legacy_colorkey (basic)
[665.368600] Starting subtest: basic
[665.370869] Starting dynamic subtest: pipe-A
[665.411577] Dynamic subtest pipe-A: SUCCESS (0.045s)
[665.424448] Starting dynamic subtest: pipe-B
[665.426911] Dynamic subtest pipe-B: SUCCESS (0.001s)
[665.436902] Starting dynamic subtest: pipe-C
[665.439448] Dynamic subtest pipe-C: SUCCESS (0.000s)
[665.448877] Starting dynamic subtest: pipe-D
[665.451352] Dynamic subtest pipe-D: SUCCESS (0.000s)
[665.453630] Subtest basic: SUCCESS (0.052s)
[665.493683] [106/133] (360s left) prime_mmap (test_aperture_limit)
[665.551385] Starting subtest: test_aperture_limit
[665.553482] Starting dynamic subtest: test_aperture_limit-smem
[665.561645] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[665.566660] Subtest test_aperture_limit: SKIP (0.009s)
[665.655193] [107/133] (360s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[667.201808] Starting subtest: dpms-mode-unset-lpsp
[671.264928] Subtest dpms-mode-unset-lpsp: SUCCESS (4.062s)
[671.649729] [108/133] (354s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[671.722693] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[671.780206] [109/133] (354s left) dmabuf_sync_file (import-multiple-read-write)
[671.833620] Starting subtest: import-multiple-read-write
[671.836700] Subtest import-multiple-read-write: SUCCESS (0.003s)
[671.891132] [110/133] (353s left) gem_partial_pwrite_pread (write-snoop)
[671.964656] Subtest write-snoop: SKIP (0.000s)
[672.040803] [111/133] (353s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[672.129428] Starting subtest: primary-yf-tiled-reflect-x-0
[672.189429] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[672.292915] [112/133] (353s left) kms_psr (psr2-sprite-mmap-cpu)
[672.386718] Starting subtest: psr2-sprite-mmap-cpu
[672.389432] Starting dynamic subtest: eDP-1
[674.133485] Dynamic subtest eDP-1: SUCCESS (1.744s)
[674.135872] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.745s)
[674.997276] [113/133] (350s left) gem_create (create-ext-placement-sanity-check)
[675.167255] Starting subtest: create-ext-placement-sanity-check
[675.170511] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[675.289063] [114/133] (350s left) kms_color_pipeline (plane-ctm3x4)
[675.387810] Starting subtest: plane-ctm3x4
[675.510950] Starting dynamic subtest: pipe-A-plane-0
[675.677582] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[675.688861] Starting dynamic subtest: pipe-A-plane-1
[675.788882] Dynamic subtest pipe-A-plane-1: SUCCESS (0.110s)
[675.799890] Starting dynamic subtest: pipe-A-plane-2
[675.899826] Dynamic subtest pipe-A-plane-2: SUCCESS (0.110s)
[677.086087] Starting dynamic subtest: pipe-B-plane-0
[677.211753] Dynamic subtest pipe-B-plane-0: SUCCESS (0.133s)
[677.223818] Starting dynamic subtest: pipe-B-plane-1
[677.321688] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s)
[677.332782] Starting dynamic subtest: pipe-B-plane-2
[677.432909] Dynamic subtest pipe-B-plane-2: SUCCESS (0.110s)
[678.622864] Starting dynamic subtest: pipe-C-plane-0
[678.725451] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[678.736624] Starting dynamic subtest: pipe-C-plane-1
[678.836145] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[678.846951] Starting dynamic subtest: pipe-C-plane-2
[678.947754] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[680.147923] Starting dynamic subtest: pipe-D-plane-0
[680.250897] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[680.262745] Starting dynamic subtest: pipe-D-plane-1
[680.364668] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[680.386368] Starting dynamic subtest: pipe-D-plane-2
[680.484351] Dynamic subtest pipe-D-plane-2: SUCCESS (0.121s)
[680.775646] Subtest plane-ctm3x4: SUCCESS (5.385s)
[681.613432] [115/133] (344s left) syncobj_timeline (invalid-query-illegal-handle)
[681.681396] Starting subtest: invalid-query-illegal-handle
[681.683813] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[681.777167] [116/133] (344s left) kms_psr (fbc-psr-cursor-plane-onoff)
[681.870966] Starting subtest: fbc-psr-cursor-plane-onoff
[681.873722] Starting dynamic subtest: eDP-1
[681.878708] Dynamic subtest eDP-1: SKIP (0.000s)
[681.883670] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[681.946212] [117/133] (344s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[682.038264] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[682.040908] Starting dynamic subtest: pipe-A
[682.100397] Dynamic subtest pipe-A: SUCCESS (0.064s)
[682.112896] Starting dynamic subtest: pipe-B
[683.242927] Dynamic subtest pipe-B: SUCCESS (1.141s)
[683.255210] Starting dynamic subtest: pipe-C
[684.352551] Dynamic subtest pipe-C: SUCCESS (1.108s)
[684.363373] Starting dynamic subtest: pipe-D
[685.494864] Dynamic subtest pipe-D: SUCCESS (1.142s)
[685.497748] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.458s)
[686.652447] [118/133] (339s left) kms_addfb_basic (bad-pitch-1024)
[686.712767] Starting subtest: bad-pitch-1024
[686.715005] Subtest bad-pitch-1024: SUCCESS (0.000s)
[686.850388] [119/133] (339s left) gem_exec_balancer (parallel-keep-submit-fence)
[687.109714] Starting subtest: parallel-keep-submit-fence
[688.525404] Subtest parallel-keep-submit-fence: SUCCESS (1.415s)
[688.618608] [120/133] (337s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[688.726536] Starting subtest: 2x-long-flip-vs-cursor-atomic
[688.731315] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[688.872077] [121/133] (337s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[688.968027] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[688.972747] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[689.062215] [122/133] (337s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[689.149880] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[689.174816] Starting dynamic subtest: pipe-A-plane-0
[689.885362] Dynamic subtest pipe-A-plane-0: SUCCESS (0.710s)
[689.896023] Starting dynamic subtest: pipe-A-plane-3
[690.341521] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[691.427928] Starting dynamic subtest: pipe-B-plane-0
[692.142910] Dynamic subtest pipe-B-plane-0: SUCCESS (0.723s)
[692.153989] Starting dynamic subtest: pipe-B-plane-3
[692.563656] Dynamic subtest pipe-B-plane-3: SUCCESS (0.420s)
[692.889291] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.738s)
[693.710193] [123/133] (332s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[693.822580] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[693.827371] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[693.917250] [124/133] (332s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[696.252505] Starting subtest: modeset-lpsp-stress-no-wait
[706.076914] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.824s)
[706.156629] [125/133] (320s left) i915_pm_rpm (gem-execbuf-stress)
[708.183785] Starting subtest: gem-execbuf-stress
[708.186947] Starting dynamic subtest: smem0
[721.116699] Dynamic subtest smem0: SUCCESS (12.927s)
[721.130990] Starting dynamic subtest: extra-wait-smem0
[782.819039] Dynamic subtest extra-wait-smem0: SUCCESS (61.674s)
[782.822028] Subtest gem-execbuf-stress: SUCCESS (74.607s)
[783.208368] [126/133] (243s left) kms_invalid_mode (bad-vtotal)
[783.296331] Starting subtest: bad-vtotal
[783.298887] Starting dynamic subtest: pipe-A-eDP-1
[783.605958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.308s)
[783.617564] Starting dynamic subtest: pipe-B-eDP-1
[783.620171] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[783.631271] Starting dynamic subtest: pipe-C-eDP-1
[783.633661] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[783.644167] Starting dynamic subtest: pipe-D-eDP-1
[783.646886] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[783.649670] Subtest bad-vtotal: SUCCESS (0.317s)
[784.423030] [127/133] (242s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[784.805657] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[785.636690] [128/133] (240s left) drm_read (empty-block)
[785.790891] Starting subtest: empty-block
[786.790432] Subtest empty-block: SUCCESS (1.001s)
[786.934572] [129/133] (239s left) gem_mmap_gtt (basic)
[786.992495] Subtest basic: SKIP (0.000s)
[787.053926] [130/133] (239s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[787.114758] Starting subtest: single-wait-for-submit-unsubmitted
[787.214734] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[787.293325] [131/133] (239s left) gem_ctx_persistence (engines-queued)
[787.365622] Starting subtest: engines-queued
[787.368671] Starting dynamic subtest: rcs0
[787.429884] Dynamic subtest rcs0: SUCCESS (0.064s)
[787.444234] Starting dynamic subtest: bcs0
[787.452787] Dynamic subtest bcs0: SUCCESS (0.021s)
[787.463631] Starting dynamic subtest: vcs0
[789.018490] Dynamic subtest vcs0: SUCCESS (1.563s)
[789.032226] Starting dynamic subtest: vcs1
[791.002276] Dynamic subtest vcs1: SUCCESS (1.981s)
[791.017149] Starting dynamic subtest: vecs0
[792.988206] Dynamic subtest vecs0: SUCCESS (1.984s)
[793.001919] Starting dynamic subtest: ccs0
[793.168929] Dynamic subtest ccs0: SUCCESS (0.180s)
[793.172076] Subtest engines-queued: SUCCESS (5.805s)
[793.296671] [132/133] (233s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[793.394640] Starting subtest: fbc-dirtyfb-ioctl
[793.397424] Starting dynamic subtest: A-eDP-1
[796.053885] Dynamic subtest A-eDP-1: SUCCESS (2.659s)
[796.056590] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.660s)
[796.919674] [133/133] (229s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[797.032740] Starting subtest: cursor-vs-flip-legacy
[826.763305] Subtest cursor-vs-flip-legacy: SUCCESS (29.735s)
[827.650531] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: kms_busy
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_vm_create
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: kms_properties
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: gem_pread
results: parsing output: 12/ for test: prime_mmap_coherency
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_chamelium_frames
results: parsing output: 17/ for test: kms_vblank
results: parsing output: 18/ for test: i915_hangman
results: parsing output: 19/ for test: syncobj_eventfd
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: api_intel_allocator
results: parsing output: 22/ for test: gem_mmap_wc
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_mmap
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_readwrite
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: sysfs_heartbeat_interval
results: parsing output: 31/ for test: gem_sync
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_hdr
results: parsing output: 34/ for test: gem_spin_batch
results: parsing output: 35/ for test: kms_vrr
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: gem_lmem_swapping
results: parsing output: 39/ for test: kms_content_protection
results: parsing output: 40/ for test: kms_atomic
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_plane_multiple
results: parsing output: 43/ for test: gem_mmap_offset
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: gem_exec_gttfill
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: kms_dp_link_training
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: gem_ctx_shared
results: parsing output: 67/ for test: kms_plane_alpha_blend
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: gem_exec_whisper
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: i915_suspend
results: parsing output: 76/ for test: kms_cursor_edge_walk
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gen9_exec_parse
results: parsing output: 79/ for test: api_intel_bb
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gen3_render_tiledx_blits
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: dumb_buffer
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_linear_blits
results: parsing output: 90/ for test: perf_pmu
results: parsing output: 91/ for test: i915_drm_fdinfo
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_pxp
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_legacy_colorkey
results: parsing output: 105/ for test: prime_mmap
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: dmabuf_sync_file
results: parsing output: 109/ for test: gem_partial_pwrite_pread
results: parsing output: 110/ for test: kms_rotation_crc
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_create
results: parsing output: 113/ for test: kms_color_pipeline
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_plane
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: i915_pm_rpm
results: parsing output: 125/ for test: kms_invalid_mode
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: drm_read
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: kms_dirtyfb
results: parsing output: 132/ for test: kms_cursor_legacy
Done.