[56.641362] Initializing watchdogs
[56.641495]   /dev/watchdog0
[56.655498] [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]
[56.659749] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.661768] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.665066] [001/130] (960s left) perf (blocking-parameterized)
[56.831485] Starting subtest: blocking-parameterized
[76.860910] Subtest blocking-parameterized: SUCCESS (20.007s)
[76.906342] [002/130] (940s left) gem_eio (in-flight-immediate)
[77.062043] Starting subtest: in-flight-immediate
[84.636098] Subtest in-flight-immediate: SUCCESS (7.575s)
[84.792777] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[84.795245] [003/130] (932s left) gem_basic (multigpu-create-close)
[84.847196] Starting subtest: multigpu-create-close
[84.850961] Subtest multigpu-create-close: SKIP (0.000s)
[84.938033] [004/130] (932s left) kms_plane_multiple (tiling-none)
[85.024474] Starting subtest: tiling-none
[85.026505] Starting dynamic subtest: pipe-A-eDP-1
[88.716927] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.690s)
[88.725645] Starting dynamic subtest: pipe-B-eDP-1
[93.117467] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.397s)
[93.125514] Starting dynamic subtest: pipe-C-eDP-1
[97.388667] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.272s)
[97.396728] Starting dynamic subtest: pipe-D-eDP-1
[101.688215] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.300s)
[101.690637] Subtest tiling-none: SUCCESS (16.661s)
[102.506331] [005/130] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[102.623594] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[107.507340] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.886s)
[107.636226] [006/130] (909s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[107.749637] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[109.108895] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.359s)
[109.911688] [007/130] (907s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[110.009398] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[110.013623] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[110.094667] [008/130] (907s left) gem_spin_batch (spin-each)
[110.173658] Starting subtest: spin-each
[113.445818] Subtest spin-each: SUCCESS (3.264s)
[114.023388] [009/130] (903s left) gem_mmap_gtt (hang-busy)
[114.085569] Subtest hang-busy: SKIP (0.000s)
[114.146074] [010/130] (903s left) gem_eio (throttle)
[114.347520] Starting subtest: throttle
[114.612359] Subtest throttle: SUCCESS (0.264s)
[114.721389] [011/130] (902s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[114.832389] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[114.836550] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[114.947529] [012/130] (902s left) gem_exec_fence (syncobj-timeline-wait)
[115.473476] Starting subtest: syncobj-timeline-wait
[116.966411] Subtest syncobj-timeline-wait: SUCCESS (1.494s)
[117.216577] [013/130] (900s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[117.316766] Starting subtest: psr-2p-pri-indfb-multidraw
[117.321234] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[117.418798] [014/130] (900s left) i915_pm_rpm (debugfs-forcewake-user)
[119.151096] Starting subtest: debugfs-forcewake-user
[130.543659] Subtest debugfs-forcewake-user: SUCCESS (11.393s)
[130.893684] [015/130] (886s left) gem_eio (in-flight-contexts-10ms)
[131.098041] Starting subtest: in-flight-contexts-10ms
[142.980192] Subtest in-flight-contexts-10ms: SUCCESS (11.882s)
[143.156039] [016/130] (874s left) prime_busy (hang)
[143.221767] Starting subtest: hang
[143.224294] Starting dynamic subtest: rcs0
[170.435536] Dynamic subtest rcs0: SUCCESS (27.209s)
[170.445048] Starting dynamic subtest: bcs0
[177.586970] Dynamic subtest bcs0: SUCCESS (7.150s)
[177.593743] Starting dynamic subtest: vcs0
[184.571752] Dynamic subtest vcs0: SUCCESS (6.984s)
[184.581229] Starting dynamic subtest: vcs1
[191.601198] Dynamic subtest vcs1: SUCCESS (7.032s)
[191.607998] Starting dynamic subtest: vecs0
[198.579103] Dynamic subtest vecs0: SUCCESS (6.974s)
[198.586899] Starting dynamic subtest: ccs0
[212.415748] Dynamic subtest ccs0: SUCCESS (13.836s)
[212.418281] Subtest hang: SUCCESS (69.189s)
[212.555385] [017/130] (805s left) gem_ctx_persistence (hostile)
[212.626103] Starting subtest: hostile
[222.144228] Subtest hostile: SUCCESS (9.513s)
[222.275755] [018/130] (795s left) kms_psr (psr-primary-mmap-cpu)
[222.382102] Starting subtest: psr-primary-mmap-cpu
[222.384473] Starting dynamic subtest: eDP-1
[224.074687] Dynamic subtest eDP-1: SUCCESS (1.691s)
[224.077085] Subtest psr-primary-mmap-cpu: SUCCESS (1.692s)
[224.921230] [019/130] (792s left) core_auth (getclient-master-drop)
[224.957408] Starting subtest: getclient-master-drop
[224.971127] Subtest getclient-master-drop: SUCCESS (0.013s)
[225.071275] [020/130] (792s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[225.137051] Starting subtest: invalid-bsd1-flag-on-vebox
[225.139306] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[225.240018] [021/130] (792s left) kms_chamelium_hpd (vga-hpd)
[225.643209] Subtest vga-hpd: SKIP (0.000s)
[226.430030] [022/130] (791s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[226.549154] Starting subtest: fbc-rgb101010-draw-render
[230.159943] Subtest fbc-rgb101010-draw-render: SUCCESS (3.613s)
[230.281472] [023/130] (787s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[230.345426] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[230.406564] [024/130] (787s left) kms_atomic_interruptible (legacy-cursor)
[230.515065] Starting subtest: legacy-cursor
[230.517405] Starting dynamic subtest: pipe-A-eDP-1
[237.897462] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.383s)
[237.899807] Subtest legacy-cursor: SUCCESS (7.384s)
[238.729848] [025/130] (779s left) gen9_exec_parse (batch-without-end)
[238.802509] Subtest batch-without-end: SKIP (0.000s)
[238.867291] [026/130] (779s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[238.964714] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[238.969230] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[239.071899] [027/130] (778s left) kms_pm_backlight (brightness-with-dpms)
[239.169274] Starting subtest: brightness-with-dpms
[239.246413] Starting dynamic subtest: eDP-1
[241.738515] Dynamic subtest eDP-1: SUCCESS (2.494s)
[241.740889] Subtest brightness-with-dpms: SUCCESS (2.571s)
[242.601665] [028/130] (775s left) kms_lease (implicit-plane-lease)
[242.695083] Starting subtest: implicit-plane-lease
[242.700043] Subtest implicit-plane-lease: SUCCESS (0.004s)
[242.802907] [029/130] (775s left) syncobj_wait (invalid-signal-bad-pad)
[242.856075] Starting subtest: invalid-signal-bad-pad
[242.858319] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[242.945858] [030/130] (775s left) kms_vblank (query-forked-busy)
[243.040992] Starting subtest: query-forked-busy
[243.043295] Starting dynamic subtest: pipe-A-eDP-1
[244.928650] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[244.941897] Starting dynamic subtest: pipe-D-eDP-1
[247.452638] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s)
[247.455079] Subtest query-forked-busy: SUCCESS (4.411s)
[248.257711] [031/130] (769s left) kms_big_fb (linear-16bpp-rotate-180)
[248.365738] Starting subtest: linear-16bpp-rotate-180
[249.875369] Subtest linear-16bpp-rotate-180: SUCCESS (1.510s)
[250.032753] [032/130] (768s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[250.158552] Starting subtest: basic-flip-after-cursor-legacy
[251.068587] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.908s)
[251.881421] [033/130] (766s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[251.998100] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[252.002218] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[252.105177] [034/130] (766s left) kms_psr (pr-cursor-blt)
[252.192880] Starting subtest: pr-cursor-blt
[252.197380] Subtest pr-cursor-blt: SKIP (0.000s)
[252.259413] [035/130] (766s left) gem_userptr_blits (unsync-unmap-after-close)
[252.328203] Subtest unsync-unmap-after-close: SKIP (0.000s)
[252.452336] [036/130] (765s left) gem_softpin (allocator-basic-reserve)
[252.512372] Starting subtest: allocator-basic-reserve
[252.569160] Subtest allocator-basic-reserve: SUCCESS (0.057s)
[252.688371] [037/130] (765s left) drm_fdinfo (idle)
[252.726298] Starting subtest: idle
[252.728766] Starting dynamic subtest: rcs0
[253.300978] Dynamic subtest rcs0: SUCCESS (0.574s)
[253.309406] Starting dynamic subtest: bcs0
[253.807465] Dynamic subtest bcs0: SUCCESS (0.503s)
[253.817401] Starting dynamic subtest: vcs0
[254.312951] Dynamic subtest vcs0: SUCCESS (0.504s)
[254.323312] Starting dynamic subtest: vcs1
[254.816884] Dynamic subtest vcs1: SUCCESS (0.503s)
[254.827518] Starting dynamic subtest: vecs0
[255.322593] Dynamic subtest vecs0: SUCCESS (0.503s)
[255.332531] Starting dynamic subtest: ccs0
[255.827026] Dynamic subtest ccs0: SUCCESS (0.503s)
[255.829973] Subtest idle: SUCCESS (3.100s)
[255.895851] [038/130] (762s left) kms_pm_rpm (modeset-lpsp)
[258.133568] Starting subtest: modeset-lpsp
[259.580112] Subtest modeset-lpsp: SUCCESS (1.445s)
[259.658521] [039/130] (758s left) i915_pm_rps (thresholds)
[259.724271] Starting subtest: thresholds
[259.729021] Subtest thresholds: SKIP (0.000s)
[259.793971] [040/130] (758s left) kms_flip (flip-vs-expired-vblank)
[259.894994] Starting subtest: flip-vs-expired-vblank
[259.897248] Starting dynamic subtest: A-eDP1
[268.640564] Dynamic subtest A-eDP1: SUCCESS (8.741s)
[268.651964] Starting dynamic subtest: B-eDP1
[277.364698] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[277.373159] Starting dynamic subtest: C-eDP1
[286.084709] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[286.092111] Starting dynamic subtest: D-eDP1
[294.713809] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[294.716277] Subtest flip-vs-expired-vblank: SUCCESS (34.822s)
[295.873416] [041/130] (722s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[295.933777] Starting subtest: saturated-hostile-nopreempt
[295.936245] Starting dynamic subtest: rcs0
[296.025159] Dynamic subtest rcs0: SKIP (0.090s)
[296.034949] Starting dynamic subtest: bcs0
[296.048811] Dynamic subtest bcs0: SKIP (0.023s)
[296.056535] Starting dynamic subtest: vcs0
[296.072714] Dynamic subtest vcs0: SKIP (0.023s)
[296.079969] Starting dynamic subtest: vcs1
[296.092957] Dynamic subtest vcs1: SKIP (0.019s)
[296.100587] Starting dynamic subtest: vecs0
[296.118644] Dynamic subtest vecs0: SKIP (0.025s)
[296.125973] Starting dynamic subtest: ccs0
[296.143676] Dynamic subtest ccs0: SKIP (0.024s)
[296.147862] Subtest saturated-hostile-nopreempt: SKIP (0.210s)
[296.217242] [042/130] (722s left) gem_lmem_swapping (heavy-multi)
[296.262375] Subtest heavy-multi: SKIP (0.000s)
[296.298293] [043/130] (722s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[296.401512] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[300.704352] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.306s)
[300.821875] [044/130] (717s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[305.870663] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[305.875467] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[306.718154] [045/130] (711s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[306.819109] Starting subtest: fbcpsr-tiling-4
[311.705825] Subtest fbcpsr-tiling-4: SUCCESS (4.889s)
[311.846788] [046/130] (706s left) kms_sequence (get-forked-busy)
[311.937127] Starting subtest: get-forked-busy
[311.939473] Starting dynamic subtest: pipe-A-eDP-1
[313.896013] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.956s)
[313.908458] Starting dynamic subtest: pipe-B-eDP-1
[316.469629] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.574s)
[316.477700] Starting dynamic subtest: pipe-C-eDP-1
[319.068725] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.597s)
[319.076506] Starting dynamic subtest: pipe-D-eDP-1
[321.596831] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.527s)
[321.599293] Subtest get-forked-busy: SUCCESS (9.659s)
[322.469458] [047/130] (696s left) syncobj_timeline (invalid-transfer-bad-pad)
[322.533733] Starting subtest: invalid-transfer-bad-pad
[322.536134] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[322.632982] [048/130] (696s left) gem_mmap_offset (clear)
[322.684871] Starting subtest: clear
[322.687303] Starting dynamic subtest: smem0
[350.524279] Dynamic subtest smem0: SUCCESS (27.836s)
[350.526837] Subtest clear: SUCCESS (27.837s)
[350.826153] [049/130] (667s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[350.975218] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[350.979176] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[351.089054] [050/130] (667s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[351.199465] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[351.203531] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[351.305202] [051/130] (667s left) gem_exec_schedule (semaphore-codependency)
[351.387603] Starting subtest: semaphore-codependency
[351.394068] Subtest semaphore-codependency: SUCCESS (0.011s)
[351.759773] [052/130] (667s left) syncobj_timeline (single-wait-signaled)
[351.818405] Starting subtest: single-wait-signaled
[351.820754] Subtest single-wait-signaled: SUCCESS (0.001s)
[351.909560] [053/130] (667s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[352.005662] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[355.483889] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (3.482s)
[355.618823] [054/130] (663s left) gem_partial_pwrite_pread (reads-display)
[355.677143] Subtest reads-display: SKIP (0.000s)
[355.749514] [055/130] (663s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[355.840800] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[355.842886] Starting dynamic subtest: pipe-A-default-mode
[356.138617] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[356.144221] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.295s)
[356.927443] [056/130] (662s left) kms_flip (2x-plain-flip)
[357.025410] Starting subtest: 2x-plain-flip
[357.035669] Subtest 2x-plain-flip: SKIP (0.010s)
[357.106092] [057/130] (661s left) dumb_buffer (map-valid)
[357.169075] Starting subtest: map-valid
[357.171398] Subtest map-valid: SUCCESS (0.000s)
[357.279322] [058/130] (661s left) kms_joiner (basic-force-ultra-joiner)
[357.394770] Starting subtest: basic-force-ultra-joiner
[357.398875] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[357.452921] [059/130] (661s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[357.560122] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[357.564046] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[357.659632] [060/130] (661s left) prime_mmap (test_aperture_limit)
[357.711345] Starting subtest: test_aperture_limit
[357.713512] Starting dynamic subtest: test_aperture_limit-smem
[357.716833] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.008s)
[357.719223] Subtest test_aperture_limit: SUCCESS (0.009s)
[357.817672] [061/130] (661s left) kms_big_fb (linear-64bpp-rotate-0)
[357.910258] Starting subtest: linear-64bpp-rotate-0
[360.204107] Subtest linear-64bpp-rotate-0: SUCCESS (2.294s)
[360.480016] [062/130] (658s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[360.590116] Starting subtest: y-tiled-32bpp-rotate-270
[360.594673] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[360.700390] [063/130] (658s left) vgem_basic (bad-handle)
[360.749930] Starting subtest: bad-handle
[360.751998] Subtest bad-handle: SUCCESS (0.000s)
[360.799497] [064/130] (658s left) kms_async_flips (invalid-async-flip)
[360.890288] Starting subtest: invalid-async-flip
[360.894746] Subtest invalid-async-flip: SKIP (0.000s)
[362.051272] [065/130] (657s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[362.159113] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[362.161457] Starting dynamic subtest: pipe-A-eDP-1
[362.185493] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[362.194811] Starting dynamic subtest: pipe-B-eDP-1
[362.216739] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[362.224756] Starting dynamic subtest: pipe-C-eDP-1
[362.246057] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[362.253706] Starting dynamic subtest: pipe-D-eDP-1
[362.275624] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[362.279712] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[364.296819] [066/130] (655s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[364.425051] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[395.001921] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (30.578s)
[395.825080] [067/130] (623s left) kms_rotation_crc (primary-rotation-180)
[395.931322] Starting subtest: primary-rotation-180
[402.949479] Subtest primary-rotation-180: SUCCESS (7.018s)
[404.172238] [068/130] (615s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[404.280091] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[404.282295] Starting dynamic subtest: pipe-A-eDP-1
[404.304661] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[404.313426] Starting dynamic subtest: pipe-B-eDP-1
[404.334352] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[404.342084] Starting dynamic subtest: pipe-C-eDP-1
[404.363765] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[404.371623] Starting dynamic subtest: pipe-D-eDP-1
[404.394657] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[404.398830] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[406.423152] [069/130] (613s left) kms_getfb (getfb-handle-not-fb)
[406.479846] Starting subtest: getfb-handle-not-fb
[406.518903] Subtest getfb-handle-not-fb: SUCCESS (0.041s)
[406.625206] [070/130] (612s left) kms_psr (fbc-psr-cursor-blt)
[406.712429] Starting subtest: fbc-psr-cursor-blt
[406.714761] Starting dynamic subtest: eDP-1
[406.719252] Dynamic subtest eDP-1: SKIP (0.000s)
[406.723762] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[406.783292] [071/130] (612s left) kms_chamelium_color (ctm-green-to-red)
[406.884333] Subtest ctm-green-to-red: SKIP (0.000s)
[406.924970] [072/130] (612s left) gem_exec_whisper (basic-contexts-priority-all)
[406.987430] Starting subtest: basic-contexts-priority-all
[429.859964] Subtest basic-contexts-priority-all: SUCCESS (22.867s)
[430.044850] [073/130] (589s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[430.158456] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[430.163028] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[430.242745] [074/130] (589s left) kms_addfb_basic (small-bo)
[430.340953] Starting subtest: small-bo
[430.343476] Subtest small-bo: SUCCESS (0.000s)
[430.459047] [075/130] (589s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[430.570795] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[430.575197] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[430.690151] [076/130] (589s left) gem_eio (wait-wedge-1us)
[430.931081] Starting subtest: wait-wedge-1us
[431.993791] Subtest wait-wedge-1us: SUCCESS (1.063s)
[432.130447] [077/130] (587s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[432.233430] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[432.237991] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[432.354202] [078/130] (587s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-out-visible-area)
[432.712614] Subtest fbc-dirty-rectangle-out-visible-area: SKIP (0.000s)
[432.764496] [FACT kms_fbc_dirty_rect (fbc-dirty-rectangle-out-visible-area)] new: kernel.kmod_is_loaded.xe: true
[432.767719] [079/130] (587s left) kms_psr (fbc-pr-cursor-render)
[432.861579] Starting subtest: fbc-pr-cursor-render
[432.866209] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[432.928102] [080/130] (586s left) gem_ctx_shared (q-smoketest-all)
[432.998193] Starting subtest: Q-smoketest-all
[465.413524] Subtest Q-smoketest-all: SUCCESS (32.365s)
[467.032958] [081/130] (552s left) kms_addfb_basic (bad-pitch-32)
[467.087910] Starting subtest: bad-pitch-32
[467.091157] Subtest bad-pitch-32: SUCCESS (0.000s)
[467.219051] [082/130] (552s left) gem_pwrite (basic-random)
[467.284786] Subtest basic-random: SKIP (0.000s)
[467.343873] [083/130] (552s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[467.447337] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[467.451405] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[467.556549] [084/130] (552s left) kms_psr2_su (page_flip-nv12)
[467.622088] Subtest page_flip-NV12: SKIP (0.000s)
[467.683961] [085/130] (552s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[467.743259] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[467.847838] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[467.917288] [086/130] (552s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[468.015088] Starting subtest: yf-tiled-16bpp-rotate-180
[468.019470] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[468.131910] [087/130] (552s left) gem_exec_schedule (submit-golden-slice)
[468.192081] Starting subtest: submit-golden-slice
[468.194523] Starting dynamic subtest: rcs0
[468.221672] Dynamic subtest rcs0: SUCCESS (0.035s)
[468.232802] Starting dynamic subtest: bcs0
[468.254254] Dynamic subtest bcs0: SUCCESS (0.032s)
[468.263015] Starting dynamic subtest: vcs0
[468.289254] Dynamic subtest vcs0: SUCCESS (0.035s)
[468.297853] Starting dynamic subtest: vcs1
[468.320630] Dynamic subtest vcs1: SUCCESS (0.031s)
[468.330092] Starting dynamic subtest: vecs0
[468.356765] Dynamic subtest vecs0: SUCCESS (0.035s)
[468.366344] Starting dynamic subtest: ccs0
[468.398196] Dynamic subtest ccs0: SUCCESS (0.041s)
[468.400703] Subtest submit-golden-slice: SUCCESS (0.212s)
[470.042415] [088/130] (550s left) gem_wait (write-wait)
[470.107702] Starting subtest: write-wait
[470.110161] Starting dynamic subtest: all-engines
[471.219665] Dynamic subtest all-engines: SUCCESS (1.111s)
[471.230862] Starting dynamic subtest: rcs0
[472.287661] Dynamic subtest rcs0: SUCCESS (1.066s)
[472.303170] Starting dynamic subtest: bcs0
[473.349352] Dynamic subtest bcs0: SUCCESS (1.059s)
[473.365491] Starting dynamic subtest: vcs0
[474.404183] Dynamic subtest vcs0: SUCCESS (1.053s)
[474.420028] Starting dynamic subtest: vcs1
[475.458786] Dynamic subtest vcs1: SUCCESS (1.053s)
[475.474805] Starting dynamic subtest: vecs0
[476.511786] Dynamic subtest vecs0: SUCCESS (1.051s)
[476.527258] Starting dynamic subtest: ccs0
[477.568816] Dynamic subtest ccs0: SUCCESS (1.055s)
[477.571783] Subtest write-wait: SUCCESS (7.462s)
[477.767382] [089/130] (542s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[477.884839] Starting subtest: cursorB-vs-flipA-legacy
[477.889406] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[477.975827] [090/130] (542s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[478.076166] Starting subtest: crc-primary-basic-y-tiled-ccs
[478.078621] Starting dynamic subtest: pipe-A-eDP-1
[478.102510] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[478.111369] Starting dynamic subtest: pipe-B-eDP-1
[478.133460] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[478.141440] Starting dynamic subtest: pipe-C-eDP-1
[478.163544] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[478.171738] Starting dynamic subtest: pipe-D-eDP-1
[478.193667] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[478.197652] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[480.261644] [091/130] (540s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[480.323573] Starting subtest: etime-multi-wait-all-submitted-signaled
[480.430047] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[480.500398] [092/130] (539s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[480.611340] Starting subtest: fbcpsr-rgb565-draw-blt
[485.442216] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (4.832s)
[485.612367] [093/130] (534s left) gem_exec_fence (basic-busy)
[485.800871] Starting subtest: basic-busy
[485.803665] Starting dynamic subtest: rcs0
[485.898443] Dynamic subtest rcs0: SUCCESS (0.097s)
[485.910241] Starting dynamic subtest: bcs0
[485.959189] Dynamic subtest bcs0: SUCCESS (0.059s)
[485.968556] Starting dynamic subtest: vcs0
[486.021960] Dynamic subtest vcs0: SUCCESS (0.061s)
[486.032762] Starting dynamic subtest: vcs1
[486.082970] Dynamic subtest vcs1: SUCCESS (0.059s)
[486.093022] Starting dynamic subtest: vecs0
[486.145935] Dynamic subtest vecs0: SUCCESS (0.061s)
[486.156550] Starting dynamic subtest: ccs0
[486.211202] Dynamic subtest ccs0: SUCCESS (0.064s)
[486.213931] Subtest basic-busy: SUCCESS (0.411s)
[487.970712] [094/130] (532s left) kms_cursor_crc (cursor-random-32x32)
[488.114719] Starting subtest: cursor-random-32x32
[488.154717] Subtest cursor-random-32x32: SKIP (0.036s)
[488.440979] [095/130] (531s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[488.499042] Starting subtest: invalid-bsd2-flag-on-blt
[488.501551] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[488.604357] [096/130] (531s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[488.847605] Starting subtest: cursor-rapid-movement-512x512
[488.852187] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[489.023844] [097/130] (531s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[489.134473] Starting subtest: verify-pxp-stale-buf-optout-execution
[490.194892] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.060s)
[490.330497] [098/130] (530s left) perf_pmu (busy-accuracy-50)
[490.375848] Starting subtest: busy-accuracy-50
[490.378138] Starting dynamic subtest: rcs0
[491.919435] Dynamic subtest rcs0: SUCCESS (1.543s)
[491.929561] Starting dynamic subtest: bcs0
[493.462649] Dynamic subtest bcs0: SUCCESS (1.541s)
[493.472560] Starting dynamic subtest: vcs0
[495.009749] Dynamic subtest vcs0: SUCCESS (1.544s)
[495.020662] Starting dynamic subtest: vcs1
[496.553537] Dynamic subtest vcs1: SUCCESS (1.542s)
[496.565476] Starting dynamic subtest: vecs0
[498.095569] Dynamic subtest vecs0: SUCCESS (1.541s)
[498.106366] Starting dynamic subtest: ccs0
[499.644657] Dynamic subtest ccs0: SUCCESS (1.546s)
[499.647246] Subtest busy-accuracy-50: SUCCESS (9.269s)
[499.952718] [099/130] (520s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[500.053882] Starting subtest: x-tiled-8bpp-rotate-0
[501.143905] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.091s)
[501.261823] [100/130] (519s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[501.651426] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[502.420406] [101/130] (518s left) kms_plane_scaling (planes-downscale-factor-0-5)
[502.525222] Starting subtest: planes-downscale-factor-0-5
[502.527592] Starting dynamic subtest: pipe-A
[502.537130] Dynamic subtest pipe-A: SKIP (0.005s)
[502.546498] Starting dynamic subtest: pipe-B
[502.555993] Dynamic subtest pipe-B: SKIP (0.016s)
[502.564847] Starting dynamic subtest: pipe-C
[502.574418] Dynamic subtest pipe-C: SKIP (0.016s)
[502.583229] Starting dynamic subtest: pipe-D
[502.591628] Dynamic subtest pipe-D: SKIP (0.017s)
[502.596391] Subtest planes-downscale-factor-0-5: SKIP (0.056s)
[502.694580] [102/130] (517s left) gem_exec_params (mmapped)
[502.754071] Starting subtest: mmapped
[502.759321] Subtest mmapped: SUCCESS (0.002s)
[502.889537] [103/130] (517s left) gem_exec_balancer (nop)
[502.955792] Starting subtest: nop
[549.433250] Subtest nop: SUCCESS (46.476s)
[549.734627] [104/130] (470s left) gem_workarounds (reset)
[549.797567] Starting subtest: reset
[549.971186] Subtest reset: SUCCESS (0.174s)
[550.101715] [105/130] (470s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[550.202263] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[550.206297] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[550.312258] [106/130] (470s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[550.416593] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[550.420534] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[550.521891] [107/130] (470s left) kms_psr (psr2-cursor-blt)
[550.621132] Starting subtest: psr2-cursor-blt
[550.623404] Starting dynamic subtest: eDP-1
[552.313827] Dynamic subtest eDP-1: SUCCESS (1.694s)
[552.316178] Subtest psr2-cursor-blt: SUCCESS (1.695s)
[553.097799] [108/130] (467s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[553.200368] Starting subtest: addfb25-y-tiled-legacy
[553.202407] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[553.286997] [109/130] (467s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[553.395629] Starting subtest: 4-tiled-16bpp-rotate-270
[553.417554] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.021s)
[553.545764] [110/130] (467s left) gem_exec_reloc (basic-write-cpu)
[553.601847] Subtest basic-write-cpu: SKIP (0.000s)
[553.671714] [111/130] (467s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[553.777834] Starting subtest: psr-rgb565-draw-pwrite
[558.557086] Subtest psr-rgb565-draw-pwrite: SUCCESS (4.782s)
[558.686942] [112/130] (462s left) gem_madvise (dontneed-before-mmap)
[558.721729] Starting subtest: dontneed-before-mmap
[558.757687] Subtest dontneed-before-mmap: SUCCESS (0.035s)
[558.850410] [113/130] (462s left) gem_userptr_blits (map-fixed-invalidate-busy)
[558.911416] Starting subtest: map-fixed-invalidate-busy
[558.915546] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[559.022563] [114/130] (462s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[559.080828] Starting subtest: single-wait-all-for-submit-unsubmitted
[559.191782] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[559.266909] [115/130] (461s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[559.317604] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[559.319930] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[559.420392] [116/130] (461s left) kms_content_protection (dp-mst-lic-type-1)
[559.591784] Starting subtest: dp-mst-lic-type-1
[559.596601] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[559.721388] [117/130] (461s left) prime_busy (after-wait)
[559.782956] Starting subtest: after-wait
[559.788802] Starting dynamic subtest: rcs0
[559.834788] Dynamic subtest rcs0: SUCCESS (0.047s)
[559.845086] Starting dynamic subtest: bcs0
[559.908430] Dynamic subtest bcs0: SUCCESS (0.073s)
[559.916637] Starting dynamic subtest: vcs0
[559.948650] Dynamic subtest vcs0: SUCCESS (0.038s)
[559.956683] Starting dynamic subtest: vcs1
[559.985122] Dynamic subtest vcs1: SUCCESS (0.037s)
[559.993055] Starting dynamic subtest: vecs0
[560.023842] Dynamic subtest vecs0: SUCCESS (0.038s)
[560.031922] Starting dynamic subtest: ccs0
[560.062138] Dynamic subtest ccs0: SUCCESS (0.038s)
[560.172576] Subtest after-wait: SUCCESS (0.388s)
[560.241568] [118/130] (460s left) gem_exec_params (no-vebox)
[560.291274] Starting subtest: no-vebox
[560.293807] Subtest no-vebox: SUCCESS (0.002s)
[561.979999] [119/130] (459s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[562.070240] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[562.075139] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[563.167740] [120/130] (458s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[568.232099] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[568.237000] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[569.063445] [121/130] (452s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[569.187043] Starting subtest: modeset-atomic-cursor-hotspot
[569.191640] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[569.277108] [122/130] (452s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[569.381197] Starting subtest: read-crc-frame-sequence
[569.383633] Starting dynamic subtest: pipe-A-eDP-1
[570.062453] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.678s)
[570.071683] Starting dynamic subtest: pipe-B-eDP-1
[571.421302] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.359s)
[571.430917] Starting dynamic subtest: pipe-C-eDP-1
[572.686483] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.264s)
[572.695553] Starting dynamic subtest: pipe-D-eDP-1
[574.031052] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[574.033516] Subtest read-crc-frame-sequence: SUCCESS (4.647s)
[574.873146] [123/130] (446s left) kms_flip (dpms-off-confusion-interruptible)
[574.984034] Starting subtest: dpms-off-confusion-interruptible
[574.986422] Starting dynamic subtest: A-eDP1
[583.675433] Dynamic subtest A-eDP1: SUCCESS (8.690s)
[583.685223] Starting dynamic subtest: B-eDP1
[592.293323] Dynamic subtest B-eDP1: SUCCESS (8.617s)
[592.303061] Starting dynamic subtest: C-eDP1
[601.006926] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[601.016242] Starting dynamic subtest: D-eDP1
[609.634315] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[609.636843] Subtest dpms-off-confusion-interruptible: SUCCESS (34.653s)
[610.802316] [124/130] (410s left) kms_addfb_basic (tile-pitch-mismatch)
[610.863269] Starting subtest: tile-pitch-mismatch
[610.868049] Subtest tile-pitch-mismatch: SKIP (0.000s)
[610.993749] [125/130] (410s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[611.089999] Starting subtest: fbc-indfb-scaledprimary
[615.138653] Subtest fbc-indfb-scaledprimary: SUCCESS (4.052s)
[615.258217] [126/130] (406s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[615.352620] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[615.357097] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[615.457852] [127/130] (406s left) kms_draw_crc (draw-method-mmap-cpu)
[615.550047] Starting subtest: draw-method-mmap-cpu
[615.552217] Starting dynamic subtest: xrgb8888-untiled
[615.777310] Dynamic subtest xrgb8888-untiled: SUCCESS (0.229s)
[615.788678] Starting dynamic subtest: rgb565-untiled
[615.977204] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[615.986284] Starting dynamic subtest: xrgb2101010-untiled
[616.154725] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.177s)
[616.163097] Starting dynamic subtest: xbgr16161616f-untiled
[616.365860] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[616.374615] Starting dynamic subtest: xrgb8888-xtiled
[616.489733] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[616.503195] Starting dynamic subtest: rgb565-xtiled
[616.621398] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[616.630120] Starting dynamic subtest: xrgb2101010-xtiled
[616.733400] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[616.746668] Starting dynamic subtest: xbgr16161616f-xtiled
[616.865812] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[616.875493] Starting dynamic subtest: xrgb8888-4tiled
[617.010179] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[617.018715] Starting dynamic subtest: rgb565-4tiled
[617.132538] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[617.142326] Starting dynamic subtest: xrgb2101010-4tiled
[617.255081] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[617.265389] Starting dynamic subtest: xbgr16161616f-4tiled
[617.388604] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[617.390978] Subtest draw-method-mmap-cpu: SUCCESS (1.841s)
[617.498179] [128/130] (404s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[617.601693] Starting subtest: extended-pageflip-modeset-hang-oldfb
[617.603693] Starting dynamic subtest: pipe-A
[625.502095] Dynamic subtest pipe-A: SUCCESS (7.895s)
[625.513060] Starting dynamic subtest: pipe-D
[634.111294] Dynamic subtest pipe-D: SUCCESS (8.607s)
[634.113921] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.509s)
[634.961841] [129/130] (386s left) gem_ctx_isolation (dirty-switch)
[635.042477] Starting subtest: dirty-switch
[635.044848] Starting dynamic subtest: rcs0
[635.485401] Dynamic subtest rcs0: SUCCESS (0.442s)
[635.500977] Starting dynamic subtest: bcs0
[635.954047] Dynamic subtest bcs0: SUCCESS (0.469s)
[635.965323] Starting dynamic subtest: vcs0
[636.412584] Dynamic subtest vcs0: SUCCESS (0.458s)
[636.423892] Starting dynamic subtest: vcs1
[638.373347] Dynamic subtest vcs1: SUCCESS (1.960s)
[638.384300] Starting dynamic subtest: vecs0
[640.402561] Dynamic subtest vecs0: SUCCESS (2.028s)
[640.413689] Starting dynamic subtest: ccs0
[642.455388] Dynamic subtest ccs0: SUCCESS (2.052s)
[642.458522] Subtest dirty-switch: SUCCESS (7.413s)
[642.727920] [130/130] (378s left) api_intel_allocator (standalone)
[642.789727] Starting subtest: standalone
[642.810658] Subtest standalone: SUCCESS (0.024s)
[642.945818] Closing watchdogs
Done.