[57.235690] Initializing watchdogs
[57.235823]   /dev/watchdog0
[57.250735] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.255080] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.257512] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.260822] [001/133] (960s left) kms_cursor_crc (cursor-random-32x32)
[57.423708] Starting subtest: cursor-random-32x32
[57.475149] Subtest cursor-random-32x32: SKIP (0.046s)
[57.749011] [002/133] (960s left) gem_exec_schedule (timeslicing)
[57.821126] Starting subtest: timeslicing
[57.823205] Starting dynamic subtest: rcs0
[57.831591] Dynamic subtest rcs0: SUCCESS (0.019s)
[57.839968] Starting dynamic subtest: bcs0
[57.852904] Dynamic subtest bcs0: SUCCESS (0.020s)
[57.864482] Starting dynamic subtest: vcs0
[57.876789] Dynamic subtest vcs0: SUCCESS (0.024s)
[57.888187] Starting dynamic subtest: vcs1
[57.898877] Dynamic subtest vcs1: SUCCESS (0.022s)
[57.906770] Starting dynamic subtest: vecs0
[57.921252] Dynamic subtest vecs0: SUCCESS (0.021s)
[57.933444] Starting dynamic subtest: ccs0
[57.941790] Dynamic subtest ccs0: SUCCESS (0.020s)
[57.944224] Subtest timeslicing: SUCCESS (0.130s)
[59.913655] [003/133] (957s left) kms_plane (plane-panning-top-left)
[60.004065] Starting subtest: plane-panning-top-left
[60.006533] Starting dynamic subtest: pipe-A
[61.661760] Dynamic subtest pipe-A: SUCCESS (1.656s)
[61.670129] Starting dynamic subtest: pipe-B
[63.943746] Dynamic subtest pipe-B: SUCCESS (2.281s)
[63.946306] Subtest plane-panning-top-left: SUCCESS (3.939s)
[64.743262] [004/133] (953s left) kms_busy (basic)
[64.848175] Starting subtest: basic
[64.850457] Starting dynamic subtest: flip
[65.447947] Dynamic subtest flip: SUCCESS (0.599s)
[65.457040] Starting dynamic subtest: modeset
[68.901631] Dynamic subtest modeset: SUCCESS (3.453s)
[68.904039] Subtest basic: SUCCESS (4.053s)
[69.698853] [005/133] (948s left) kms_addfb_basic (basic-x-tiled-legacy)
[69.762280] Starting subtest: basic-x-tiled-legacy
[69.767138] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[69.891795] [006/133] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[69.997641] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[74.314472] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.322s)
[75.529536] [007/133] (942s left) gem_vm_create (execbuf)
[75.587880] Starting subtest: execbuf
[75.594997] Subtest execbuf: SUCCESS (0.007s)
[75.706779] [008/133] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[75.797791] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[84.420853] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.623s)
[84.529779] [009/133] (933s left) gem_ctx_param (basic-default)
[84.591806] Starting subtest: basic-default
[84.594126] Subtest basic-default: SUCCESS (0.000s)
[84.664609] [010/133] (933s left) kms_properties (crtc-properties-atomic)
[84.753224] Starting subtest: crtc-properties-atomic
[84.755604] Starting dynamic subtest: pipe-A-eDP-1
[85.190414] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s)
[85.198207] Starting dynamic subtest: pipe-B-eDP-1
[86.356889] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s)
[86.365111] Starting dynamic subtest: pipe-C-eDP-1
[87.478987] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[87.488391] Starting dynamic subtest: pipe-D-eDP-1
[88.607747] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[88.609640] Subtest crtc-properties-atomic: SUCCESS (3.854s)
[89.431167] [011/133] (928s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[89.531097] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[89.533466] Starting dynamic subtest: pipe-A-default-mode
[92.250482] Dynamic subtest pipe-A-default-mode: SUCCESS (2.718s)
[92.252391] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.719s)
[93.114130] [012/133] (925s left) gem_pread (bench)
[93.171979] Subtest bench: SKIP (0.000s)
[93.244554] [013/133] (924s left) prime_mmap_coherency (write)
[93.305580] Starting subtest: write
[98.680739] Subtest write: SUCCESS (5.373s)
[98.818995] [014/133] (919s left) gem_exec_reloc (basic-cpu)
[98.880077] Subtest basic-cpu: SKIP (0.000s)
[98.950791] [015/133] (919s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[99.058229] Starting subtest: fbc-tiling-linear
[102.722347] Subtest fbc-tiling-linear: SUCCESS (3.668s)
[103.923705] [016/133] (914s left) kms_psr (fbc-psr2-basic)
[104.019261] Starting subtest: fbc-psr2-basic
[104.021576] Starting dynamic subtest: eDP-1
[104.025813] Dynamic subtest eDP-1: SKIP (0.000s)
[104.030151] Subtest fbc-psr2-basic: SKIP (0.001s)
[104.088704] [017/133] (914s left) kms_chamelium_frames (dp-crc-single)
[104.463457] Subtest dp-crc-single: SKIP (0.000s)
[105.236724] [018/133] (913s left) kms_vblank (wait-forked)
[105.332470] Starting subtest: wait-forked
[105.334867] Starting dynamic subtest: pipe-A-eDP-1
[107.151239] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[107.163888] Starting dynamic subtest: pipe-D-eDP-1
[109.654124] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.499s)
[109.656455] Subtest wait-forked: SUCCESS (4.320s)
[110.527362] [019/133] (907s left) i915_hangman (gt-engine-hang)
[110.594970] Starting subtest: gt-engine-hang
[110.597204] Starting dynamic subtest: rcs0
[111.864169] Dynamic subtest rcs0: SUCCESS (1.268s)
[111.875367] Starting dynamic subtest: bcs0
[113.845701] Dynamic subtest bcs0: SUCCESS (1.980s)
[113.856852] Starting dynamic subtest: vcs0
[115.892825] Dynamic subtest vcs0: SUCCESS (2.045s)
[115.903679] Starting dynamic subtest: vcs1
[117.877237] Dynamic subtest vcs1: SUCCESS (1.983s)
[117.888278] Starting dynamic subtest: vecs0
[119.861866] Dynamic subtest vecs0: SUCCESS (1.982s)
[119.872787] Starting dynamic subtest: ccs0
[121.909288] Dynamic subtest ccs0: SUCCESS (2.046s)
[121.911901] Subtest gt-engine-hang: SUCCESS (11.315s)
[122.044413] [020/133] (896s left) syncobj_eventfd (timeline-wait-signaled)
[122.097136] Starting subtest: timeline-wait-signaled
[122.099523] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[122.178187] [021/133] (896s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[122.283674] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[122.288260] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[122.350639] [022/133] (896s left) api_intel_allocator (fork-simple-stress)
[122.411932] Starting subtest: fork-simple-stress
[127.806735] Subtest fork-simple-stress: SUCCESS (5.396s)
[127.929714] [023/133] (890s left) gem_mmap_wc (coherency)
[128.008178] Subtest coherency: SKIP (0.000s)
[128.092550] [024/133] (890s left) gem_exec_schedule (pi-common)
[128.290378] Starting subtest: pi-common
[128.292376] Starting dynamic subtest: rcs0
[128.383562] Dynamic subtest rcs0: SUCCESS (0.095s)
[128.400578] Starting dynamic subtest: bcs0
[128.416357] Dynamic subtest bcs0: SUCCESS (0.032s)
[128.432094] Starting dynamic subtest: vcs0
[128.450044] Dynamic subtest vcs0: SUCCESS (0.033s)
[128.458229] Starting dynamic subtest: vcs1
[128.483369] Dynamic subtest vcs1: SUCCESS (0.033s)
[128.491286] Starting dynamic subtest: vecs0
[128.515745] Dynamic subtest vecs0: SUCCESS (0.032s)
[128.523812] Starting dynamic subtest: ccs0
[128.547183] Dynamic subtest ccs0: SUCCESS (0.031s)
[128.549491] Subtest pi-common: SUCCESS (0.259s)
[128.789390] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[128.795510] [025/133] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[128.925264] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[128.929393] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[129.060662] [026/133] (889s left) gem_mmap (basic)
[129.138878] Subtest basic: SKIP (0.000s)
[129.227621] [027/133] (889s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[129.358830] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[129.363078] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[129.474755] [028/133] (889s left) syncobj_wait (invalid-reset-one-illegal-handle)
[129.536032] Starting subtest: invalid-reset-one-illegal-handle
[129.538412] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[129.657719] [029/133] (889s left) gem_readwrite (new-obj)
[129.730819] Subtest new-obj: SKIP (0.000s)
[129.807631] [030/133] (889s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[129.919211] Starting subtest: yf-tiled-8bpp-rotate-0
[129.922846] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[130.034783] [031/133] (888s left) sysfs_heartbeat_interval (invalid)
[130.106364] Starting subtest: invalid
[130.108276] Starting dynamic subtest: vecs0
[130.110267] Dynamic subtest vecs0: SUCCESS (0.000s)
[130.122471] Starting dynamic subtest: ccs0
[130.124116] Dynamic subtest ccs0: SUCCESS (0.000s)
[130.136189] Starting dynamic subtest: vcs0
[130.138047] Dynamic subtest vcs0: SUCCESS (0.000s)
[130.149258] Starting dynamic subtest: bcs0
[130.150909] Dynamic subtest bcs0: SUCCESS (0.000s)
[130.162308] Starting dynamic subtest: rcs0
[130.163973] Dynamic subtest rcs0: SUCCESS (0.000s)
[130.174803] Starting dynamic subtest: vcs1
[130.176618] Dynamic subtest vcs1: SUCCESS (0.000s)
[130.178307] Subtest invalid: SUCCESS (0.008s)
[130.237152] [032/133] (888s left) gem_sync (basic-all)
[130.340636] Starting subtest: basic-all
[133.847764] Subtest basic-all: SUCCESS (3.512s)
[134.033601] [033/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[134.142259] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[134.146243] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[134.240954] [034/133] (884s left) kms_hdr (bpc-switch-suspend)
[134.331155] Starting subtest: bpc-switch-suspend
[135.403941] Starting dynamic subtest: pipe-A-eDP-1
[154.709326] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.702s)
[154.711816] Subtest bpc-switch-suspend: SUCCESS (5.778s)
[154.840191] [035/133] (864s left) gem_spin_batch (legacy-resubmit)
[154.908739] Starting subtest: legacy-resubmit
[154.911189] Starting dynamic subtest: default
[154.921433] Dynamic subtest default: SUCCESS (0.012s)
[154.931074] Starting dynamic subtest: render
[154.933394] Dynamic subtest render: SUCCESS (0.001s)
[154.941762] Starting dynamic subtest: bsd
[154.943984] Dynamic subtest bsd: SUCCESS (0.003s)
[154.952025] Starting dynamic subtest: bsd1
[154.954345] Dynamic subtest bsd1: SUCCESS (0.002s)
[154.962620] Starting dynamic subtest: bsd2
[154.964846] Dynamic subtest bsd2: SUCCESS (0.001s)
[154.972922] Starting dynamic subtest: blt
[154.975182] Dynamic subtest blt: SUCCESS (0.002s)
[154.983241] Starting dynamic subtest: vebox
[154.985616] Dynamic subtest vebox: SUCCESS (0.003s)
[154.987839] Subtest legacy-resubmit: SUCCESS (0.028s)
[155.173662] [036/133] (864s left) kms_vrr (seamless-rr-switch-drrs)
[155.270661] Starting subtest: seamless-rr-switch-drrs
[155.277144] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[155.345206] [037/133] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[155.436422] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[155.440677] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[155.552900] [038/133] (863s left) gem_exec_balancer (bonded-semaphore)
[155.621368] Starting subtest: bonded-semaphore
[155.625796] Subtest bonded-semaphore: SKIP (0.000s)
[155.937445] [039/133] (863s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[155.984666] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[156.030847] [040/133] (863s left) kms_content_protection (dp-mst-lic-type-1)
[156.165516] Starting subtest: dp-mst-lic-type-1
[156.170051] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[156.284937] [041/133] (863s left) kms_atomic (plane-overlay-legacy)
[156.380698] Starting subtest: plane-overlay-legacy
[156.383068] Starting dynamic subtest: pipe-A-eDP-1
[156.815078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.422s)
[156.817408] Subtest plane-overlay-legacy: SUCCESS (0.423s)
[157.688605] [042/133] (861s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[157.791468] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[164.534388] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.637s)
[164.660828] [043/133] (854s left) kms_plane_multiple (tiling-x)
[164.760427] Starting subtest: tiling-x
[164.762309] Starting dynamic subtest: pipe-A-eDP-1
[168.495005] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.701s)
[168.511905] Starting dynamic subtest: pipe-B-eDP-1
[172.935299] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.419s)
[172.944910] Starting dynamic subtest: pipe-C-eDP-1
[177.274384] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.326s)
[177.283771] Starting dynamic subtest: pipe-D-eDP-1
[181.725952] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.443s)
[181.728487] Subtest tiling-x: SUCCESS (16.894s)
[182.537672] [044/133] (837s left) gem_mmap_offset (close-race)
[182.608032] Starting subtest: close-race
[202.721359] Subtest close-race: SUCCESS (20.104s)
[202.853037] [045/133] (816s left) perf_pmu (semaphore-busy)
[202.899934] Starting subtest: semaphore-busy
[202.902187] Starting dynamic subtest: rcs0
[204.524404] Dynamic subtest rcs0: SUCCESS (1.622s)
[204.534879] Starting dynamic subtest: bcs0
[206.158403] Dynamic subtest bcs0: SUCCESS (1.631s)
[206.168561] Starting dynamic subtest: vcs0
[209.986343] Dynamic subtest vcs0: SUCCESS (3.824s)
[209.997610] Starting dynamic subtest: vcs1
[216.002303] Dynamic subtest vcs1: SUCCESS (6.010s)
[216.011581] Starting dynamic subtest: vecs0
[222.018476] Dynamic subtest vecs0: SUCCESS (6.011s)
[222.030778] Starting dynamic subtest: ccs0
[224.088015] Dynamic subtest ccs0: FAIL (2.016s)
[224.090325] Subtest semaphore-busy: FAIL (21.128s)
[224.148895] [046/133] (795s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[224.250420] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[224.254620] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[224.342575] [047/133] (795s left) gem_exec_reloc (basic-write-cpu-noreloc)
[224.398285] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[224.480710] [048/133] (795s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[224.571261] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[225.328544] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.759s)
[225.481303] [049/133] (794s left) kms_flip (dpms-off-confusion-interruptible)
[225.589075] Starting subtest: dpms-off-confusion-interruptible
[225.591437] Starting dynamic subtest: A-eDP1
[234.260628] Dynamic subtest A-eDP1: SUCCESS (8.667s)
[234.270370] Starting dynamic subtest: B-eDP1
[242.895379] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[242.905310] Starting dynamic subtest: C-eDP1
[251.514902] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[251.527561] Starting dynamic subtest: D-eDP1
[260.153610] Dynamic subtest D-eDP1: SUCCESS (8.640s)
[260.158900] Subtest dpms-off-confusion-interruptible: SUCCESS (34.566s)
[261.312071] [050/133] (758s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[261.409371] Starting subtest: crc-primary-basic-y-tiled-ccs
[261.411660] Starting dynamic subtest: pipe-A-eDP-1
[261.433450] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[261.444043] Starting dynamic subtest: pipe-B-eDP-1
[261.464651] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[261.472880] Starting dynamic subtest: pipe-C-eDP-1
[261.493682] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[261.501635] Starting dynamic subtest: pipe-D-eDP-1
[261.523131] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[261.527554] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[263.591030] [051/133] (756s left) gem_exec_gttfill (multigpu-basic)
[263.769542] Starting subtest: multigpu-basic
[277.663810] Subtest multigpu-basic: SUCCESS (13.896s)
[277.718256] [052/133] (742s left) kms_cursor_crc (cursor-alpha-opaque)
[277.869573] Starting subtest: cursor-alpha-opaque
[277.871458] Starting dynamic subtest: pipe-A-eDP-1
[278.530127] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.661s)
[278.540218] Starting dynamic subtest: pipe-D-eDP-1
[279.759889] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[279.762267] Subtest cursor-alpha-opaque: SUCCESS (1.893s)
[280.587258] [053/133] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[280.699803] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[287.953425] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.255s)
[288.063032] [054/133] (731s left) kms_flip (flip-vs-suspend-interruptible)
[288.158896] Starting subtest: flip-vs-suspend-interruptible
[288.161195] Starting dynamic subtest: A-eDP1
[321.545422] Dynamic subtest A-eDP1: SUCCESS (3.678s)
[321.562340] Starting dynamic subtest: B-eDP1
[370.578120] Dynamic subtest B-eDP1: SUCCESS (4.493s)
[370.589373] Starting dynamic subtest: C-eDP1
[419.580770] Dynamic subtest C-eDP1: SUCCESS (4.478s)
[419.591683] Starting dynamic subtest: D-eDP1
[468.566284] Dynamic subtest D-eDP1: SUCCESS (4.480s)
[468.572409] Subtest flip-vs-suspend-interruptible: SUCCESS (17.141s)
[469.785546] [055/133] (550s left) kms_psr (pr-cursor-plane-onoff)
[469.891137] Starting subtest: pr-cursor-plane-onoff
[469.896042] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[469.981703] [056/133] (550s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[470.093412] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[470.096099] Starting dynamic subtest: pipe-A-eDP-1
[476.024866] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.797s)
[476.035862] Starting dynamic subtest: pipe-B-eDP-1
[482.752291] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.659s)
[482.755176] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.459s)
[483.629472] [057/133] (536s left) kms_dp_link_training (uhbr-sst)
[483.730195] Starting subtest: uhbr-sst
[483.740059] Subtest uhbr-sst: SKIP (0.000s)
[483.804896] [058/133] (536s left) gem_ctx_persistence (processes)
[483.874181] Starting subtest: processes
[485.322280] Subtest processes: SUCCESS (1.443s)
[485.414897] [059/133] (534s left) gem_exec_reloc (basic-write-wc-active)
[485.479860] Subtest basic-write-wc-active: SKIP (0.000s)
[485.543771] [060/133] (534s left) kms_addfb_basic (bad-pitch-128)
[485.604137] Starting subtest: bad-pitch-128
[485.606720] Subtest bad-pitch-128: SUCCESS (0.000s)
[485.757038] [061/133] (534s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[485.855745] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[490.244499] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.380s)
[491.458873] [062/133] (528s left) syncobj_timeline (wait-all-complex)
[491.517087] Starting subtest: wait-all-complex
[491.736483] Subtest wait-all-complex: SUCCESS (0.218s)
[491.815194] [063/133] (528s left) gem_eio (in-flight-10ms)
[492.034408] Starting subtest: in-flight-10ms
[500.243064] Subtest in-flight-10ms: SUCCESS (8.195s)
[500.362635] [064/133] (520s left) kms_big_fb (linear-32bpp-rotate-90)
[500.477846] Starting subtest: linear-32bpp-rotate-90
[500.498258] Subtest linear-32bpp-rotate-90: SKIP (0.020s)
[500.611778] [065/133] (519s left) syncobj_timeline (reset-multiple-signaled)
[500.659885] Starting subtest: reset-multiple-signaled
[500.662325] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[500.755743] [066/133] (519s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[500.872795] Starting subtest: 2x-long-flip-vs-cursor-legacy
[500.877895] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[501.030778] [067/133] (519s left) gem_ctx_shared (q-smoketest)
[501.092159] Starting subtest: Q-smoketest
[501.094246] Starting dynamic subtest: rcs0
[506.668343] Dynamic subtest rcs0: SUCCESS (5.527s)
[506.678483] Starting dynamic subtest: bcs0
[512.191847] Dynamic subtest bcs0: SUCCESS (5.515s)
[512.202389] Starting dynamic subtest: vcs0
[517.682149] Dynamic subtest vcs0: SUCCESS (5.481s)
[517.694714] Starting dynamic subtest: vcs1
[523.171693] Dynamic subtest vcs1: SUCCESS (5.497s)
[523.188922] Starting dynamic subtest: vecs0
[528.672989] Dynamic subtest vecs0: SUCCESS (5.489s)
[528.683892] Starting dynamic subtest: ccs0
[534.184345] Dynamic subtest ccs0: SUCCESS (5.501s)
[534.187093] Subtest Q-smoketest: SUCCESS (33.020s)
[534.313752] [068/133] (486s left) kms_plane_alpha_blend (alpha-transparent-fb)
[534.412402] Starting subtest: alpha-transparent-fb
[534.718987] Starting dynamic subtest: pipe-A-eDP-1
[535.295998] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[535.306674] Starting dynamic subtest: pipe-D-eDP-1
[536.607352] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.310s)
[536.610359] Subtest alpha-transparent-fb: SUCCESS (2.194s)
[537.433944] [069/133] (483s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[537.564643] Starting subtest: cursorB-vs-flipA-atomic-transitions
[537.570033] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[537.713191] [070/133] (482s left) gem_exec_reloc (basic-wc-gtt-active)
[537.766624] Subtest basic-wc-gtt-active: SKIP (0.000s)
[537.836519] [071/133] (482s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[537.958109] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[549.125229] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.162s)
[549.952592] [072/133] (470s left) gem_exec_whisper (basic-forked)
[550.011596] Starting subtest: basic-forked
[557.887642] Subtest basic-forked: SUCCESS (7.870s)
[558.075957] [073/133] (462s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[558.179345] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[558.191890] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[558.271428] [074/133] (462s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[558.369005] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[558.374024] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[558.470113] [075/133] (462s left) syncobj_wait (single-wait-all-submitted)
[558.530190] Starting subtest: single-wait-all-submitted
[558.631049] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[558.710670] [076/133] (462s left) i915_suspend (debugfs-reader)
[558.774122] Starting subtest: debugfs-reader
[576.531899] Subtest debugfs-reader: SUCCESS (3.147s)
[576.695636] [077/133] (444s left) kms_cursor_edge_walk (128x128-top-edge)
[576.789252] Starting subtest: 128x128-top-edge
[576.791777] Starting dynamic subtest: pipe-A-eDP-1
[580.287026] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.394s)
[580.297911] Starting dynamic subtest: pipe-D-eDP-1
[583.472935] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[583.475288] Subtest 128x128-top-edge: SUCCESS (6.520s)
[584.304996] [078/133] (436s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[584.400247] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[584.402450] Starting dynamic subtest: pipe-A-eDP-1
[585.139161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s)
[585.149904] Starting dynamic subtest: pipe-B-eDP-1
[586.942482] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.781s)
[586.953567] Starting dynamic subtest: pipe-C-eDP-1
[588.722439] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.763s)
[588.731559] Starting dynamic subtest: pipe-D-eDP-1
[590.542377] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.806s)
[590.544709] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.077s)
[591.715516] [079/133] (429s left) gen9_exec_parse (basic-rejected)
[591.785858] Subtest basic-rejected: SKIP (0.000s)
[591.909064] [080/133] (429s left) api_intel_bb (object-noreloc-keep-cache-simple)
[591.971545] Starting subtest: object-noreloc-keep-cache-simple
[591.974988] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[592.109424] [081/133] (429s left) kms_selftest (drm_cmdline_parser)
[592.146969] Starting subtest: drm_cmdline_parser
[592.170402] Starting dynamic subtest: drm_test_cmdline_force_d_only
[592.254875] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.084s)
[592.267303] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[592.361024] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.104s)
[592.377428] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[592.454177] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.092s)
[592.469990] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[592.555113] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.099s)
[592.571832] Starting dynamic subtest: drm_test_cmdline_force_e_only
[592.638195] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.083s)
[592.648515] Starting dynamic subtest: drm_test_cmdline_res
[592.733140] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.094s)
[592.741853] Starting dynamic subtest: drm_test_cmdline_res_vesa
[592.811457] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.078s)
[592.820217] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[592.893877] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.081s)
[592.902739] Starting dynamic subtest: drm_test_cmdline_res_rblank
[593.011145] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.115s)
[593.020419] Starting dynamic subtest: drm_test_cmdline_res_bpp
[593.102001] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.090s)
[593.111613] Starting dynamic subtest: drm_test_cmdline_res_refresh
[593.194966] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.092s)
[593.204532] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[593.300032] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.105s)
[593.309793] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[593.394131] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.092s)
[593.405103] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[593.505914] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.111s)
[593.517106] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[593.598931] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.092s)
[593.609958] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[593.704917] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.104s)
[593.716166] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[593.798813] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.093s)
[593.809652] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[593.891226] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.091s)
[593.901913] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[593.988134] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.096s)
[593.999146] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[594.094300] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.106s)
[594.104883] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[594.173149] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.077s)
[594.183593] Starting dynamic subtest: drm_test_cmdline_name
[594.264109] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.090s)
[594.274606] Starting dynamic subtest: drm_test_cmdline_name_bpp
[594.361673] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.096s)
[594.372007] Starting dynamic subtest: drm_test_cmdline_name_option
[594.455856] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.093s)
[594.466212] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[594.539991] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.083s)
[594.550245] Starting dynamic subtest: drm_test_cmdline_rotate_0
[594.630020] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.089s)
[594.638709] Starting dynamic subtest: drm_test_cmdline_rotate_90
[594.736092] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.105s)
[594.746624] Starting dynamic subtest: drm_test_cmdline_rotate_180
[594.822974] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.086s)
[594.833232] Starting dynamic subtest: drm_test_cmdline_rotate_270
[594.928420] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.103s)
[594.943436] Starting dynamic subtest: drm_test_cmdline_hmirror
[595.015000] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.086s)
[595.025333] Starting dynamic subtest: drm_test_cmdline_vmirror
[595.104341] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.088s)
[595.115337] Starting dynamic subtest: drm_test_cmdline_margin_options
[595.208248] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.103s)
[595.218985] Starting dynamic subtest: drm_test_cmdline_multiple_options
[595.327042] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.116s)
[595.338038] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[595.413778] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.086s)
[595.424685] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[595.526924] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.112s)
[595.537966] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[595.640934] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.112s)
[595.651951] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[595.741928] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.101s)
[595.752748] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[595.846877] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.104s)
[595.857580] Starting dynamic subtest: drm_test_cmdline_invalid
[595.965509] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.117s)
[595.975316] Starting dynamic subtest: drm_test_cmdline_tv_options
[596.087111] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.121s)
[596.089376] Subtest drm_cmdline_parser: SUCCESS (3.926s)
[596.256316] [082/133] (425s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[596.361248] Starting subtest: x-tiled-16bpp-rotate-270
[596.380759] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[596.495853] [083/133] (424s left) gen3_render_tiledx_blits
[596.601843] [084/133] (424s left) perf (whitelisted-registers-userspace-config)
[596.745167] Starting subtest: whitelisted-registers-userspace-config
[596.747041] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[596.791571] [085/133] (424s left) gem_exec_fence (parallel)
[596.968313] Starting subtest: parallel
[596.970225] Starting dynamic subtest: rcs0
[599.119464] Dynamic subtest rcs0: SUCCESS (2.149s)
[599.128794] Starting dynamic subtest: bcs0
[601.276806] Dynamic subtest bcs0: SUCCESS (2.152s)
[601.287541] Starting dynamic subtest: vcs0
[603.436398] Dynamic subtest vcs0: SUCCESS (2.154s)
[603.450043] Starting dynamic subtest: vcs1
[605.592614] Dynamic subtest vcs1: SUCCESS (2.153s)
[605.603940] Starting dynamic subtest: vecs0
[607.749290] Dynamic subtest vecs0: SUCCESS (2.153s)
[607.760725] Starting dynamic subtest: ccs0
[609.900812] Dynamic subtest ccs0: SUCCESS (2.149s)
[609.902732] Subtest parallel: SUCCESS (12.916s)
[610.998182] [086/133] (410s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[611.111215] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[611.115249] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[611.216818] [087/133] (410s left) dumb_buffer (map-uaf)
[611.272767] Starting subtest: map-uaf
[611.276230] Subtest map-uaf: SUCCESS (0.006s)
[611.391218] [088/133] (410s left) kms_psr (psr-sprite-render)
[611.499442] Starting subtest: psr-sprite-render
[611.501521] Starting dynamic subtest: eDP-1
[613.274295] Dynamic subtest eDP-1: SUCCESS (1.771s)
[613.276772] Subtest psr-sprite-render: SUCCESS (1.772s)
[614.122999] [089/133] (407s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[614.188553] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[614.294841] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[614.387498] [090/133] (407s left) gem_linear_blits (normal)
[614.605859] Starting subtest: normal
[618.442429] Subtest normal: SUCCESS (3.834s)
[618.587077] [091/133] (403s left) perf_pmu (init-wait)
[618.675940] Starting subtest: init-wait
[618.678158] Starting dynamic subtest: rcs0
[618.680502] Dynamic subtest rcs0: SUCCESS (0.001s)
[618.690711] Starting dynamic subtest: bcs0
[618.692642] Dynamic subtest bcs0: SUCCESS (0.000s)
[618.701603] Starting dynamic subtest: vcs0
[618.703540] Dynamic subtest vcs0: SUCCESS (0.001s)
[618.712611] Starting dynamic subtest: vcs1
[618.714542] Dynamic subtest vcs1: SUCCESS (0.000s)
[618.724167] Starting dynamic subtest: vecs0
[618.726472] Dynamic subtest vecs0: SUCCESS (0.000s)
[618.738277] Starting dynamic subtest: ccs0
[618.740202] Dynamic subtest ccs0: SUCCESS (0.000s)
[618.742104] Subtest init-wait: SUCCESS (0.007s)
[618.797512] [092/133] (403s left) i915_drm_fdinfo (context-close-stress)
[618.840009] Starting subtest: context-close-stress
[629.588363] Subtest context-close-stress: SUCCESS (10.744s)
[629.676403] [093/133] (392s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[629.993012] Starting subtest: 2x-long-cursor-vs-flip-legacy
[629.997638] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[630.136173] [094/133] (391s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[630.240710] Starting subtest: bad-aux-stride-y-tiled-ccs
[630.242980] Starting dynamic subtest: pipe-A-eDP-1
[630.264486] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[630.275587] Starting dynamic subtest: pipe-B-eDP-1
[630.296225] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[630.306045] Starting dynamic subtest: pipe-C-eDP-1
[630.327935] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[630.338899] Starting dynamic subtest: pipe-D-eDP-1
[630.360982] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[630.365348] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[632.485130] [095/133] (389s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[632.588987] Starting subtest: 4-tiled-16bpp-rotate-270
[632.609945] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.020s)
[632.732737] [096/133] (389s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[632.823025] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[632.825353] Starting dynamic subtest: pipe-A-eDP-1
[632.883998] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[632.897179] Starting dynamic subtest: pipe-B-eDP-1
[632.954140] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[632.964901] Starting dynamic subtest: pipe-C-eDP-1
[633.022314] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[633.033470] Starting dynamic subtest: pipe-D-eDP-1
[633.089478] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[633.093693] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[635.054515] [097/133] (386s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[635.159079] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[635.161248] Starting dynamic subtest: pipe-A-eDP-1
[635.232211] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[635.243408] Starting dynamic subtest: pipe-B-eDP-1
[636.329416] Dynamic subtest pipe-B-eDP-1: SKIP (1.095s)
[636.333786] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.174s)
[637.526307] [098/133] (384s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[637.645890] Starting subtest: cursorB-vs-flipB-atomic
[637.650280] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[637.791219] [099/133] (384s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[637.889760] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[637.893625] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[637.988489] [100/133] (384s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[638.042334] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[638.046823] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[638.241984] [101/133] (383s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[638.339594] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[642.743811] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.406s)
[643.951526] [102/133] (378s left) gem_pxp (reject-modify-context-protection-off-3)
[644.072031] Starting subtest: reject-modify-context-protection-off-3
[644.074709] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[644.192704] [103/133] (378s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[644.282443] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[644.286795] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[645.373903] [104/133] (376s left) syncobj_wait (single-wait-submitted)
[645.447436] Starting subtest: single-wait-submitted
[645.550616] Subtest single-wait-submitted: SUCCESS (0.104s)
[645.639930] [105/133] (376s left) kms_legacy_colorkey (basic)
[645.736873] Starting subtest: basic
[645.739011] Starting dynamic subtest: pipe-A
[645.779695] Dynamic subtest pipe-A: SUCCESS (0.045s)
[645.791426] Starting dynamic subtest: pipe-B
[645.793348] Dynamic subtest pipe-B: SUCCESS (0.000s)
[645.802631] Starting dynamic subtest: pipe-C
[645.804854] Dynamic subtest pipe-C: SUCCESS (0.000s)
[645.814064] Starting dynamic subtest: pipe-D
[645.816293] Dynamic subtest pipe-D: SUCCESS (0.000s)
[645.818471] Subtest basic: SUCCESS (0.050s)
[645.856437] [106/133] (376s left) prime_mmap (test_aperture_limit)
[645.907359] Starting subtest: test_aperture_limit
[645.909336] Starting dynamic subtest: test_aperture_limit-smem
[645.914338] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[645.918851] Subtest test_aperture_limit: SKIP (0.008s)
[646.014038] [107/133] (376s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[648.096960] Starting subtest: dpms-mode-unset-lpsp
[652.160601] Subtest dpms-mode-unset-lpsp: SUCCESS (4.067s)
[652.545791] [108/133] (369s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[652.614864] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[652.670109] [109/133] (369s left) dmabuf_sync_file (import-multiple-read-write)
[652.727098] Starting subtest: import-multiple-read-write
[652.729353] Subtest import-multiple-read-write: SUCCESS (0.003s)
[652.786679] [110/133] (369s left) gem_partial_pwrite_pread (write-snoop)
[652.843741] Subtest write-snoop: SKIP (0.000s)
[652.921899] [111/133] (369s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[653.007242] Starting subtest: primary-yf-tiled-reflect-x-0
[653.067253] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[653.170904] [112/133] (369s left) kms_psr (psr2-sprite-mmap-cpu)
[653.270982] Starting subtest: psr2-sprite-mmap-cpu
[653.273278] Starting dynamic subtest: eDP-1
[655.019372] Dynamic subtest eDP-1: SUCCESS (1.748s)
[655.021954] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.749s)
[655.895747] [113/133] (366s left) gem_create (create-ext-placement-sanity-check)
[656.068297] Starting subtest: create-ext-placement-sanity-check
[656.070881] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[656.186590] [114/133] (366s left) kms_color_pipeline (plane-ctm3x4)
[656.276887] Starting subtest: plane-ctm3x4
[656.400046] Starting dynamic subtest: pipe-A-plane-0
[656.567282] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[656.580341] Starting dynamic subtest: pipe-A-plane-1
[656.677901] Dynamic subtest pipe-A-plane-1: SUCCESS (0.110s)
[656.693891] Starting dynamic subtest: pipe-A-plane-2
[656.823918] Dynamic subtest pipe-A-plane-2: SUCCESS (0.142s)
[657.994412] Starting dynamic subtest: pipe-B-plane-0
[658.118774] Dynamic subtest pipe-B-plane-0: SUCCESS (0.133s)
[658.129578] Starting dynamic subtest: pipe-B-plane-1
[658.229931] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s)
[658.240511] Starting dynamic subtest: pipe-B-plane-2
[658.385997] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[659.637992] Starting dynamic subtest: pipe-C-plane-0
[659.737466] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[659.748102] Starting dynamic subtest: pipe-C-plane-1
[659.848935] Dynamic subtest pipe-C-plane-1: SUCCESS (0.111s)
[659.859384] Starting dynamic subtest: pipe-C-plane-2
[659.972735] Dynamic subtest pipe-C-plane-2: SUCCESS (0.121s)
[661.195504] Starting dynamic subtest: pipe-D-plane-0
[661.296839] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[661.310438] Starting dynamic subtest: pipe-D-plane-1
[661.408043] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[661.418255] Starting dynamic subtest: pipe-D-plane-2
[661.530348] Dynamic subtest pipe-D-plane-2: SUCCESS (0.121s)
[661.821234] Subtest plane-ctm3x4: SUCCESS (5.541s)
[662.623587] [115/133] (360s left) syncobj_timeline (invalid-query-illegal-handle)
[662.693091] Starting subtest: invalid-query-illegal-handle
[662.695455] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[662.801945] [116/133] (360s left) kms_psr (fbc-psr-cursor-plane-onoff)
[662.899422] Starting subtest: fbc-psr-cursor-plane-onoff
[662.901357] Starting dynamic subtest: eDP-1
[662.905400] Dynamic subtest eDP-1: SKIP (0.000s)
[662.909457] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[662.985616] [117/133] (359s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[663.087851] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[663.090050] Starting dynamic subtest: pipe-A
[663.150289] Dynamic subtest pipe-A: SUCCESS (0.065s)
[663.160597] Starting dynamic subtest: pipe-B
[664.346942] Dynamic subtest pipe-B: SUCCESS (1.195s)
[664.359397] Starting dynamic subtest: pipe-C
[665.455898] Dynamic subtest pipe-C: SUCCESS (1.106s)
[665.466230] Starting dynamic subtest: pipe-D
[666.607862] Dynamic subtest pipe-D: SUCCESS (1.151s)
[666.610462] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.521s)
[667.748891] [118/133] (355s left) kms_addfb_basic (bad-pitch-1024)
[667.805436] Starting subtest: bad-pitch-1024
[667.807372] Subtest bad-pitch-1024: SUCCESS (0.000s)
[667.939338] [119/133] (354s left) gem_exec_balancer (parallel-keep-submit-fence)
[668.214372] Starting subtest: parallel-keep-submit-fence
[669.345218] Subtest parallel-keep-submit-fence: SUCCESS (1.134s)
[669.454025] [120/133] (353s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[669.591733] Starting subtest: 2x-long-flip-vs-cursor-atomic
[669.598917] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.004s)
[669.742780] [121/133] (353s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[669.837406] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[669.841856] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[669.933861] [122/133] (353s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[670.039043] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[670.063134] Starting dynamic subtest: pipe-A-plane-0
[670.685215] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[670.695461] Starting dynamic subtest: pipe-A-plane-3
[671.074014] Dynamic subtest pipe-A-plane-3: SUCCESS (0.388s)
[672.135465] Starting dynamic subtest: pipe-B-plane-0
[672.771519] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[672.781806] Starting dynamic subtest: pipe-B-plane-3
[673.183205] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s)
[673.497939] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.460s)
[674.335988] [123/133] (348s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[674.427162] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[674.431167] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[674.520045] [124/133] (348s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[676.152594] Starting subtest: modeset-lpsp-stress-no-wait
[686.126683] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.981s)
[686.220266] [125/133] (336s left) i915_pm_rpm (gem-execbuf-stress)
[688.049601] Starting subtest: gem-execbuf-stress
[688.051708] Starting dynamic subtest: smem0
[700.812729] Dynamic subtest smem0: SUCCESS (12.765s)
[700.826423] Starting dynamic subtest: extra-wait-smem0
[763.062699] Dynamic subtest extra-wait-smem0: SUCCESS (62.235s)
[763.065874] Subtest gem-execbuf-stress: SUCCESS (75.005s)
[763.443622] [126/133] (259s left) kms_invalid_mode (bad-vtotal)
[763.555826] Starting subtest: bad-vtotal
[763.558032] Starting dynamic subtest: pipe-A-eDP-1
[763.838334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[763.848980] Starting dynamic subtest: pipe-B-eDP-1
[763.850847] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[763.860953] Starting dynamic subtest: pipe-C-eDP-1
[763.863047] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[763.873024] Starting dynamic subtest: pipe-D-eDP-1
[763.875447] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[763.877735] Subtest bad-vtotal: SUCCESS (0.289s)
[764.653201] [127/133] (258s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[765.036546] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[765.856561] [128/133] (257s left) drm_read (empty-block)
[765.992622] Starting subtest: empty-block
[766.995083] Subtest empty-block: SUCCESS (1.000s)
[767.145111] [129/133] (256s left) gem_mmap_gtt (basic)
[767.195709] Subtest basic: SKIP (0.000s)
[767.255270] [130/133] (256s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[767.321574] Starting subtest: single-wait-for-submit-unsubmitted
[767.422005] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[767.517377] [131/133] (255s left) gem_ctx_persistence (engines-queued)
[767.570770] Starting subtest: engines-queued
[767.573171] Starting dynamic subtest: rcs0
[767.644044] Dynamic subtest rcs0: SUCCESS (0.073s)
[767.656681] Starting dynamic subtest: bcs0
[767.681961] Dynamic subtest bcs0: SUCCESS (0.036s)
[767.692338] Starting dynamic subtest: vcs0
[768.919991] Dynamic subtest vcs0: SUCCESS (1.235s)
[768.933604] Starting dynamic subtest: vcs1
[770.904519] Dynamic subtest vcs1: SUCCESS (1.981s)
[770.918405] Starting dynamic subtest: vecs0
[772.889073] Dynamic subtest vecs0: SUCCESS (1.981s)
[772.902506] Starting dynamic subtest: ccs0
[773.067356] Dynamic subtest ccs0: SUCCESS (0.177s)
[773.069822] Subtest engines-queued: SUCCESS (5.495s)
[773.183231] [132/133] (250s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[773.277580] Starting subtest: fbc-dirtyfb-ioctl
[773.279911] Starting dynamic subtest: A-eDP-1
[775.827739] Dynamic subtest A-eDP-1: SUCCESS (2.549s)
[775.829986] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.550s)
[776.649952] [133/133] (246s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[776.777548] Starting subtest: cursor-vs-flip-legacy
[806.456521] Subtest cursor-vs-flip-legacy: SUCCESS (29.671s)
[807.274115] 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.