[58.588965] Initializing watchdogs
[58.589019]   /dev/watchdog0
[58.603477] [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]
[58.607849] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.610440] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.613668] [001/132] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[58.740722] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[62.292900] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.557s)
[63.419038] [002/132] (955s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[63.521867] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[70.201835] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.683s)
[70.315696] [003/132] (948s left) gem_exec_endless (dispatch)
[70.399463] Starting subtest: dispatch
[70.401729] Starting dynamic subtest: rcs0
[70.408990] Dynamic subtest rcs0: SUCCESS (0.006s)
[70.418116] Starting dynamic subtest: bcs0
[70.422360] Dynamic subtest bcs0: SUCCESS (0.008s)
[70.430384] Starting dynamic subtest: vcs0
[70.434519] Dynamic subtest vcs0: SUCCESS (0.005s)
[70.442629] Starting dynamic subtest: vcs1
[70.446865] Dynamic subtest vcs1: SUCCESS (0.005s)
[70.454287] Starting dynamic subtest: vecs0
[70.458599] Dynamic subtest vecs0: SUCCESS (0.005s)
[70.466126] Starting dynamic subtest: ccs0
[70.470449] Dynamic subtest ccs0: SUCCESS (0.004s)
[70.472678] Subtest dispatch: SUCCESS (0.035s)
[71.930939] [004/132] (947s left) sysfs_preempt_timeout (timeout)
[71.990427] Starting subtest: timeout
[71.992451] Starting dynamic subtest: vecs0
[81.868711] Dynamic subtest vecs0: SUCCESS (9.875s)
[81.878962] Starting dynamic subtest: ccs0
[83.048057] Dynamic subtest ccs0: SUCCESS (1.180s)
[83.057531] Starting dynamic subtest: vcs0
[92.885993] Dynamic subtest vcs0: SUCCESS (9.834s)
[92.896065] Starting dynamic subtest: bcs0
[94.070943] Dynamic subtest bcs0: SUCCESS (1.186s)
[94.084827] Starting dynamic subtest: rcs0
[95.242021] Dynamic subtest rcs0: SUCCESS (1.171s)
[95.250451] Starting dynamic subtest: vcs1
[104.909909] Dynamic subtest vcs1: SUCCESS (9.666s)
[104.912446] Subtest timeout: SUCCESS (32.918s)
[104.981849] [005/132] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[105.080776] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[105.085232] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[105.189294] [006/132] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[105.280645] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[105.285180] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[105.378018] [007/132] (913s left) i915_drm_fdinfo (virtual-idle)
[105.415250] Starting subtest: virtual-idle
[108.474211] Subtest virtual-idle: SUCCESS (3.056s)
[108.547904] [008/132] (910s left) gem_pread (snoop)
[108.611286] Subtest snoop: SKIP (0.000s)
[108.665922] [009/132] (910s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[108.762487] Starting subtest: fbc-rgb565-draw-mmap-cpu
[112.746933] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.989s)
[113.926696] [010/132] (905s left) i915_pm_rps (thresholds)
[113.995376] Starting subtest: thresholds
[114.000118] Subtest thresholds: SKIP (0.000s)
[114.116129] [011/132] (905s left) kms_setmode (invalid-clone-single-crtc-stealing)
[114.173714] Starting subtest: invalid-clone-single-crtc-stealing
[114.180389] Subtest invalid-clone-single-crtc-stealing: SKIP (0.001s)
[114.273783] [012/132] (905s left) kms_pm_dc (dc6-dpms)
[115.376795] Starting subtest: dc6-dpms
[117.492420] Subtest dc6-dpms: SUCCESS (2.115s)
[117.566134] [013/132] (902s left) kms_frontbuffer_tracking (psr-suspend)
[117.670740] Starting subtest: psr-suspend
[155.753331] Subtest psr-suspend: SUCCESS (8.051s)
[155.881189] [014/132] (863s left) prime_mmap (test_aperture_limit)
[155.950980] Starting subtest: test_aperture_limit
[155.953351] Starting dynamic subtest: test_aperture_limit-smem
[155.960424] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[155.965069] Subtest test_aperture_limit: SKIP (0.008s)
[156.064983] [015/132] (863s left) kms_plane_scaling (invalid-num-scalers)
[156.147498] Starting subtest: invalid-num-scalers
[156.149839] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[156.165207] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[156.174803] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[156.203855] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.036s)
[156.212660] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[156.240396] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.036s)
[156.249236] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[156.278007] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.037s)
[156.280238] Subtest invalid-num-scalers: SUCCESS (0.132s)
[156.373734] [016/132] (863s left) kms_cursor_crc (cursor-offscreen-64x21)
[156.565493] Starting subtest: cursor-offscreen-64x21
[156.617410] Subtest cursor-offscreen-64x21: SKIP (0.046s)
[156.821647] [017/132] (862s left) kms_flip (absolute-wf_vblank)
[156.911492] Starting subtest: absolute-wf_vblank
[156.913596] Starting dynamic subtest: A-eDP1
[165.703618] Dynamic subtest A-eDP1: SUCCESS (8.789s)
[165.714240] Starting dynamic subtest: B-eDP1
[174.427630] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[174.435914] Starting dynamic subtest: C-eDP1
[183.152694] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[183.163956] Starting dynamic subtest: D-eDP1
[191.891214] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[191.893163] Subtest absolute-wf_vblank: SUCCESS (34.977s)
[193.097341] [018/132] (826s left) kms_atomic_transition (plane-all-transition)
[193.186461] Starting subtest: plane-all-transition
[193.188686] Starting dynamic subtest: pipe-A-eDP-1
[195.682536] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[195.989971] Starting dynamic subtest: pipe-B-eDP-1
[199.242778] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.260s)
[199.545747] Subtest plane-all-transition: SUCCESS (6.359s)
[200.368317] [019/132] (819s left) gem_create (hog-create)
[200.430101] Starting subtest: hog-create
[200.432195] Starting dynamic subtest: smem0
[233.960184] Dynamic subtest smem0: SUCCESS (33.524s)
[233.962914] Subtest hog-create: SUCCESS (33.526s)
[234.147896] [020/132] (785s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[234.253324] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[235.243119] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.990s)
[235.351121] [021/132] (784s left) kms_cursor_edge_walk (64x64-right-edge)
[235.456318] Starting subtest: 64x64-right-edge
[235.458596] Starting dynamic subtest: pipe-A-eDP-1
[238.933167] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.476s)
[238.942454] Starting dynamic subtest: pipe-D-eDP-1
[242.057893] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[242.060211] Subtest 64x64-right-edge: SUCCESS (6.602s)
[242.865917] [022/132] (777s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[242.965605] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[244.043675] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.078s)
[244.172940] [023/132] (775s left) dmabuf_sync_file (import-basic)
[244.294406] Starting subtest: import-basic
[244.296187] Subtest import-basic: SUCCESS (0.001s)
[244.360852] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[244.363812] [024/132] (775s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[244.468503] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[244.470524] Starting dynamic subtest: pipe-A
[244.488768] Dynamic subtest pipe-A: SKIP (0.018s)
[244.497152] Starting dynamic subtest: pipe-B
[244.522226] Dynamic subtest pipe-B: SKIP (0.031s)
[244.530300] Starting dynamic subtest: pipe-C
[244.554255] Dynamic subtest pipe-C: SKIP (0.031s)
[244.562281] Starting dynamic subtest: pipe-D
[244.586507] Dynamic subtest pipe-D: SKIP (0.032s)
[244.589937] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.115s)
[244.697709] [025/132] (775s left) kms_pipe_stress (stress-xrgb8888-untiled)
[244.783460] Starting subtest: stress-xrgb8888-untiled
[250.630547] Subtest stress-xrgb8888-untiled: SUCCESS (5.846s)
[250.685736] [026/132] (769s left) kms_force_connector_basic (force-edid)
[250.762244] Starting subtest: force-edid
[251.124284] Subtest force-edid: SUCCESS (0.362s)
[251.268974] [027/132] (768s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[251.365350] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[251.368831] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[251.466965] [028/132] (768s left) kms_invalid_mode (zero-clock)
[251.559521] Starting subtest: zero-clock
[251.561541] Starting dynamic subtest: pipe-A-eDP-1
[251.850151] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[251.861088] Starting dynamic subtest: pipe-B-eDP-1
[251.863293] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[251.871430] Starting dynamic subtest: pipe-C-eDP-1
[251.873332] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[251.881321] Starting dynamic subtest: pipe-D-eDP-1
[251.883191] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[251.885050] Subtest zero-clock: SUCCESS (0.297s)
[252.689402] [029/132] (767s left) kms_flip (2x-flip-vs-wf_vblank)
[252.787694] Starting subtest: 2x-flip-vs-wf_vblank
[252.800160] Subtest 2x-flip-vs-wf_vblank: SKIP (0.014s)
[252.880322] [030/132] (767s left) gem_exec_balancer (bonded-false-hang)
[253.144850] Starting subtest: bonded-false-hang
[253.149806] Subtest bonded-false-hang: SKIP (0.000s)
[253.279426] [031/132] (767s left) syncobj_wait (invalid-reset-illegal-handle)
[253.335317] Starting subtest: invalid-reset-illegal-handle
[253.337165] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[253.429394] [032/132] (766s left) gem_ctx_persistence (legacy-engines-persistence)
[253.491315] Starting subtest: legacy-engines-persistence
[253.493663] Starting dynamic subtest: render
[254.311111] Dynamic subtest render: SUCCESS (0.819s)
[254.325976] Starting dynamic subtest: bsd1
[255.074143] Dynamic subtest bsd1: SUCCESS (0.760s)
[255.087702] Starting dynamic subtest: bsd2
[255.837121] Dynamic subtest bsd2: SUCCESS (0.759s)
[255.848243] Starting dynamic subtest: blt
[256.587145] Dynamic subtest blt: SUCCESS (0.747s)
[256.597647] Starting dynamic subtest: vebox
[257.380930] Dynamic subtest vebox: SUCCESS (0.791s)
[257.383569] Subtest legacy-engines-persistence: SUCCESS (3.891s)
[257.468516] [033/132] (762s left) kms_display_modes (extended-mode-basic)
[257.561134] Starting subtest: extended-mode-basic
[257.565499] Subtest extended-mode-basic: SKIP (0.000s)
[257.610002] [034/132] (762s left) api_intel_allocator (default-alignment)
[257.673588] Starting subtest: default-alignment
[257.675899] Subtest default-alignment: SUCCESS (0.004s)
[257.782640] [035/132] (762s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[257.882584] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[257.886783] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[257.970738] [036/132] (762s left) kms_pm_rpm (system-suspend-idle)
[260.102012] Starting subtest: system-suspend-idle
[279.407655] Subtest system-suspend-idle: SUCCESS (4.320s)
[279.791918] [037/132] (740s left) gem_pwrite (basic-exhaustion)
[279.870365] Subtest basic-exhaustion: SKIP (0.000s)
[279.944009] [038/132] (740s left) gem_lmem_swapping (verify-random-ccs)
[279.990417] Subtest verify-random-ccs: SKIP (0.000s)
[280.036889] [039/132] (740s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[280.130445] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[280.134757] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[280.214211] [040/132] (740s left) syncobj_wait (single-wait-for-submit-submitted)
[280.269465] Starting subtest: single-wait-for-submit-submitted
[280.369745] Subtest single-wait-for-submit-submitted: SUCCESS (0.101s)
[280.447438] [041/132] (740s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[280.501453] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[280.601826] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[280.692425] [042/132] (740s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[280.857035] Starting subtest: cursor-rapid-movement-64x64
[280.858928] Starting dynamic subtest: pipe-A-eDP-1
[281.396754] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.535s)
[281.426701] Starting dynamic subtest: pipe-D-eDP-1
[282.579264] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.160s)
[282.581603] Subtest cursor-rapid-movement-64x64: SUCCESS (1.721s)
[283.430438] [043/132] (737s left) kms_legacy_colorkey (invalid-plane)
[283.533555] Starting subtest: invalid-plane
[283.535867] Starting dynamic subtest: zero-id
[283.538085] Dynamic subtest zero-id: SUCCESS (0.000s)
[283.547154] Starting dynamic subtest: outrange-id
[283.549051] Dynamic subtest outrange-id: SUCCESS (0.000s)
[283.550956] Subtest invalid-plane: SUCCESS (0.001s)
[283.607205] [044/132] (737s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[283.719561] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[283.723714] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[283.821576] [045/132] (737s left) gem_ctx_exec (basic)
[283.872800] Starting subtest: basic
[283.875281] Subtest basic: SUCCESS (0.005s)
[283.997498] [046/132] (737s left) gem_exec_schedule (implicit-boths)
[284.071278] Starting subtest: implicit-boths
[284.073340] Starting dynamic subtest: rcs0
[284.171577] Dynamic subtest rcs0: SUCCESS (0.110s)
[284.182396] Starting dynamic subtest: vcs0
[284.258756] Dynamic subtest vcs0: SUCCESS (0.086s)
[284.272172] Starting dynamic subtest: vcs1
[284.342779] Dynamic subtest vcs1: SUCCESS (0.083s)
[284.353387] Starting dynamic subtest: vecs0
[284.419191] Dynamic subtest vecs0: SUCCESS (0.076s)
[284.429574] Starting dynamic subtest: ccs0
[284.506506] Dynamic subtest ccs0: SUCCESS (0.086s)
[284.509101] Subtest implicit-boths: SUCCESS (0.446s)
[286.032166] [047/132] (735s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[286.134457] Starting subtest: primary-4-tiled-reflect-x-180
[293.178147] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.042s)
[294.388585] [048/132] (726s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[294.479536] Starting subtest: fbc-rgb101010-draw-blt
[299.026426] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.548s)
[300.196709] [049/132] (720s left) api_intel_bb (object-reloc-purge-cache)
[300.254287] Starting subtest: object-reloc-purge-cache
[300.258477] Subtest object-reloc-purge-cache: SKIP (0.002s)
[300.367433] [050/132] (720s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[300.457992] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[300.462096] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[300.556330] [051/132] (720s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[300.615877] Starting subtest: multi-wait-for-submit-submitted-signaled
[300.618130] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[300.720887] [052/132] (720s left) kms_content_protection (uevent)
[300.868821] Starting subtest: uevent
[300.873326] Subtest uevent: SKIP (0.000s)
[300.996155] [053/132] (720s left) gem_tiled_fence_blits (basic)
[301.043141] Subtest basic: SKIP (0.000s)
[301.104893] [054/132] (720s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[301.204935] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[308.713718] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.509s)
[308.853880] [055/132] (712s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[308.958822] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[308.961131] Starting dynamic subtest: pipe-A-eDP-1
[309.055035] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[309.066387] Starting dynamic subtest: pipe-B-eDP-1
[310.227798] Dynamic subtest pipe-B-eDP-1: SKIP (1.170s)
[310.232013] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.273s)
[311.393733] [056/132] (710s left) gem_lmem_swapping (parallel-multi)
[311.436639] Subtest parallel-multi: SKIP (0.000s)
[311.479987] [057/132] (709s left) kms_dsc (dsc-with-output-formats-with-bpc)
[311.583442] Starting subtest: dsc-with-output-formats-with-bpc
[311.642928] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[311.685165] [058/132] (709s left) gem_exec_fence (syncobj-timeline-repeat)
[312.258451] Starting subtest: syncobj-timeline-repeat
[312.506087] Subtest syncobj-timeline-repeat: SUCCESS (0.248s)
[313.995262] [059/132] (707s left) gem_workarounds (suspend-resume-fd)
[314.061882] Starting subtest: suspend-resume-fd
[330.174377] Subtest suspend-resume-fd: SUCCESS (1.168s)
[331.316963] [060/132] (691s left) gen9_exec_parse (batch-invalid-length)
[331.403582] Subtest batch-invalid-length: SKIP (0.000s)
[331.472811] [061/132] (691s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[331.564101] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[331.568307] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[331.645872] [062/132] (691s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[331.751861] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[331.756034] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[331.837629] [063/132] (690s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[331.928840] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[338.912029] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.981s)
[339.013480] [064/132] (683s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[339.115815] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[339.119878] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[339.192974] [065/132] (683s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[339.291408] Starting subtest: fbc-psr2-sprite-mmap-cpu
[339.293524] Starting dynamic subtest: eDP-1
[339.297400] Dynamic subtest eDP-1: SKIP (0.000s)
[339.301346] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[339.378334] [066/132] (683s left) gem_exec_whisper (basic-forked)
[339.442352] Starting subtest: basic-forked
[346.294458] Subtest basic-forked: SUCCESS (6.848s)
[346.497384] [067/132] (676s left) gem_ccs (block-multicopy-inplace)
[346.555536] Starting subtest: block-multicopy-inplace
[346.560190] Subtest block-multicopy-inplace: SKIP (0.000s)
[346.656191] [068/132] (676s left) perf_pmu (all-busy-idle-check-all)
[346.696142] Starting subtest: all-busy-idle-check-all
[347.858374] Subtest all-busy-idle-check-all: SUCCESS (1.161s)
[347.957636] [069/132] (675s left) syncobj_wait (invalid-signal-bad-pad)
[348.020784] Starting subtest: invalid-signal-bad-pad
[348.023329] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[348.119584] [070/132] (674s left) gem_wait (await)
[348.184302] Starting subtest: await
[348.186688] Starting dynamic subtest: all-engines
[349.308195] Dynamic subtest all-engines: SUCCESS (1.122s)
[349.327016] Starting dynamic subtest: rcs0
[350.367697] Dynamic subtest rcs0: SUCCESS (1.056s)
[350.385728] Starting dynamic subtest: bcs0
[351.428614] Dynamic subtest bcs0: SUCCESS (1.056s)
[351.444828] Starting dynamic subtest: vcs0
[352.479493] Dynamic subtest vcs0: SUCCESS (1.051s)
[352.496558] Starting dynamic subtest: vcs1
[353.532216] Dynamic subtest vcs1: SUCCESS (1.050s)
[353.549271] Starting dynamic subtest: vecs0
[354.587110] Dynamic subtest vecs0: SUCCESS (1.052s)
[354.603767] Starting dynamic subtest: ccs0
[355.644311] Dynamic subtest ccs0: SUCCESS (1.054s)
[355.647055] Subtest await: SUCCESS (7.458s)
[355.863242] [071/132] (667s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[355.957686] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[355.960061] Starting dynamic subtest: pipe-A-default-mode
[357.111371] Dynamic subtest pipe-A-default-mode: SKIP (1.152s)
[357.115507] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.153s)
[357.282304] [072/132] (665s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[357.377838] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[357.380145] Starting dynamic subtest: pipe-A-eDP-1
[359.582110] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.206s)
[359.596511] Starting dynamic subtest: pipe-B-eDP-1
[362.011221] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.427s)
[362.022544] Starting dynamic subtest: pipe-C-eDP-1
[364.127892] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.116s)
[364.137352] Starting dynamic subtest: pipe-D-eDP-1
[366.232107] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.104s)
[366.234034] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.859s)
[367.483818] [073/132] (655s left) gem_exec_schedule (preempt-engines)
[367.562692] Starting subtest: preempt-engines
[367.565037] Starting dynamic subtest: rcs0
[369.805061] Dynamic subtest rcs0: SUCCESS (2.249s)
[369.817942] Starting dynamic subtest: bcs0
[372.031774] Dynamic subtest bcs0: SUCCESS (2.225s)
[372.046359] Starting dynamic subtest: vcs0
[374.370361] Dynamic subtest vcs0: SUCCESS (2.337s)
[374.388338] Starting dynamic subtest: vcs1
[376.660889] Dynamic subtest vcs1: SUCCESS (2.289s)
[376.672804] Starting dynamic subtest: vecs0
[378.959996] Dynamic subtest vecs0: SUCCESS (2.297s)
[378.969705] Starting dynamic subtest: ccs0
[381.250989] Dynamic subtest ccs0: SUCCESS (2.288s)
[381.253456] Subtest preempt-engines: SUCCESS (13.697s)
[381.557351] [074/132] (641s left) gem_sync (basic-each)
[381.635376] Starting subtest: basic-each
[384.147059] Subtest basic-each: SUCCESS (2.523s)
[384.350354] [075/132] (638s left) gem_sync (basic-many-each)
[384.427472] Starting subtest: basic-many-each
[386.707695] Subtest basic-many-each: SUCCESS (2.290s)
[386.894166] [076/132] (636s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[387.019361] Starting subtest: cursorB-vs-flipA-toggle
[387.023806] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[387.161015] [077/132] (636s left) syncobj_timeline (single-wait-all-available-submitted)
[387.214201] Starting subtest: single-wait-all-available-submitted
[387.216368] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[387.340964] [078/132] (636s left) perf_pmu (invalid-open)
[387.376535] Starting subtest: invalid-open
[387.378864] Subtest invalid-open: SUCCESS (0.000s)
[387.502902] [079/132] (635s left) kms_psr (psr2-sprite-plane-onoff)
[387.602500] Starting subtest: psr2-sprite-plane-onoff
[387.604798] Starting dynamic subtest: eDP-1
[389.350114] Dynamic subtest eDP-1: SUCCESS (1.748s)
[389.352400] Subtest psr2-sprite-plane-onoff: SUCCESS (1.749s)
[390.179160] [080/132] (633s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[390.277624] Starting subtest: fbc-rgb565-draw-blt
[394.412797] Subtest fbc-rgb565-draw-blt: SUCCESS (4.138s)
[395.577379] [081/132] (627s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[395.706629] Starting subtest: protected-encrypted-src-copy-not-readible
[395.819764] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.114s)
[395.958042] [082/132] (627s left) kms_flip (plain-flip-fb-recreate)
[396.056165] Starting subtest: plain-flip-fb-recreate
[396.058422] Starting dynamic subtest: A-eDP1
[404.926086] Dynamic subtest A-eDP1: SUCCESS (8.871s)
[404.936931] Starting dynamic subtest: B-eDP1
[413.834141] Dynamic subtest B-eDP1: SUCCESS (8.905s)
[413.846625] Starting dynamic subtest: C-eDP1
[422.729061] Dynamic subtest C-eDP1: SUCCESS (8.890s)
[422.741704] Starting dynamic subtest: D-eDP1
[431.625606] Dynamic subtest D-eDP1: SUCCESS (8.894s)
[431.629573] Subtest plain-flip-fb-recreate: SUCCESS (35.574s)
[432.780690] [083/132] (590s left) i915_drm_fdinfo (busy)
[432.839807] Starting subtest: busy
[432.841975] Starting dynamic subtest: rcs0
[432.866943] Dynamic subtest rcs0: SKIP (0.026s)
[432.879023] Starting dynamic subtest: bcs0
[432.883512] Dynamic subtest bcs0: SKIP (0.000s)
[432.893093] Starting dynamic subtest: vcs0
[432.897489] Dynamic subtest vcs0: SKIP (0.000s)
[432.906961] Starting dynamic subtest: vcs1
[432.911249] Dynamic subtest vcs1: SKIP (0.000s)
[432.920032] Starting dynamic subtest: vecs0
[432.924348] Dynamic subtest vecs0: SKIP (0.000s)
[432.933327] Starting dynamic subtest: ccs0
[432.937559] Dynamic subtest ccs0: SKIP (0.000s)
[432.941864] Subtest busy: SKIP (0.031s)
[432.979180] [084/132] (590s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[433.092680] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[433.727829] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[433.888705] [085/132] (589s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[434.283813] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[435.055100] [086/132] (588s left) kms_vblank (ts-continuation-idle)
[435.139509] Starting subtest: ts-continuation-idle
[435.141618] Starting dynamic subtest: pipe-A-eDP-1
[435.538282] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[435.551832] Starting dynamic subtest: pipe-D-eDP-1
[436.632413] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.091s)
[436.634310] Subtest ts-continuation-idle: SUCCESS (1.492s)
[437.472248] [087/132] (586s left) prime_busy (hang)
[437.529460] Starting subtest: hang
[437.531326] Starting dynamic subtest: rcs0
[463.402993] Dynamic subtest rcs0: SUCCESS (25.872s)
[463.414401] Starting dynamic subtest: bcs0
[470.493782] Dynamic subtest bcs0: SUCCESS (7.088s)
[470.505788] Starting dynamic subtest: vcs0
[477.532451] Dynamic subtest vcs0: SUCCESS (7.038s)
[477.541785] Starting dynamic subtest: vcs1
[484.516898] Dynamic subtest vcs1: SUCCESS (6.979s)
[484.527815] Starting dynamic subtest: vecs0
[491.548134] Dynamic subtest vecs0: SUCCESS (7.034s)
[491.557918] Starting dynamic subtest: ccs0
[505.388078] Dynamic subtest ccs0: SUCCESS (13.834s)
[505.390485] Subtest hang: SUCCESS (67.855s)
[505.497208] [088/132] (518s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[505.556286] Subtest tiled-to-tiled: SKIP (0.000s)
[505.628043] [089/132] (518s left) gem_exec_params (secure-non-master)
[505.694618] Starting subtest: secure-non-master
[505.698898] Subtest secure-non-master: SKIP (0.000s)
[505.793338] [090/132] (518s left) syncobj_wait (multi-wait-signaled)
[505.842332] Starting subtest: multi-wait-signaled
[505.844529] Subtest multi-wait-signaled: SUCCESS (0.000s)
[505.955708] [091/132] (517s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[506.047997] Starting subtest: basic-modeset-with-all-modifiers-formats
[506.431457] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[507.212876] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.782s)
[507.222819] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[507.234944] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[507.244451] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[507.257256] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[507.266530] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[507.413215] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[507.427552] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[507.435405] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[507.444935] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[507.457836] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[507.469819] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[507.479905] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[507.489727] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[507.501963] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.020s)
[507.511151] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[507.524287] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[507.533893] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[507.546484] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[507.555563] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[507.568482] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[507.577530] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[507.591057] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[507.599908] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[507.746355] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[507.757102] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[507.768766] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[507.778565] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[507.790973] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[507.800245] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[507.813076] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[507.822639] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[507.835454] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[507.844727] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[507.857851] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[507.867049] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[507.879889] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.020s)
[507.892184] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[507.901821] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[507.911048] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[507.924356] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[507.933800] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[508.102563] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.177s)
[508.116440] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[508.124819] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[508.134322] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[508.147033] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[508.156214] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[508.169123] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[508.178633] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[508.191434] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[508.200465] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[508.213131] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[508.222304] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[508.235533] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[508.244779] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[508.257707] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[508.267468] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[508.279994] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[508.695630] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.649s)
[509.461652] [092/132] (514s left) gem_exec_schedule (u-fairslice)
[509.533553] Starting subtest: u-fairslice
[509.535514] Starting dynamic subtest: rcs0
[511.550785] Dynamic subtest rcs0: SUCCESS (2.023s)
[511.562190] Starting dynamic subtest: bcs0
[513.567776] Dynamic subtest bcs0: SUCCESS (2.017s)
[513.578777] Starting dynamic subtest: vcs0
[515.592136] Dynamic subtest vcs0: SUCCESS (2.021s)
[515.601562] Starting dynamic subtest: vcs1
[517.610060] Dynamic subtest vcs1: SUCCESS (2.018s)
[517.619560] Starting dynamic subtest: vecs0
[519.630894] Dynamic subtest vecs0: SUCCESS (2.018s)
[519.641507] Starting dynamic subtest: ccs0
[521.650138] Dynamic subtest ccs0: SUCCESS (2.019s)
[521.652131] Subtest u-fairslice: SUCCESS (12.121s)
[521.949325] [093/132] (502s left) gem_ctx_param (invalid-param-set)
[522.002078] Starting subtest: invalid-param-set
[522.005117] Subtest invalid-param-set: SUCCESS (0.000s)
[522.106168] [094/132] (501s left) i915_pm_rpm (gem-mmap-type)
[523.973171] Starting subtest: gem-mmap-type
[523.976149] Starting dynamic subtest: wb-smem0
[527.809492] Dynamic subtest wb-smem0: SUCCESS (3.834s)
[527.820000] Starting dynamic subtest: wc-smem0
[530.684376] Dynamic subtest wc-smem0: SUCCESS (2.873s)
[530.694797] Starting dynamic subtest: uc-smem0
[533.853013] Dynamic subtest uc-smem0: SUCCESS (3.168s)
[533.855463] Subtest gem-mmap-type: SUCCESS (9.877s)
[533.941534] [095/132] (490s left) kms_color (ctm-green-to-red)
[534.028505] Starting subtest: ctm-green-to-red
[534.030523] Starting dynamic subtest: pipe-A-eDP-1
[534.732793] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[534.745053] Starting dynamic subtest: pipe-B-eDP-1
[536.113309] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.379s)
[536.123506] Starting dynamic subtest: pipe-C-eDP-1
[537.482675] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[537.493541] Starting dynamic subtest: pipe-D-eDP-1
[538.800810] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.315s)
[538.802819] Subtest ctm-green-to-red: SUCCESS (4.772s)
[539.664158] [096/132] (484s left) kms_psr (fbc-pr-primary-mmap-gtt)
[539.765055] Starting subtest: fbc-pr-primary-mmap-gtt
[539.769199] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[539.840812] [097/132] (484s left) kms_atomic_transition (modeset-transition-nonblocking)
[539.933841] Starting subtest: modeset-transition-nonblocking
[539.935663] Starting dynamic subtest: 1x-outputs
[551.033494] Dynamic subtest 1x-outputs: SUCCESS (11.099s)
[551.036172] Subtest modeset-transition-nonblocking: SUCCESS (11.101s)
[551.870329] [098/132] (472s left) kms_flip (2x-plain-flip)
[551.962214] Starting subtest: 2x-plain-flip
[551.971105] Subtest 2x-plain-flip: SKIP (0.011s)
[552.106804] [099/132] (472s left) syncobj_timeline (multi-wait-all-available-submitted)
[552.168649] Starting subtest: multi-wait-all-available-submitted
[552.170596] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[552.262451] [100/132] (472s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[552.359495] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[552.361819] Starting dynamic subtest: pipe-A-eDP-1
[552.383871] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[552.394805] Starting dynamic subtest: pipe-B-eDP-1
[552.416822] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[552.425999] Starting dynamic subtest: pipe-C-eDP-1
[552.447509] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[552.456609] Starting dynamic subtest: pipe-D-eDP-1
[552.479080] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[552.483413] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[554.581416] [101/132] (469s left) gem_userptr_blits (coherency-sync)
[554.650887] Starting subtest: coherency-sync
[555.094862] Subtest coherency-sync: SKIP (0.406s)
[555.219905] [102/132] (469s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[555.357314] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[555.359431] Starting dynamic subtest: pipe-A-eDP-1
[555.383044] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[555.393368] Starting dynamic subtest: pipe-B-eDP-1
[555.416825] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[555.426127] Starting dynamic subtest: pipe-C-eDP-1
[555.449989] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[555.459277] Starting dynamic subtest: pipe-D-eDP-1
[555.483370] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[555.487789] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.010s)
[557.580188] [103/132] (466s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[557.641168] Starting subtest: y-tiled-to-vebox-x-tiled
[557.645242] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[557.836642] [104/132] (466s left) gem_exec_reloc (basic-write-read-noreloc)
[557.893495] Subtest basic-write-read-noreloc: SKIP (0.000s)
[557.970372] [105/132] (466s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[558.054613] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[558.056842] Starting dynamic subtest: pipe-A-eDP-1
[558.080359] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[558.091335] Starting dynamic subtest: pipe-B-eDP-1
[558.114141] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[558.124349] Starting dynamic subtest: pipe-C-eDP-1
[558.147260] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[558.156639] Starting dynamic subtest: pipe-D-eDP-1
[558.179558] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[558.183461] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[560.270115] [106/132] (464s left) gem_spin_batch (legacy)
[560.330208] Starting subtest: legacy
[560.332492] Starting dynamic subtest: default
[563.568949] Dynamic subtest default: SUCCESS (3.233s)
[563.579726] Starting dynamic subtest: render
[566.799092] Dynamic subtest render: SUCCESS (3.228s)
[566.816343] Starting dynamic subtest: bsd
[570.037023] Dynamic subtest bsd: SUCCESS (3.235s)
[570.049661] Starting dynamic subtest: bsd1
[573.271831] Dynamic subtest bsd1: SUCCESS (3.232s)
[573.284333] Starting dynamic subtest: bsd2
[576.508822] Dynamic subtest bsd2: SUCCESS (3.234s)
[576.520624] Starting dynamic subtest: blt
[579.747000] Dynamic subtest blt: SUCCESS (3.235s)
[579.758728] Starting dynamic subtest: vebox
[582.983809] Dynamic subtest vebox: SUCCESS (3.234s)
[582.986095] Subtest legacy: SUCCESS (22.651s)
[584.902057] [107/132] (439s left) gem_ctx_param (set-priority-not-supported)
[584.952793] Starting subtest: set-priority-not-supported
[584.957341] Subtest set-priority-not-supported: SKIP (0.000s)
[585.029638] [108/132] (439s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[585.140163] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[592.073353] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.935s)
[592.200373] [109/132] (432s left) gem_ctx_param (invalid-get-no-zeromap)
[592.261117] Starting subtest: invalid-get-no-zeromap
[592.263004] Subtest invalid-get-no-zeromap: SUCCESS (0.002s)
[592.363637] [110/132] (432s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[592.451448] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[592.455528] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[592.556402] [111/132] (432s left) kms_properties (crtc-properties-legacy)
[592.644725] Starting subtest: crtc-properties-legacy
[592.646973] Starting dynamic subtest: pipe-A-eDP-1
[593.111593] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.466s)
[593.121925] Starting dynamic subtest: pipe-B-eDP-1
[594.290671] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.177s)
[594.301651] Starting dynamic subtest: pipe-C-eDP-1
[595.484290] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.192s)
[595.494578] Starting dynamic subtest: pipe-D-eDP-1
[596.693801] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.210s)
[596.696104] Subtest crtc-properties-legacy: SUCCESS (4.050s)
[597.556269] [112/132] (427s left) kms_chamelium_hpd (dp-hpd)
[597.933812] Subtest dp-hpd: SKIP (0.000s)
[598.747812] [113/132] (426s left) kms_plane_scaling (2x-scaler-multi-pipe)
[598.844688] Starting subtest: 2x-scaler-multi-pipe
[598.849200] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[598.954591] [114/132] (425s left) kms_psr (fbc-psr-sprite-render)
[599.038845] Starting subtest: fbc-psr-sprite-render
[599.041090] Starting dynamic subtest: eDP-1
[599.045319] Dynamic subtest eDP-1: SKIP (0.000s)
[599.049526] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[599.118340] [115/132] (425s left) syncobj_wait (wait-any-interrupted)
[599.183145] Starting subtest: wait-any-interrupted
[599.285116] Subtest wait-any-interrupted: SUCCESS (0.101s)
[599.364184] [116/132] (425s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[599.452231] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[599.456665] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[599.535302] [117/132] (425s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[599.631220] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[599.657568] Starting dynamic subtest: pipe-A-plane-0
[599.946213] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[599.957576] Starting dynamic subtest: pipe-A-plane-3
[600.179623] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[600.189918] Starting dynamic subtest: pipe-A-plane-5
[600.194496] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[601.317515] Starting dynamic subtest: pipe-B-plane-0
[601.608817] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[601.619286] Starting dynamic subtest: pipe-B-plane-3
[601.842193] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[601.853437] Starting dynamic subtest: pipe-B-plane-5
[601.858003] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[602.155072] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.523s)
[602.958757] [118/132] (422s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[603.073698] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[610.322810] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.254s)
[610.459637] [119/132] (414s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[610.562767] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[610.564586] Starting dynamic subtest: pipe-A-eDP-1
[611.385042] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.818s)
[611.394943] Starting dynamic subtest: pipe-B-eDP-1
[613.073671] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.681s)
[613.093780] Starting dynamic subtest: pipe-C-eDP-1
[614.609947] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.536s)
[614.620973] Starting dynamic subtest: pipe-D-eDP-1
[616.104060] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.494s)
[616.106059] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.535s)
[617.265697] [120/132] (407s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[617.372646] Starting subtest: extended-modeset-hang-oldfb-with-reset
[617.374983] Starting dynamic subtest: pipe-A
[629.301606] Dynamic subtest pipe-A: SUCCESS (11.927s)
[629.313153] Starting dynamic subtest: pipe-D
[641.504790] Dynamic subtest pipe-D: SUCCESS (12.200s)
[641.507119] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.132s)
[642.362381] [121/132] (382s left) kms_psr (pr-primary-page-flip)
[642.459651] Starting subtest: pr-primary-page-flip
[642.463920] Subtest pr-primary-page-flip: SKIP (0.000s)
[642.534290] [122/132] (382s left) perf (gen12-group-exclusive-stream-ctx-handle)
[642.655372] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[642.682087] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.028s)
[642.739601] [123/132] (382s left) gem_mmap_offset (oob-read)
[643.828988] Starting subtest: oob-read
[643.831524] Subtest oob-read: SUCCESS (0.001s)
[643.942600] [124/132] (381s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[644.041879] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[644.045948] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[644.139899] [125/132] (381s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[644.255228] Starting subtest: 4-tiled-16bpp-rotate-90
[644.274801] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[644.404119] [126/132] (381s left) kms_vblank (accuracy-idle)
[644.510562] Starting subtest: accuracy-idle
[644.512377] Starting dynamic subtest: pipe-A-eDP-1
[646.264438] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.754s)
[646.279350] Starting dynamic subtest: pipe-D-eDP-1
[648.688795] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.419s)
[648.691098] Subtest accuracy-idle: SUCCESS (4.176s)
[649.558224] [127/132] (375s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[649.653430] Starting subtest: y-tiled-64bpp-rotate-180
[649.657843] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[649.746990] [128/132] (375s left) gem_ctx_shared (q-out-order)
[649.814497] Starting subtest: Q-out-order
[649.816886] Starting dynamic subtest: rcs0
[649.937116] Dynamic subtest rcs0: SUCCESS (0.121s)
[649.951476] Starting dynamic subtest: vcs0
[650.026381] Dynamic subtest vcs0: SUCCESS (0.088s)
[650.045506] Starting dynamic subtest: vcs1
[650.107631] Dynamic subtest vcs1: SUCCESS (0.080s)
[650.124658] Starting dynamic subtest: vecs0
[650.191847] Dynamic subtest vecs0: SUCCESS (0.083s)
[650.209867] Starting dynamic subtest: ccs0
[650.272382] Dynamic subtest ccs0: SUCCESS (0.079s)
[650.274894] Subtest Q-out-order: SUCCESS (0.458s)
[651.958883] [129/132] (373s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[652.014559] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[652.117619] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[652.209837] [130/132] (373s left) syncobj_wait (wait-all-interrupted)
[652.258618] Starting subtest: wait-all-interrupted
[652.359123] Subtest wait-all-interrupted: SUCCESS (0.101s)
[652.439190] [131/132] (373s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[652.531132] Starting subtest: psr-rgb565-draw-mmap-gtt
[652.535415] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[652.627679] [132/132] (373s left) prime_vgem (basic-write)
[652.715282] Starting subtest: basic-write
[652.723621] Subtest basic-write: SKIP (0.006s)
[652.834290] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_endless
results: parsing output: 3/ for test: sysfs_preempt_timeout
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: i915_drm_fdinfo
results: parsing output: 7/ for test: gem_pread
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: i915_pm_rps
results: parsing output: 10/ for test: kms_setmode
results: parsing output: 11/ for test: kms_pm_dc
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: prime_mmap
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_atomic_transition
results: parsing output: 18/ for test: gem_create
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_cursor_edge_walk
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: dmabuf_sync_file
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: kms_pipe_stress
results: parsing output: 25/ for test: kms_force_connector_basic
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_invalid_mode
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: kms_display_modes
results: parsing output: 33/ for test: api_intel_allocator
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: gem_pwrite
results: parsing output: 37/ for test: gem_lmem_swapping
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_legacy_colorkey
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_ctx_exec
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_content_protection
results: parsing output: 52/ for test: gem_tiled_fence_blits
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: gem_lmem_swapping
results: parsing output: 56/ for test: kms_dsc
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: gem_workarounds
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: gem_ccs
results: parsing output: 67/ for test: perf_pmu
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: gem_sync
results: parsing output: 74/ for test: gem_sync
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: perf_pmu
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_pxp
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: i915_drm_fdinfo
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_chamelium_edid
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: prime_busy
results: parsing output: 87/ for test: gem_set_tiling_vs_blt
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_async_flips
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: gem_ctx_param
results: parsing output: 93/ for test: i915_pm_rpm
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_atomic_transition
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_spin_batch
results: parsing output: 106/ for test: gem_ctx_param
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_ctx_param
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_properties
results: parsing output: 111/ for test: kms_chamelium_hpd
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_busy
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: gem_mmap_offset
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_ctx_shared
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: prime_vgem
Done.