[59.601646] Initializing watchdogs
[59.601694]   /dev/watchdog0
[59.616572] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.621371] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.623848] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.627309] [001/133] (960s left) kms_cursor_crc (cursor-random-32x32)
[59.802058] Starting subtest: cursor-random-32x32
[59.855189] Subtest cursor-random-32x32: SKIP (0.050s)
[60.128958] [002/133] (960s left) gem_exec_schedule (timeslicing)
[60.199595] Starting subtest: timeslicing
[60.201814] Starting dynamic subtest: rcs0
[60.211591] Dynamic subtest rcs0: SUCCESS (0.020s)
[60.221239] Starting dynamic subtest: bcs0
[60.231639] Dynamic subtest bcs0: SUCCESS (0.020s)
[60.239729] Starting dynamic subtest: vcs0
[60.255923] Dynamic subtest vcs0: SUCCESS (0.024s)
[60.263282] Starting dynamic subtest: vcs1
[60.278850] Dynamic subtest vcs1: SUCCESS (0.022s)
[60.286151] Starting dynamic subtest: vecs0
[60.299380] Dynamic subtest vecs0: SUCCESS (0.020s)
[60.306750] Starting dynamic subtest: ccs0
[60.321250] Dynamic subtest ccs0: SUCCESS (0.021s)
[60.323621] Subtest timeslicing: SUCCESS (0.130s)
[61.963160] [003/133] (958s left) kms_plane (plane-panning-top-left)
[62.062000] Starting subtest: plane-panning-top-left
[62.064480] Starting dynamic subtest: pipe-A
[63.793020] Dynamic subtest pipe-A: SUCCESS (1.725s)
[63.800659] Starting dynamic subtest: pipe-B
[66.215966] Dynamic subtest pipe-B: SUCCESS (2.417s)
[66.218393] Subtest plane-panning-top-left: SUCCESS (4.144s)
[67.089809] [004/133] (953s left) kms_busy (basic)
[67.318615] Starting subtest: basic
[67.321604] Starting dynamic subtest: flip
[68.696967] Dynamic subtest flip: SUCCESS (1.375s)
[68.706870] Starting dynamic subtest: modeset
[71.649779] Dynamic subtest modeset: SUCCESS (2.950s)
[71.652308] Subtest basic: SUCCESS (4.328s)
[72.436069] [005/133] (947s left) kms_addfb_basic (basic-x-tiled-legacy)
[72.498026] Starting subtest: basic-x-tiled-legacy
[72.502328] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[72.630962] [006/133] (947s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[72.729719] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[77.034055] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.306s)
[78.231085] [007/133] (942s left) gem_vm_create (execbuf)
[78.302850] Starting subtest: execbuf
[78.307252] Subtest execbuf: SUCCESS (0.007s)
[78.423502] [008/133] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[78.527454] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[87.196401] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.668s)
[87.309425] [009/133] (933s left) gem_ctx_param (basic-default)
[87.374557] Starting subtest: basic-default
[87.376987] Subtest basic-default: SUCCESS (0.000s)
[87.449192] [010/133] (933s left) kms_properties (crtc-properties-atomic)
[87.537644] Starting subtest: crtc-properties-atomic
[87.540050] Starting dynamic subtest: pipe-A-eDP-1
[87.972691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[87.982566] Starting dynamic subtest: pipe-B-eDP-1
[89.176797] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.202s)
[89.186512] Starting dynamic subtest: pipe-C-eDP-1
[90.303321] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[90.312381] Starting dynamic subtest: pipe-D-eDP-1
[91.446521] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.143s)
[91.448903] Subtest crtc-properties-atomic: SUCCESS (3.907s)
[92.254216] [011/133] (928s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[92.359144] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[92.361447] Starting dynamic subtest: pipe-A-default-mode
[95.071034] Dynamic subtest pipe-A-default-mode: SUCCESS (2.709s)
[95.073362] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.710s)
[95.943090] [012/133] (924s left) gem_pread (bench)
[96.008369] Subtest bench: SKIP (0.000s)
[96.067377] [013/133] (924s left) prime_mmap_coherency (write)
[96.128064] Starting subtest: write
[101.510528] Subtest write: SUCCESS (5.379s)
[101.653088] [014/133] (919s left) gem_exec_reloc (basic-cpu)
[101.709323] Subtest basic-cpu: SKIP (0.000s)
[101.775260] [015/133] (918s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[101.879503] Starting subtest: fbc-tiling-linear
[105.569748] Subtest fbc-tiling-linear: SUCCESS (3.693s)
[106.746791] [016/133] (914s left) kms_psr (fbc-psr2-basic)
[106.850831] Starting subtest: fbc-psr2-basic
[106.853125] Starting dynamic subtest: eDP-1
[106.857473] Dynamic subtest eDP-1: SKIP (0.000s)
[106.861799] Subtest fbc-psr2-basic: SKIP (0.001s)
[106.923950] [017/133] (913s left) kms_chamelium_frames (dp-crc-single)
[107.307333] Subtest dp-crc-single: SKIP (0.000s)
[108.143396] [018/133] (912s left) kms_vblank (wait-forked)
[108.256123] Starting subtest: wait-forked
[108.257979] Starting dynamic subtest: pipe-A-eDP-1
[110.075539] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.818s)
[110.089077] Starting dynamic subtest: pipe-D-eDP-1
[112.570626] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.493s)
[112.572956] Subtest wait-forked: SUCCESS (4.314s)
[113.424806] [019/133] (907s left) i915_hangman (gt-engine-hang)
[113.491837] Starting subtest: gt-engine-hang
[113.493899] Starting dynamic subtest: rcs0
[114.871926] Dynamic subtest rcs0: SUCCESS (1.380s)
[114.883096] Starting dynamic subtest: bcs0
[116.854756] Dynamic subtest bcs0: SUCCESS (1.981s)
[116.865883] Starting dynamic subtest: vcs0
[118.902394] Dynamic subtest vcs0: SUCCESS (2.045s)
[118.914227] Starting dynamic subtest: vcs1
[120.885986] Dynamic subtest vcs1: SUCCESS (1.982s)
[120.898527] Starting dynamic subtest: vecs0
[122.870086] Dynamic subtest vecs0: SUCCESS (1.982s)
[122.880886] Starting dynamic subtest: ccs0
[124.854055] Dynamic subtest ccs0: SUCCESS (1.982s)
[124.856794] Subtest gt-engine-hang: SUCCESS (11.362s)
[124.973733] [020/133] (895s left) syncobj_eventfd (timeline-wait-signaled)
[125.044198] Starting subtest: timeline-wait-signaled
[125.046576] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[125.149273] [021/133] (895s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[125.262786] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[125.267133] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[125.328843] [022/133] (895s left) api_intel_allocator (fork-simple-stress)
[125.392748] Starting subtest: fork-simple-stress
[130.792762] Subtest fork-simple-stress: SUCCESS (5.399s)
[130.908777] [023/133] (890s left) gem_mmap_wc (coherency)
[130.973404] Subtest coherency: SKIP (0.000s)
[131.037599] [024/133] (890s left) gem_exec_schedule (pi-common)
[131.232117] Starting subtest: pi-common
[131.234064] Starting dynamic subtest: rcs0
[131.344124] Dynamic subtest rcs0: SUCCESS (0.116s)
[131.352820] Starting dynamic subtest: bcs0
[131.377249] Dynamic subtest bcs0: SUCCESS (0.032s)
[131.385266] Starting dynamic subtest: vcs0
[131.409660] Dynamic subtest vcs0: SUCCESS (0.032s)
[131.417778] Starting dynamic subtest: vcs1
[131.440791] Dynamic subtest vcs1: SUCCESS (0.031s)
[131.449225] Starting dynamic subtest: vecs0
[131.472395] Dynamic subtest vecs0: SUCCESS (0.031s)
[131.480623] Starting dynamic subtest: ccs0
[131.505910] Dynamic subtest ccs0: SUCCESS (0.033s)
[131.508115] Subtest pi-common: SUCCESS (0.278s)
[131.760244] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[131.763769] [025/133] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[131.884032] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[131.888252] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[131.994412] [026/133] (889s left) gem_mmap (basic)
[132.065150] Subtest basic: SKIP (0.000s)
[132.131691] [027/133] (889s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[132.238512] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[132.242693] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[132.358881] [028/133] (888s left) syncobj_wait (invalid-reset-one-illegal-handle)
[132.419100] Starting subtest: invalid-reset-one-illegal-handle
[132.421365] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[132.511697] [029/133] (888s left) gem_readwrite (new-obj)
[132.573628] Subtest new-obj: SKIP (0.000s)
[132.639602] [030/133] (888s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[132.737986] Starting subtest: yf-tiled-8bpp-rotate-0
[132.741394] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[132.829851] [031/133] (888s left) sysfs_heartbeat_interval (invalid)
[132.905057] Starting subtest: invalid
[132.907153] Starting dynamic subtest: vecs0
[132.909091] Dynamic subtest vecs0: SUCCESS (0.000s)
[132.916555] Starting dynamic subtest: ccs0
[132.918170] Dynamic subtest ccs0: SUCCESS (0.000s)
[132.925349] Starting dynamic subtest: vcs0
[132.926979] Dynamic subtest vcs0: SUCCESS (0.000s)
[132.934206] Starting dynamic subtest: bcs0
[132.935778] Dynamic subtest bcs0: SUCCESS (0.000s)
[132.942795] Starting dynamic subtest: rcs0
[132.944380] Dynamic subtest rcs0: SUCCESS (0.000s)
[132.951848] Starting dynamic subtest: vcs1
[132.953692] Dynamic subtest vcs1: SUCCESS (0.000s)
[132.955494] Subtest invalid: SUCCESS (0.004s)
[133.008719] [032/133] (888s left) gem_sync (basic-all)
[133.088456] Starting subtest: basic-all
[135.466141] Subtest basic-all: SUCCESS (2.384s)
[135.647225] [033/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[135.755075] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[135.758961] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[135.841659] [034/133] (885s left) kms_hdr (bpc-switch-suspend)
[135.930176] Starting subtest: bpc-switch-suspend
[137.010437] Starting dynamic subtest: pipe-A-eDP-1
[156.287794] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.440s)
[156.290204] Subtest bpc-switch-suspend: SUCCESS (6.522s)
[156.424897] [035/133] (865s left) gem_spin_batch (legacy-resubmit)
[156.513403] Starting subtest: legacy-resubmit
[156.516100] Starting dynamic subtest: default
[156.523952] Dynamic subtest default: SUCCESS (0.010s)
[156.535867] Starting dynamic subtest: render
[156.538170] Dynamic subtest render: SUCCESS (0.002s)
[156.548170] Starting dynamic subtest: bsd
[156.550304] Dynamic subtest bsd: SUCCESS (0.003s)
[156.559200] Starting dynamic subtest: bsd1
[156.561403] Dynamic subtest bsd1: SUCCESS (0.001s)
[156.569915] Starting dynamic subtest: bsd2
[156.572089] Dynamic subtest bsd2: SUCCESS (0.002s)
[156.580704] Starting dynamic subtest: blt
[156.582913] Dynamic subtest blt: SUCCESS (0.004s)
[156.593700] Starting dynamic subtest: vebox
[156.595841] Dynamic subtest vebox: SUCCESS (0.003s)
[156.597964] Subtest legacy-resubmit: SUCCESS (0.029s)
[156.774576] [036/133] (864s left) kms_vrr (seamless-rr-switch-drrs)
[156.872957] Starting subtest: seamless-rr-switch-drrs
[156.879834] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[156.963632] [037/133] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[157.068136] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[157.072468] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[157.163977] [038/133] (864s left) gem_exec_balancer (bonded-semaphore)
[157.226512] Starting subtest: bonded-semaphore
[157.231009] Subtest bonded-semaphore: SKIP (0.000s)
[157.559966] [039/133] (864s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[157.612876] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[157.661090] [040/133] (864s left) kms_content_protection (dp-mst-lic-type-1)
[157.803800] Starting subtest: dp-mst-lic-type-1
[157.808016] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[157.915013] [041/133] (863s left) kms_atomic (plane-overlay-legacy)
[158.010741] Starting subtest: plane-overlay-legacy
[158.013076] Starting dynamic subtest: pipe-A-eDP-1
[158.436178] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[158.438383] Subtest plane-overlay-legacy: SUCCESS (0.419s)
[159.237791] [042/133] (862s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[159.337460] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[166.215536] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.802s)
[166.341818] [043/133] (855s left) kms_plane_multiple (tiling-x)
[166.431325] Starting subtest: tiling-x
[166.433887] Starting dynamic subtest: pipe-A-eDP-1
[170.243561] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.789s)
[170.253373] Starting dynamic subtest: pipe-B-eDP-1
[174.750024] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.488s)
[174.760140] Starting dynamic subtest: pipe-C-eDP-1
[179.074035] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.314s)
[179.083552] Starting dynamic subtest: pipe-D-eDP-1
[183.507369] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.426s)
[183.509696] Subtest tiling-x: SUCCESS (17.022s)
[184.326014] [044/133] (837s left) gem_mmap_offset (close-race)
[184.384204] Starting subtest: close-race
[204.497817] Subtest close-race: SUCCESS (20.109s)
[204.625789] [045/133] (817s left) perf_pmu (semaphore-busy)
[204.668521] Starting subtest: semaphore-busy
[204.670711] Starting dynamic subtest: rcs0
[206.302396] Dynamic subtest rcs0: SUCCESS (1.630s)
[206.314359] Starting dynamic subtest: bcs0
[207.936488] Dynamic subtest bcs0: SUCCESS (1.631s)
[207.947789] Starting dynamic subtest: vcs0
[212.236911] Dynamic subtest vcs0: SUCCESS (4.297s)
[212.247786] Starting dynamic subtest: vcs1
[217.228283] Dynamic subtest vcs1: SUCCESS (4.985s)
[217.239484] Starting dynamic subtest: vecs0
[223.243580] Dynamic subtest vecs0: SUCCESS (6.010s)
[223.253419] Starting dynamic subtest: ccs0
[225.313089] Dynamic subtest ccs0: FAIL (2.017s)
[225.315428] Subtest semaphore-busy: FAIL (20.585s)
[225.376884] [046/133] (796s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[225.482265] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[225.486714] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[225.577522] [047/133] (796s left) gem_exec_reloc (basic-write-cpu-noreloc)
[225.638170] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[225.709344] [048/133] (796s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[225.807562] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[226.610272] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.804s)
[226.772173] [049/133] (795s left) kms_flip (dpms-off-confusion-interruptible)
[226.884419] Starting subtest: dpms-off-confusion-interruptible
[226.887885] Starting dynamic subtest: A-eDP1
[235.615180] Dynamic subtest A-eDP1: SUCCESS (8.723s)
[235.627272] Starting dynamic subtest: B-eDP1
[244.241392] Dynamic subtest B-eDP1: SUCCESS (8.621s)
[244.250952] Starting dynamic subtest: C-eDP1
[252.861203] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[252.873818] Starting dynamic subtest: D-eDP1
[261.494663] Dynamic subtest D-eDP1: SUCCESS (8.634s)
[261.500173] Subtest dpms-off-confusion-interruptible: SUCCESS (34.611s)
[262.659181] [050/133] (759s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[262.757208] Starting subtest: crc-primary-basic-y-tiled-ccs
[262.759394] Starting dynamic subtest: pipe-A-eDP-1
[262.780715] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.790436] Starting dynamic subtest: pipe-B-eDP-1
[262.810741] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.819277] Starting dynamic subtest: pipe-C-eDP-1
[262.839866] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.848464] Starting dynamic subtest: pipe-D-eDP-1
[262.870186] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.874490] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[265.008213] [051/133] (757s left) gem_exec_gttfill (multigpu-basic)
[265.180680] Starting subtest: multigpu-basic
[279.810875] Subtest multigpu-basic: SUCCESS (14.634s)
[279.857855] [052/133] (742s left) kms_cursor_crc (cursor-alpha-opaque)
[280.015416] Starting subtest: cursor-alpha-opaque
[280.017685] Starting dynamic subtest: pipe-A-eDP-1
[280.688807] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.670s)
[280.697950] Starting dynamic subtest: pipe-D-eDP-1
[281.999824] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s)
[282.001657] Subtest cursor-alpha-opaque: SUCCESS (1.984s)
[282.796979] [053/133] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[282.892913] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[290.188931] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.301s)
[290.328779] [054/133] (732s left) kms_flip (flip-vs-suspend-interruptible)
[290.429876] Starting subtest: flip-vs-suspend-interruptible
[290.432019] Starting dynamic subtest: A-eDP1
[339.146812] Dynamic subtest A-eDP1: SUCCESS (4.651s)
[339.159744] Starting dynamic subtest: B-eDP1
[388.201391] Dynamic subtest B-eDP1: SUCCESS (4.559s)
[388.213924] Starting dynamic subtest: C-eDP1
[437.141592] Dynamic subtest C-eDP1: SUCCESS (4.522s)
[437.156332] Starting dynamic subtest: D-eDP1
[486.153920] Dynamic subtest D-eDP1: SUCCESS (4.545s)
[486.156544] Subtest flip-vs-suspend-interruptible: SUCCESS (18.286s)
[487.354761] [055/133] (535s left) kms_psr (pr-cursor-plane-onoff)
[487.458248] Starting subtest: pr-cursor-plane-onoff
[487.463437] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[487.533830] [056/133] (534s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[487.631535] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[487.634479] Starting dynamic subtest: pipe-A-eDP-1
[493.544169] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.819s)
[493.555568] Starting dynamic subtest: pipe-B-eDP-1
[500.256245] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.655s)
[500.259118] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.478s)
[501.141043] [057/133] (521s left) kms_dp_link_training (uhbr-sst)
[501.234294] Starting subtest: uhbr-sst
[501.245388] Subtest uhbr-sst: SKIP (0.000s)
[501.316924] [058/133] (521s left) gem_ctx_persistence (processes)
[501.384366] Starting subtest: processes
[502.857792] Subtest processes: SUCCESS (1.467s)
[502.945734] [059/133] (519s left) gem_exec_reloc (basic-write-wc-active)
[503.012328] Subtest basic-write-wc-active: SKIP (0.000s)
[503.088353] [060/133] (519s left) kms_addfb_basic (bad-pitch-128)
[503.133758] Starting subtest: bad-pitch-128
[503.135770] Subtest bad-pitch-128: SUCCESS (0.000s)
[503.267742] [061/133] (519s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[503.361437] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[507.761697] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.395s)
[508.965825] [062/133] (513s left) syncobj_timeline (wait-all-complex)
[509.032327] Starting subtest: wait-all-complex
[509.250687] Subtest wait-all-complex: SUCCESS (0.217s)
[509.327450] [063/133] (513s left) gem_eio (in-flight-10ms)
[509.555498] Starting subtest: in-flight-10ms
[517.768264] Subtest in-flight-10ms: SUCCESS (8.203s)
[517.930042] [064/133] (504s left) kms_big_fb (linear-32bpp-rotate-90)
[518.031702] Starting subtest: linear-32bpp-rotate-90
[518.051203] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[518.170084] [065/133] (504s left) syncobj_timeline (reset-multiple-signaled)
[518.222276] Starting subtest: reset-multiple-signaled
[518.224438] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[518.312903] [066/133] (504s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[518.431926] Starting subtest: 2x-long-flip-vs-cursor-legacy
[518.436797] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[518.579248] [067/133] (504s left) gem_ctx_shared (q-smoketest)
[518.647345] Starting subtest: Q-smoketest
[518.649676] Starting dynamic subtest: rcs0
[524.214331] Dynamic subtest rcs0: SUCCESS (5.512s)
[524.226134] Starting dynamic subtest: bcs0
[529.739152] Dynamic subtest bcs0: SUCCESS (5.521s)
[529.750138] Starting dynamic subtest: vcs0
[535.231684] Dynamic subtest vcs0: SUCCESS (5.488s)
[535.243788] Starting dynamic subtest: vcs1
[540.716392] Dynamic subtest vcs1: SUCCESS (5.487s)
[540.726286] Starting dynamic subtest: vecs0
[546.198291] Dynamic subtest vecs0: SUCCESS (5.478s)
[546.209461] Starting dynamic subtest: ccs0
[551.694171] Dynamic subtest ccs0: SUCCESS (5.493s)
[551.696315] Subtest Q-smoketest: SUCCESS (32.988s)
[551.830221] [068/133] (471s left) kms_plane_alpha_blend (alpha-transparent-fb)
[551.933985] Starting subtest: alpha-transparent-fb
[552.230492] Starting dynamic subtest: pipe-A-eDP-1
[552.820269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[552.831875] Starting dynamic subtest: pipe-D-eDP-1
[554.247140] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.426s)
[554.249730] Subtest alpha-transparent-fb: SUCCESS (2.314s)
[555.058007] [069/133] (467s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[555.182718] Starting subtest: cursorB-vs-flipA-atomic-transitions
[555.188031] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[555.330552] [070/133] (467s left) gem_exec_reloc (basic-wc-gtt-active)
[555.391322] Subtest basic-wc-gtt-active: SKIP (0.000s)
[555.460637] [071/133] (467s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[555.579660] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[566.787583] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.202s)
[567.589895] [072/133] (455s left) gem_exec_whisper (basic-forked)
[567.656548] Starting subtest: basic-forked
[575.329546] Subtest basic-forked: SUCCESS (7.666s)
[575.522430] [073/133] (447s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[575.628508] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[575.639441] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[575.731489] [074/133] (447s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[575.832403] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[575.838064] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[575.940314] [075/133] (447s left) syncobj_wait (single-wait-all-submitted)
[575.988551] Starting subtest: single-wait-all-submitted
[576.089120] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[576.171173] [076/133] (447s left) i915_suspend (debugfs-reader)
[576.230578] Starting subtest: debugfs-reader
[594.130228] Subtest debugfs-reader: SUCCESS (3.139s)
[594.313786] [077/133] (429s left) kms_cursor_edge_walk (128x128-top-edge)
[594.417085] Starting subtest: 128x128-top-edge
[594.420294] Starting dynamic subtest: pipe-A-eDP-1
[597.939444] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.447s)
[597.954558] Starting dynamic subtest: pipe-D-eDP-1
[601.092246] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.110s)
[601.094839] Subtest 128x128-top-edge: SUCCESS (6.560s)
[601.922916] [078/133] (421s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[602.014407] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[602.017208] Starting dynamic subtest: pipe-A-eDP-1
[602.777395] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[602.788526] Starting dynamic subtest: pipe-B-eDP-1
[604.578363] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.786s)
[604.589315] Starting dynamic subtest: pipe-C-eDP-1
[606.419933] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.828s)
[606.432873] Starting dynamic subtest: pipe-D-eDP-1
[608.270364] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.836s)
[608.273439] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.203s)
[609.406355] [079/133] (414s left) gen9_exec_parse (basic-rejected)
[609.476370] Subtest basic-rejected: SKIP (0.000s)
[609.560365] [080/133] (414s left) api_intel_bb (object-noreloc-keep-cache-simple)
[609.623957] Starting subtest: object-noreloc-keep-cache-simple
[609.626736] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[609.743833] [081/133] (413s left) kms_selftest (drm_cmdline_parser)
[609.789710] Starting subtest: drm_cmdline_parser
[609.821264] Starting dynamic subtest: drm_test_cmdline_force_d_only
[609.905413] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.087s)
[609.916130] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[610.002692] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.096s)
[610.014461] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[610.095711] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.092s)
[610.107146] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[610.184392] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.088s)
[610.196389] Starting dynamic subtest: drm_test_cmdline_force_e_only
[610.259795] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.074s)
[610.270176] Starting dynamic subtest: drm_test_cmdline_res
[610.369959] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.109s)
[610.380116] Starting dynamic subtest: drm_test_cmdline_res_vesa
[610.452363] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.079s)
[610.462318] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[610.533622] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.080s)
[610.543409] Starting dynamic subtest: drm_test_cmdline_res_rblank
[610.620003] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.086s)
[610.631374] Starting dynamic subtest: drm_test_cmdline_res_bpp
[610.716558] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.094s)
[610.726293] Starting dynamic subtest: drm_test_cmdline_res_refresh
[610.817827] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.102s)
[610.828274] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[610.910415] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.092s)
[610.922018] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[610.993181] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.080s)
[611.004246] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[611.088943] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.096s)
[611.098974] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[611.186735] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.096s)
[611.197164] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[611.293187] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.103s)
[611.303281] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[611.385039] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.091s)
[611.395363] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[611.462553] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.076s)
[611.472822] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[611.550929] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.087s)
[611.560779] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[611.647032] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.095s)
[611.656805] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[611.740919] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.092s)
[611.750790] Starting dynamic subtest: drm_test_cmdline_name
[611.830974] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.090s)
[611.841528] Starting dynamic subtest: drm_test_cmdline_name_bpp
[611.924321] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.091s)
[611.934626] Starting dynamic subtest: drm_test_cmdline_name_option
[612.015092] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.089s)
[612.026422] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[612.093826] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.077s)
[612.103894] Starting dynamic subtest: drm_test_cmdline_rotate_0
[612.184373] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.090s)
[612.194043] Starting dynamic subtest: drm_test_cmdline_rotate_90
[612.272943] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.086s)
[612.284308] Starting dynamic subtest: drm_test_cmdline_rotate_180
[612.352423] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.078s)
[612.363106] Starting dynamic subtest: drm_test_cmdline_rotate_270
[612.438167] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.084s)
[612.450552] Starting dynamic subtest: drm_test_cmdline_hmirror
[612.528822] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.090s)
[612.540315] Starting dynamic subtest: drm_test_cmdline_vmirror
[612.621833] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.091s)
[612.633986] Starting dynamic subtest: drm_test_cmdline_margin_options
[612.711573] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.089s)
[612.723344] Starting dynamic subtest: drm_test_cmdline_multiple_options
[612.799878] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.086s)
[612.811310] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[612.893059] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.093s)
[612.904520] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[612.981915] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.088s)
[612.992817] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[613.071085] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.088s)
[613.081545] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[613.158412] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.086s)
[613.169241] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[613.240674] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.080s)
[613.250586] Starting dynamic subtest: drm_test_cmdline_invalid
[613.327248] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.087s)
[613.336915] Starting dynamic subtest: drm_test_cmdline_tv_options
[613.435035] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.106s)
[613.436940] Subtest drm_cmdline_parser: SUCCESS (3.633s)
[613.587775] [082/133] (410s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[613.684516] Starting subtest: x-tiled-16bpp-rotate-270
[613.707613] Subtest x-tiled-16bpp-rotate-270: SKIP (0.021s)
[613.824876] [083/133] (409s left) gen3_render_tiledx_blits
[613.950338] [084/133] (409s left) perf (whitelisted-registers-userspace-config)
[614.092763] Starting subtest: whitelisted-registers-userspace-config
[614.094540] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[614.138070] [085/133] (409s left) gem_exec_fence (parallel)
[614.312669] Starting subtest: parallel
[614.315504] Starting dynamic subtest: rcs0
[616.470343] Dynamic subtest rcs0: SUCCESS (2.154s)
[616.482785] Starting dynamic subtest: bcs0
[618.627543] Dynamic subtest bcs0: SUCCESS (2.153s)
[618.638371] Starting dynamic subtest: vcs0
[620.780561] Dynamic subtest vcs0: SUCCESS (2.149s)
[620.790931] Starting dynamic subtest: vcs1
[622.932560] Dynamic subtest vcs1: SUCCESS (2.149s)
[622.943260] Starting dynamic subtest: vecs0
[625.086744] Dynamic subtest vecs0: SUCCESS (2.151s)
[625.105221] Starting dynamic subtest: ccs0
[627.240842] Dynamic subtest ccs0: SUCCESS (2.151s)
[627.243100] Subtest parallel: SUCCESS (12.913s)
[627.829931] [086/133] (396s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[627.945757] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[627.951151] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[628.055970] [087/133] (395s left) dumb_buffer (map-uaf)
[628.117976] Starting subtest: map-uaf
[628.120515] Subtest map-uaf: SUCCESS (0.004s)
[628.223241] [088/133] (395s left) kms_psr (psr-sprite-render)
[628.314528] Starting subtest: psr-sprite-render
[628.317302] Starting dynamic subtest: eDP-1
[630.068873] Dynamic subtest eDP-1: SUCCESS (1.756s)
[630.071263] Subtest psr-sprite-render: SUCCESS (1.758s)
[630.944149] [089/133] (393s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[630.996431] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[631.103373] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[631.182869] [090/133] (392s left) gem_linear_blits (normal)
[631.433842] Starting subtest: normal
[636.267760] Subtest normal: SUCCESS (4.833s)
[636.500133] [091/133] (387s left) perf_pmu (init-wait)
[636.589084] Starting subtest: init-wait
[636.591810] Starting dynamic subtest: rcs0
[636.594275] Dynamic subtest rcs0: SUCCESS (0.001s)
[636.608351] Starting dynamic subtest: bcs0
[636.611210] Dynamic subtest bcs0: SUCCESS (0.001s)
[636.621461] Starting dynamic subtest: vcs0
[636.623885] Dynamic subtest vcs0: SUCCESS (0.001s)
[636.634346] Starting dynamic subtest: vcs1
[636.637006] Dynamic subtest vcs1: SUCCESS (0.001s)
[636.647007] Starting dynamic subtest: vecs0
[636.649238] Dynamic subtest vecs0: SUCCESS (0.000s)
[636.659145] Starting dynamic subtest: ccs0
[636.661361] Dynamic subtest ccs0: SUCCESS (0.001s)
[636.663775] Subtest init-wait: SUCCESS (0.008s)
[636.708577] [092/133] (387s left) i915_drm_fdinfo (context-close-stress)
[636.753545] Starting subtest: context-close-stress
[647.500111] Subtest context-close-stress: SUCCESS (10.745s)
[647.582741] [093/133] (376s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[647.846989] Starting subtest: 2x-long-cursor-vs-flip-legacy
[647.852252] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[647.993303] [094/133] (376s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[648.092326] Starting subtest: bad-aux-stride-y-tiled-ccs
[648.095017] Starting dynamic subtest: pipe-A-eDP-1
[648.120795] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[648.132368] Starting dynamic subtest: pipe-B-eDP-1
[648.158052] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[648.167870] Starting dynamic subtest: pipe-C-eDP-1
[648.193429] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[648.203374] Starting dynamic subtest: pipe-D-eDP-1
[648.230358] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[648.235933] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[650.282756] [095/133] (374s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[650.385999] Starting subtest: 4-tiled-16bpp-rotate-270
[650.407347] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.020s)
[650.534402] [096/133] (373s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[650.619187] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[650.621628] Starting dynamic subtest: pipe-A-eDP-1
[650.688639] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[650.700069] Starting dynamic subtest: pipe-B-eDP-1
[650.771261] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[650.782646] Starting dynamic subtest: pipe-C-eDP-1
[650.850105] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[650.860801] Starting dynamic subtest: pipe-D-eDP-1
[650.926556] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[650.931406] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[652.942358] [097/133] (371s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[653.046815] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[653.049172] Starting dynamic subtest: pipe-A-eDP-1
[653.118808] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[653.129441] Starting dynamic subtest: pipe-B-eDP-1
[654.215937] Dynamic subtest pipe-B-eDP-1: SKIP (1.093s)
[654.221306] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.172s)
[655.412546] [098/133] (369s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[655.527060] Starting subtest: cursorB-vs-flipB-atomic
[655.531921] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[655.674657] [099/133] (368s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[655.762555] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[655.767275] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[655.856929] [100/133] (368s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[655.913342] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[655.918743] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[656.104996] [101/133] (368s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[656.216421] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[660.677550] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.464s)
[661.819854] [102/133] (362s left) gem_pxp (reject-modify-context-protection-off-3)
[661.938421] Starting subtest: reject-modify-context-protection-off-3
[661.941424] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[662.048928] [103/133] (362s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[662.140202] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[662.145247] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[663.243907] [104/133] (361s left) syncobj_wait (single-wait-submitted)
[663.315256] Starting subtest: single-wait-submitted
[663.424083] Subtest single-wait-submitted: SUCCESS (0.107s)
[663.519911] [105/133] (361s left) kms_legacy_colorkey (basic)
[663.622766] Starting subtest: basic
[663.625501] Starting dynamic subtest: pipe-A
[663.664917] Dynamic subtest pipe-A: SUCCESS (0.045s)
[663.678540] Starting dynamic subtest: pipe-B
[663.681049] Dynamic subtest pipe-B: SUCCESS (0.000s)
[663.691522] Starting dynamic subtest: pipe-C
[663.694334] Dynamic subtest pipe-C: SUCCESS (0.000s)
[663.704528] Starting dynamic subtest: pipe-D
[663.707272] Dynamic subtest pipe-D: SUCCESS (0.000s)
[663.710021] Subtest basic: SUCCESS (0.050s)
[663.750619] [106/133] (361s left) prime_mmap (test_aperture_limit)
[663.806672] Starting subtest: test_aperture_limit
[663.809223] Starting dynamic subtest: test_aperture_limit-smem
[663.817516] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[663.822551] Subtest test_aperture_limit: SKIP (0.008s)
[663.902381] [107/133] (360s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[665.759641] Starting subtest: dpms-mode-unset-lpsp
[669.804510] Subtest dpms-mode-unset-lpsp: SUCCESS (4.048s)
[670.176152] [108/133] (354s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[670.234613] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[670.298665] [109/133] (354s left) dmabuf_sync_file (import-multiple-read-write)
[670.349465] Starting subtest: import-multiple-read-write
[670.352283] Subtest import-multiple-read-write: SUCCESS (0.003s)
[670.410967] [110/133] (354s left) gem_partial_pwrite_pread (write-snoop)
[670.462778] Subtest write-snoop: SKIP (0.000s)
[670.522313] [111/133] (354s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[670.617510] Starting subtest: primary-yf-tiled-reflect-x-0
[670.678189] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[670.785909] [112/133] (354s left) kms_psr (psr2-sprite-mmap-cpu)
[670.870321] Starting subtest: psr2-sprite-mmap-cpu
[670.873123] Starting dynamic subtest: eDP-1
[672.568399] Dynamic subtest eDP-1: SUCCESS (1.699s)
[672.571413] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.699s)
[673.442543] [113/133] (351s left) gem_create (create-ext-placement-sanity-check)
[673.607744] Starting subtest: create-ext-placement-sanity-check
[673.610503] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[673.722634] [114/133] (351s left) kms_color_pipeline (plane-ctm3x4)
[673.816767] Starting subtest: plane-ctm3x4
[673.954024] Starting dynamic subtest: pipe-A-plane-0
[674.129857] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[674.141193] Starting dynamic subtest: pipe-A-plane-1
[674.241442] Dynamic subtest pipe-A-plane-1: SUCCESS (0.110s)
[674.253561] Starting dynamic subtest: pipe-A-plane-2
[674.373942] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s)
[675.554386] Starting dynamic subtest: pipe-B-plane-0
[675.712567] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[675.723587] Starting dynamic subtest: pipe-B-plane-1
[675.821371] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s)
[675.832103] Starting dynamic subtest: pipe-B-plane-2
[675.943908] Dynamic subtest pipe-B-plane-2: SUCCESS (0.121s)
[677.179357] Starting dynamic subtest: pipe-C-plane-0
[677.280962] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[677.292112] Starting dynamic subtest: pipe-C-plane-1
[677.391828] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[677.402187] Starting dynamic subtest: pipe-C-plane-2
[677.503378] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[678.693547] Starting dynamic subtest: pipe-D-plane-0
[678.796281] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[678.807601] Starting dynamic subtest: pipe-D-plane-1
[678.918402] Dynamic subtest pipe-D-plane-1: SUCCESS (0.121s)
[678.929436] Starting dynamic subtest: pipe-D-plane-2
[679.062773] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[679.360853] Subtest plane-ctm3x4: SUCCESS (5.544s)
[680.162075] [115/133] (345s left) syncobj_timeline (invalid-query-illegal-handle)
[680.219670] Starting subtest: invalid-query-illegal-handle
[680.222193] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[680.314909] [116/133] (344s left) kms_psr (fbc-psr-cursor-plane-onoff)
[680.401852] Starting subtest: fbc-psr-cursor-plane-onoff
[680.404401] Starting dynamic subtest: eDP-1
[680.409364] Dynamic subtest eDP-1: SKIP (0.000s)
[680.414413] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[680.489065] [117/133] (344s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[680.584940] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[680.587465] Starting dynamic subtest: pipe-A
[680.648721] Dynamic subtest pipe-A: SUCCESS (0.065s)
[680.659765] Starting dynamic subtest: pipe-B
[681.797837] Dynamic subtest pipe-B: SUCCESS (1.147s)
[681.808548] Starting dynamic subtest: pipe-C
[682.910250] Dynamic subtest pipe-C: SUCCESS (1.111s)
[682.920547] Starting dynamic subtest: pipe-D
[684.038327] Dynamic subtest pipe-D: SUCCESS (1.127s)
[684.040978] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.455s)
[685.202686] [118/133] (340s left) kms_addfb_basic (bad-pitch-1024)
[685.257283] Starting subtest: bad-pitch-1024
[685.260000] Subtest bad-pitch-1024: SUCCESS (0.000s)
[685.382560] [119/133] (340s left) gem_exec_balancer (parallel-keep-submit-fence)
[685.645338] Starting subtest: parallel-keep-submit-fence
[687.012717] Subtest parallel-keep-submit-fence: SUCCESS (1.367s)
[687.108314] [120/133] (338s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[687.221343] Starting subtest: 2x-long-flip-vs-cursor-atomic
[687.227177] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[687.364523] [121/133] (338s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[687.463550] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[687.468974] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[687.547865] [122/133] (337s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[687.644297] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[687.671249] Starting dynamic subtest: pipe-A-plane-0
[688.381150] Dynamic subtest pipe-A-plane-0: SUCCESS (0.711s)
[688.393327] Starting dynamic subtest: pipe-A-plane-3
[688.858317] Dynamic subtest pipe-A-plane-3: SUCCESS (0.477s)
[690.008527] Starting dynamic subtest: pipe-B-plane-0
[690.677184] Dynamic subtest pipe-B-plane-0: SUCCESS (0.677s)
[690.688859] Starting dynamic subtest: pipe-B-plane-3
[691.113456] Dynamic subtest pipe-B-plane-3: SUCCESS (0.432s)
[691.425212] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.780s)
[692.285434] [123/133] (333s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[692.379936] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[692.385331] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[692.485451] [124/133] (333s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[694.728677] Starting subtest: modeset-lpsp-stress-no-wait
[704.559257] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.828s)
[704.641301] [125/133] (321s left) i915_pm_rpm (gem-execbuf-stress)
[706.778575] Starting subtest: gem-execbuf-stress
[706.781169] Starting dynamic subtest: smem0
[719.710783] Dynamic subtest smem0: SUCCESS (12.931s)
[719.724357] Starting dynamic subtest: extra-wait-smem0
[781.899695] Dynamic subtest extra-wait-smem0: SUCCESS (62.162s)
[781.902501] Subtest gem-execbuf-stress: SUCCESS (75.099s)
[782.290293] [126/133] (243s left) kms_invalid_mode (bad-vtotal)
[782.392542] Starting subtest: bad-vtotal
[782.395247] Starting dynamic subtest: pipe-A-eDP-1
[782.681553] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[782.694588] Starting dynamic subtest: pipe-B-eDP-1
[782.696997] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[782.708166] Starting dynamic subtest: pipe-C-eDP-1
[782.710875] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[782.721505] Starting dynamic subtest: pipe-D-eDP-1
[782.724265] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[782.727063] Subtest bad-vtotal: SUCCESS (0.296s)
[783.500926] [127/133] (242s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[783.891039] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[784.708415] [128/133] (241s left) drm_read (empty-block)
[784.843537] Starting subtest: empty-block
[785.845553] Subtest empty-block: SUCCESS (1.000s)
[785.973023] [129/133] (239s left) gem_mmap_gtt (basic)
[786.035392] Subtest basic: SKIP (0.000s)
[786.107665] [130/133] (239s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[786.156507] Starting subtest: single-wait-for-submit-unsubmitted
[786.263892] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[786.389928] [131/133] (239s left) gem_ctx_persistence (engines-queued)
[786.445300] Starting subtest: engines-queued
[786.448241] Starting dynamic subtest: rcs0
[786.500360] Dynamic subtest rcs0: SUCCESS (0.055s)
[786.514572] Starting dynamic subtest: bcs0
[786.537288] Dynamic subtest bcs0: SUCCESS (0.036s)
[786.548218] Starting dynamic subtest: vcs0
[788.593987] Dynamic subtest vcs0: SUCCESS (2.055s)
[788.608107] Starting dynamic subtest: vcs1
[790.578339] Dynamic subtest vcs1: SUCCESS (1.982s)
[790.592147] Starting dynamic subtest: vecs0
[792.561930] Dynamic subtest vecs0: SUCCESS (1.981s)
[792.575513] Starting dynamic subtest: ccs0
[792.762798] Dynamic subtest ccs0: SUCCESS (0.200s)
[792.765553] Subtest engines-queued: SUCCESS (6.321s)
[792.847608] [132/133] (233s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[792.949265] Starting subtest: fbc-dirtyfb-ioctl
[792.952028] Starting dynamic subtest: A-eDP-1
[795.591911] Dynamic subtest A-eDP-1: SUCCESS (2.644s)
[795.594534] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.645s)
[796.382278] [133/133] (229s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[796.499807] Starting subtest: cursor-vs-flip-legacy
[826.331434] Subtest cursor-vs-flip-legacy: SUCCESS (29.836s)
[827.196966] 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.