[57.707076] Initializing watchdogs
[57.707125]   /dev/watchdog0
[57.725973] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.730121] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.732103] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.734034] [001/132] (960s left) i915_query (query-topology-kernel-writes)
[57.866520] Starting subtest: query-topology-kernel-writes
[57.867786] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[57.953189] [002/132] (960s left) gen9_exec_parse (cmd-crossing-page)
[58.010966] Subtest cmd-crossing-page: SKIP (0.000s)
[58.065044] [003/132] (960s left) sysfs_timeslice_duration (idempotent)
[58.130083] Starting subtest: idempotent
[58.132354] Starting dynamic subtest: vecs0
[58.133301] Dynamic subtest vecs0: SUCCESS (0.000s)
[58.139754] Starting dynamic subtest: ccs0
[58.140607] Dynamic subtest ccs0: SUCCESS (0.000s)
[58.145317] Starting dynamic subtest: vcs0
[58.146156] Dynamic subtest vcs0: SUCCESS (0.000s)
[58.150691] Starting dynamic subtest: bcs0
[58.151523] Dynamic subtest bcs0: SUCCESS (0.000s)
[58.155977] Starting dynamic subtest: rcs0
[58.156820] Dynamic subtest rcs0: SUCCESS (0.000s)
[58.161472] Starting dynamic subtest: vcs1
[58.162348] Dynamic subtest vcs1: SUCCESS (0.000s)
[58.163143] Subtest idempotent: SUCCESS (0.003s)
[58.235658] [004/132] (960s left) syncobj_timeline (wait-any-complex)
[58.293995] Starting subtest: wait-any-complex
[58.355361] Subtest wait-any-complex: SUCCESS (0.062s)
[58.421794] [005/132] (959s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[58.528695] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[58.529718] Starting dynamic subtest: pipe-A
[58.631976] Dynamic subtest pipe-A: SUCCESS (0.103s)
[58.638869] Starting dynamic subtest: pipe-B
[59.751482] Dynamic subtest pipe-B: SUCCESS (1.119s)
[59.758701] Starting dynamic subtest: pipe-C
[60.864093] Dynamic subtest pipe-C: SUCCESS (1.112s)
[60.869731] Starting dynamic subtest: pipe-D
[61.980073] Dynamic subtest pipe-D: SUCCESS (1.116s)
[61.981212] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.451s)
[63.119085] [006/132] (955s left) kms_vblank (query-idle-hang)
[63.208684] Starting subtest: query-idle-hang
[63.210107] Starting dynamic subtest: pipe-A-eDP-1
[89.701805] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.490s)
[89.710194] Starting dynamic subtest: pipe-D-eDP-1
[104.734649] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.030s)
[104.735822] Subtest query-idle-hang: SUCCESS (41.524s)
[105.561305] [007/132] (912s left) perf_pmu (busy-no-semaphores)
[105.599774] Starting subtest: busy-no-semaphores
[105.600642] Starting dynamic subtest: rcs0
[106.170070] Dynamic subtest rcs0: SUCCESS (0.567s)
[106.177298] Starting dynamic subtest: bcs0
[106.717255] Dynamic subtest bcs0: SUCCESS (0.547s)
[106.726077] Starting dynamic subtest: vcs0
[107.265083] Dynamic subtest vcs0: SUCCESS (0.547s)
[107.273411] Starting dynamic subtest: vcs1
[108.460065] Dynamic subtest vcs1: SUCCESS (1.194s)
[108.468497] Starting dynamic subtest: vecs0
[110.446936] Dynamic subtest vecs0: SUCCESS (1.985s)
[110.453756] Starting dynamic subtest: ccs0
[112.430091] Dynamic subtest ccs0: SUCCESS (1.984s)
[112.431422] Subtest busy-no-semaphores: SUCCESS (6.828s)
[112.536011] [008/132] (905s left) gem_sync (basic-all)
[112.603424] Starting subtest: basic-all
[115.688449] Subtest basic-all: SUCCESS (3.085s)
[115.863283] [009/132] (902s left) kms_display_modes (extended-mode-basic)
[115.958520] Starting subtest: extended-mode-basic
[115.960229] Subtest extended-mode-basic: SKIP (0.000s)
[115.993494] [010/132] (902s left) core_setmaster (master-drop-set-user)
[118.018928] Starting subtest: master-drop-set-user
[118.033733] Subtest master-drop-set-user: SUCCESS (0.015s)
[118.057033] [FACT core_setmaster (master-drop-set-user)] new: kernel.kmod_is_loaded.amdgpu: true
[118.057701] [FACT core_setmaster (master-drop-set-user)] new: kernel.kmod_is_loaded.xe: true
[118.059266] [011/132] (900s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[118.111756] Starting subtest: multi-wait-all-for-submit-available-submitted
[118.112673] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[118.216669] [012/132] (900s left) kms_chamelium_color (ctm-0-25)
[118.310598] Subtest ctm-0-25: SKIP (0.000s)
[118.344709] [013/132] (900s left) gem_exec_whisper (basic-fds-priority-all)
[118.401826] Starting subtest: basic-fds-priority-all
[139.944762] Subtest basic-fds-priority-all: SUCCESS (21.539s)
[140.117912] [014/132] (878s left) kms_vblank (wait-busy-hang)
[140.225620] Starting subtest: wait-busy-hang
[140.228086] Starting dynamic subtest: pipe-A-eDP-1
[166.684369] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.458s)
[166.693147] Starting dynamic subtest: pipe-D-eDP-1
[191.645036] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.958s)
[191.646284] Subtest wait-busy-hang: SUCCESS (51.419s)
[192.488090] [015/132] (826s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[192.579647] Starting subtest: primary-4-tiled-reflect-x-180
[199.590487] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.011s)
[200.837681] [016/132] (817s left) kms_chamelium_edid (dp-mode-timings)
[201.218104] Subtest dp-mode-timings: SKIP (0.000s)
[202.037545] [017/132] (816s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[202.137544] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[202.138499] Starting dynamic subtest: pipe-A-eDP-1
[202.147167] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[202.155037] Starting dynamic subtest: pipe-B-eDP-1
[202.164742] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[202.170749] Starting dynamic subtest: pipe-C-eDP-1
[202.178896] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[202.184600] Starting dynamic subtest: pipe-D-eDP-1
[202.192230] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[202.193048] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[204.322924] [018/132] (814s left) kms_rotation_crc (cursor-rotation-180)
[204.426506] Starting subtest: cursor-rotation-180
[205.866116] Subtest cursor-rotation-180: SUCCESS (1.440s)
[207.074060] [019/132] (811s left) gem_exec_parallel (basic)
[207.128389] Starting subtest: basic
[207.129520] Starting dynamic subtest: rcs0
[208.596229] Dynamic subtest rcs0: SUCCESS (1.468s)
[208.604497] Starting dynamic subtest: bcs0
[210.060308] Dynamic subtest bcs0: SUCCESS (1.463s)
[210.067983] Starting dynamic subtest: vcs0
[211.907374] Dynamic subtest vcs0: SUCCESS (1.845s)
[211.915683] Starting dynamic subtest: vcs1
[213.930482] Dynamic subtest vcs1: SUCCESS (2.023s)
[213.937967] Starting dynamic subtest: vecs0
[215.915436] Dynamic subtest vecs0: SUCCESS (1.984s)
[215.924626] Starting dynamic subtest: ccs0
[217.422701] Dynamic subtest ccs0: SUCCESS (1.509s)
[217.424077] Subtest basic: SUCCESS (10.294s)
[217.598694] [020/132] (801s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[217.714848] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[217.716795] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[217.804231] [021/132] (800s left) gem_exec_schedule (u-semaphore-codependency)
[217.870901] Starting subtest: u-semaphore-codependency
[217.884241] Subtest u-semaphore-codependency: SUCCESS (0.013s)
[218.241371] [022/132] (800s left) gem_mmap_gtt (basic)
[218.287941] Subtest basic: SKIP (0.000s)
[218.339515] [023/132] (800s left) i915_query (query-topology-garbage-items)
[218.383693] Starting subtest: query-topology-garbage-items
[218.384925] Subtest query-topology-garbage-items: SUCCESS (0.001s)
[218.482901] [024/132] (800s left) gem_mmap (basic)
[218.540826] Subtest basic: SKIP (0.000s)
[218.596918] [025/132] (800s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite)
[218.698362] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite
[222.585339] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (3.888s)
[222.702757] [026/132] (796s left) gem_exec_balancer (hang)
[222.953313] Starting subtest: hang
[224.977729] Subtest hang: SUCCESS (2.025s)
[225.109749] [027/132] (793s left) syncobj_basic (bad-flags-handle-to-fd)
[225.176206] Starting subtest: bad-flags-handle-to-fd
[225.177722] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[225.281708] [028/132] (793s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[230.262971] Starting subtest: pr-plane-move-sf-dmg-area
[230.265522] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s)
[231.098622] [029/132] (787s left) gem_ctx_persistence (legacy-engines-mixed)
[231.151877] Starting subtest: legacy-engines-mixed
[231.152912] Starting dynamic subtest: render
[231.237324] Dynamic subtest render: SUCCESS (0.085s)
[231.246250] Starting dynamic subtest: bsd1
[231.314117] Dynamic subtest bsd1: SUCCESS (0.075s)
[231.322923] Starting dynamic subtest: bsd2
[231.373526] Dynamic subtest bsd2: SUCCESS (0.058s)
[231.380806] Starting dynamic subtest: blt
[231.456937] Dynamic subtest blt: SUCCESS (0.082s)
[231.466184] Starting dynamic subtest: vebox
[231.533416] Dynamic subtest vebox: SUCCESS (0.076s)
[231.534574] Subtest legacy-engines-mixed: SUCCESS (0.382s)
[231.602540] [030/132] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[231.710122] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[231.711883] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[231.807031] [031/132] (787s left) gem_watchdog (default-virtual)
[231.863125] Starting subtest: default-virtual
[238.149262] Subtest default-virtual: SUCCESS (6.283s)
[238.260564] [032/132] (780s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[238.361280] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[243.197768] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.835s)
[243.313243] [033/132] (775s left) kms_psr (fbc-psr2-basic)
[243.410080] Starting subtest: fbc-psr2-basic
[243.411124] Starting dynamic subtest: eDP-1
[243.413079] Dynamic subtest eDP-1: SKIP (0.000s)
[243.414935] Subtest fbc-psr2-basic: SKIP (0.001s)
[243.476450] [034/132] (775s left) kms_invalid_mode (bad-hsync-end)
[243.572605] Starting subtest: bad-hsync-end
[243.573574] Starting dynamic subtest: pipe-A-eDP-1
[243.853747] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[243.860873] Starting dynamic subtest: pipe-B-eDP-1
[243.861762] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[243.867600] Starting dynamic subtest: pipe-C-eDP-1
[243.868454] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[243.874667] Starting dynamic subtest: pipe-D-eDP-1
[243.875545] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[243.876416] Subtest bad-hsync-end: SUCCESS (0.285s)
[244.667743] [035/132] (774s left) prime_vgem (wait)
[244.803550] Starting subtest: wait
[244.804652] Starting dynamic subtest: rcs0
[244.858463] Dynamic subtest rcs0: SUCCESS (0.055s)
[244.864934] Starting dynamic subtest: bcs0
[244.942964] Dynamic subtest bcs0: SUCCESS (0.084s)
[244.949311] Starting dynamic subtest: vcs0
[244.987063] Dynamic subtest vcs0: SUCCESS (0.044s)
[244.993501] Starting dynamic subtest: vcs1
[245.030488] Dynamic subtest vcs1: SUCCESS (0.043s)
[245.036926] Starting dynamic subtest: vecs0
[245.076074] Dynamic subtest vecs0: SUCCESS (0.045s)
[245.082422] Starting dynamic subtest: ccs0
[245.122085] Dynamic subtest ccs0: SUCCESS (0.046s)
[245.122954] Subtest wait: SUCCESS (0.319s)
[245.240121] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[245.242170] [036/132] (774s left) gem_mmap_offset (bad-object)
[245.298524] Starting subtest: bad-object
[245.299629] Subtest bad-object: SUCCESS (0.001s)
[245.405101] [037/132] (773s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[245.492814] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[245.493685] Starting dynamic subtest: pipe-A-default-mode
[245.793583] Dynamic subtest pipe-A-default-mode: SKIP (0.298s)
[245.796486] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.299s)
[246.594137] [038/132] (772s left) gem_lmem_swapping (heavy-multi)
[246.634361] Subtest heavy-multi: SKIP (0.000s)
[246.676969] [039/132] (772s left) gem_exec_schedule (semaphore-power)
[246.856512] Subtest semaphore-power: SKIP (0.000s)
[247.026852] [040/132] (772s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[247.115745] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[247.116720] Starting dynamic subtest: pipe-A
[247.122780] Dynamic subtest pipe-A: SKIP (0.005s)
[247.129511] Starting dynamic subtest: pipe-B
[247.139736] Dynamic subtest pipe-B: SKIP (0.016s)
[247.145835] Starting dynamic subtest: pipe-C
[247.155686] Dynamic subtest pipe-C: SKIP (0.016s)
[247.161761] Starting dynamic subtest: pipe-D
[247.171939] Dynamic subtest pipe-D: SKIP (0.016s)
[247.173660] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.055s)
[247.258354] [041/132] (772s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[247.353090] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[247.354752] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[247.442738] [042/132] (771s left) kms_cursor_crc (cursor-offscreen-256x85)
[247.658927] Starting subtest: cursor-offscreen-256x85
[247.706358] Subtest cursor-offscreen-256x85: SKIP (0.045s)
[247.872839] [043/132] (771s left) gem_eio (banned)
[248.065302] Starting subtest: banned
[248.625990] Subtest banned: SUCCESS (0.562s)
[248.805805] [044/132] (770s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[253.834307] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[253.835300] Starting dynamic subtest: pipe-A-eDP-1
[254.642241] Dynamic subtest pipe-A-eDP-1: SKIP (0.808s)
[254.649046] Starting dynamic subtest: pipe-B-eDP-1
[255.763502] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[255.765385] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.930s)
[256.938345] [045/132] (762s left) kms_prime (basic-crc-vgem)
[257.024269] Starting subtest: basic-crc-vgem
[257.025230] Starting dynamic subtest: second-to-first
[257.941587] Dynamic subtest second-to-first: SUCCESS (0.918s)
[257.942472] Subtest basic-crc-vgem: SUCCESS (0.919s)
[258.020088] [046/132] (761s left) kms_pm_rpm (drm-resources-equal)
[259.569581] Starting subtest: drm-resources-equal
[264.902945] Subtest drm-resources-equal: SUCCESS (5.334s)
[264.983130] [047/132] (754s left) gem_exec_balancer (sliced)
[265.052218] Starting subtest: sliced
[265.054603] Subtest sliced: SKIP (0.000s)
[265.348234] [048/132] (754s left) kms_psr (pr-cursor-blt)
[265.438929] Starting subtest: pr-cursor-blt
[265.440611] Subtest pr-cursor-blt: SKIP (0.000s)
[265.504017] [049/132] (754s left) perf (oa-formats)
[265.603803] Starting subtest: oa-formats
[265.604721] Starting dynamic subtest: 0-rcs0
[265.623545] Dynamic subtest 0-rcs0: SUCCESS (0.020s)
[265.631393] Starting dynamic subtest: 1-vcs1
[265.663186] Dynamic subtest 1-vcs1: SUCCESS (0.039s)
[265.664338] Subtest oa-formats: SUCCESS (0.060s)
[265.707481] [050/132] (753s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[265.805224] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[265.806982] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[265.900433] [051/132] (753s left) gem_spin_batch (spin-all)
[265.958076] Starting subtest: spin-all
[265.971768] Subtest spin-all: SUCCESS (0.014s)
[267.981970] [052/132] (751s left) kms_flip (dpms-vs-vblank-race)
[268.083429] Starting subtest: dpms-vs-vblank-race
[268.085583] Starting dynamic subtest: A-eDP1
[273.090078] Dynamic subtest A-eDP1: SUCCESS (5.004s)
[273.097015] Starting dynamic subtest: B-eDP1
[277.693462] Dynamic subtest B-eDP1: SUCCESS (4.601s)
[277.706162] Starting dynamic subtest: C-eDP1
[282.198557] Dynamic subtest C-eDP1: SUCCESS (4.505s)
[282.205315] Starting dynamic subtest: D-eDP1
[286.600750] Dynamic subtest D-eDP1: SUCCESS (4.403s)
[286.603388] Subtest dpms-vs-vblank-race: SUCCESS (18.520s)
[287.380591] [053/132] (732s left) i915_pm_rps (min-max-config-idle)
[287.443692] Starting subtest: min-max-config-idle
[287.445584] Subtest min-max-config-idle: SKIP (0.000s)
[287.495899] [054/132] (732s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[287.592788] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[292.220084] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.629s)
[292.349228] [055/132] (727s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[292.748405] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[293.536628] [056/132] (726s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[293.630718] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[293.632504] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[293.722918] [057/132] (726s left) i915_hangman (engine-error-state-capture)
[293.783677] Starting subtest: engine-error-state-capture
[293.784962] Starting dynamic subtest: rcs0
[296.905638] Dynamic subtest rcs0: SUCCESS (3.119s)
[296.916207] Starting dynamic subtest: bcs0
[302.858292] Dynamic subtest bcs0: SUCCESS (5.950s)
[302.867376] Starting dynamic subtest: vcs0
[308.873578] Dynamic subtest vcs0: SUCCESS (6.013s)
[308.882860] Starting dynamic subtest: vcs1
[314.826244] Dynamic subtest vcs1: SUCCESS (5.950s)
[314.836648] Starting dynamic subtest: vecs0
[319.817839] Dynamic subtest vecs0: SUCCESS (4.989s)
[319.827841] Starting dynamic subtest: ccs0
[324.874290] Dynamic subtest ccs0: SUCCESS (5.053s)
[324.876734] Subtest engine-error-state-capture: SUCCESS (31.088s)
[324.948243] [058/132] (694s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[325.070492] Starting subtest: cursorB-vs-flipA-toggle
[325.073526] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[325.178161] [059/132] (694s left) kms_plane_scaling (invalid-parameters)
[325.280485] Starting subtest: invalid-parameters
[325.281392] Starting dynamic subtest: less-than-1-height-src
[325.289916] Dynamic subtest less-than-1-height-src: SUCCESS (0.010s)
[325.296853] Starting dynamic subtest: less-than-1-width-src
[325.300525] Dynamic subtest less-than-1-width-src: SUCCESS (0.010s)
[325.301374] Subtest invalid-parameters: SUCCESS (0.021s)
[325.408095] [060/132] (694s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[325.512110] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[325.523895] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[325.592621] [061/132] (694s left) kms_chamelium_frames (hdmi-crc-single)
[325.978860] Subtest hdmi-crc-single: SKIP (0.000s)
[326.756487] [062/132] (693s left) kms_atomic (plane-invalid-params-fence)
[326.865791] Starting subtest: plane-invalid-params-fence
[326.866825] Starting dynamic subtest: pipe-A-eDP-1
[327.239353] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.373s)
[327.240432] Subtest plane-invalid-params-fence: SUCCESS (0.374s)
[328.108708] [063/132] (691s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[328.210951] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[331.424243] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (3.220s)
[331.558802] [064/132] (688s left) kms_mmap_write_crc (main)
[331.646999] Starting subtest: main
[331.648061] Starting dynamic subtest: pipe-A-eDP-1
[335.206238] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.558s)
[335.207518] Subtest main: SUCCESS (3.559s)
[336.051661] [065/132] (684s left) gem_mmap_wc (read-write-distinct)
[336.110543] Subtest read-write-distinct: SKIP (0.000s)
[336.169547] [066/132] (684s left) kms_properties (crtc-properties-atomic)
[336.268842] Starting subtest: crtc-properties-atomic
[336.269759] Starting dynamic subtest: pipe-A-eDP-1
[336.720574] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[336.729704] Starting dynamic subtest: pipe-B-eDP-1
[337.905589] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.185s)
[337.915178] Starting dynamic subtest: pipe-C-eDP-1
[339.015343] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[339.024459] Starting dynamic subtest: pipe-D-eDP-1
[340.150056] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[340.150950] Subtest crtc-properties-atomic: SUCCESS (3.881s)
[340.953835] [067/132] (679s left) kms_cursor_crc (cursor-onscreen-128x128)
[341.148191] Starting subtest: cursor-onscreen-128x128
[341.153470] Starting dynamic subtest: pipe-A-eDP-1
[343.458259] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.305s)
[343.481743] Starting dynamic subtest: pipe-D-eDP-1
[346.451227] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.975s)
[346.452374] Subtest cursor-onscreen-128x128: SUCCESS (5.303s)
[347.297455] [068/132] (672s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[347.362730] Starting subtest: multi-wait-all-for-submit-submitted
[347.471620] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[347.539067] [069/132] (672s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[347.603058] Starting subtest: mixed-tiled-to-y-tiled-ccs
[347.604941] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[347.776430] [070/132] (672s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[347.833085] Starting subtest: etime-single-wait-for-submit-submitted
[347.933972] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.101s)
[348.003299] [071/132] (672s left) syncobj_basic (illegal-fd-to-handle)
[348.046728] Starting subtest: illegal-fd-to-handle
[348.047961] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[348.154239] [072/132] (672s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[348.253064] Starting subtest: fbc-modesetfrombusy
[351.024067] Subtest fbc-modesetfrombusy: SUCCESS (2.772s)
[351.166741] [073/132] (669s left) vgem_basic (dmabuf-mmap)
[351.203906] Starting subtest: dmabuf-mmap
[351.242330] Subtest dmabuf-mmap: SUCCESS (0.040s)
[351.289899] [074/132] (669s left) gem_exec_balancer (busy)
[351.356552] Starting subtest: busy
[352.955297] Subtest busy: SUCCESS (1.596s)
[353.287649] [075/132] (667s left) kms_properties (get_properties-sanity-non-atomic)
[353.391918] Starting subtest: get_properties-sanity-non-atomic
[353.394134] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[353.458893] [076/132] (667s left) gem_fence_thrash (bo-write-verify-y)
[353.489690] Starting subtest: bo-write-verify-y
[353.514796] Subtest bo-write-verify-y: SKIP (0.023s)
[353.571830] [077/132] (666s left) kms_cursor_crc (cursor-sliding-64x21)
[353.747353] Starting subtest: cursor-sliding-64x21
[353.785206] Subtest cursor-sliding-64x21: SKIP (0.035s)
[354.022507] [078/132] (666s left) syncobj_wait (wait-for-submit-complex)
[354.071797] Starting subtest: wait-for-submit-complex
[354.133364] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[354.204548] [079/132] (666s left) kms_flip (flip-vs-fences)
[354.300579] Starting subtest: flip-vs-fences
[354.302521] Subtest flip-vs-fences: SKIP (0.000s)
[354.424483] [080/132] (666s left) syncobj_wait (single-wait-all-signaled)
[354.465880] Starting subtest: single-wait-all-signaled
[354.466949] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[354.580518] [081/132] (666s left) kms_big_fb (linear-addfb)
[354.690931] Starting subtest: linear-addfb
[354.691905] Subtest linear-addfb: SUCCESS (0.000s)
[354.797138] [082/132] (665s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[354.886700] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[354.888350] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[354.989556] [083/132] (665s left) gem_render_copy (x-tiled)
[355.049544] Starting subtest: x-tiled
[355.050555] Starting dynamic subtest: smem
[355.094179] Dynamic subtest smem: SUCCESS (0.044s)
[355.095171] Subtest x-tiled: SUCCESS (0.045s)
[355.314434] [084/132] (665s left) gem_fence_thrash (bo-write-verify-none)
[355.344724] Starting subtest: bo-write-verify-none
[355.361263] Subtest bo-write-verify-none: SKIP (0.016s)
[355.426600] [085/132] (665s left) kms_cursor_crc (cursor-size-change)
[355.512058] Starting subtest: cursor-size-change
[355.513274] Starting dynamic subtest: pipe-A-eDP-1
[356.347422] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.829s)
[356.355666] Starting dynamic subtest: pipe-D-eDP-1
[357.840892] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.496s)
[357.842149] Subtest cursor-size-change: SUCCESS (2.328s)
[358.734743] [086/132] (662s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[358.829938] Starting subtest: y-tiled-8bpp-rotate-90
[358.831752] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[358.938937] [087/132] (661s left) kms_rotation_crc (primary-rotation-90)
[359.036086] Starting subtest: primary-rotation-90
[359.038990] Subtest primary-rotation-90: SKIP (0.001s)
[359.101449] [088/132] (661s left) testdisplay
[359.465660] [089/132] (661s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[359.557853] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[359.558871] Starting dynamic subtest: pipe-A-eDP-1
[359.567730] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[359.574718] Starting dynamic subtest: pipe-B-eDP-1
[359.583400] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[359.590029] Starting dynamic subtest: pipe-C-eDP-1
[359.598319] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[359.605091] Starting dynamic subtest: pipe-D-eDP-1
[359.613510] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[359.615138] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[361.767431] [090/132] (659s left) gem_tiled_pread_basic
[361.886113] [091/132] (659s left) gem_exec_reloc (basic-wc-noreloc)
[361.938930] Subtest basic-wc-noreloc: SKIP (0.000s)
[362.013156] [092/132] (659s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[362.107070] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[367.289717] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.183s)
[367.432891] [093/132] (653s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[367.484340] Starting subtest: single-wait-all-for-submit-signaled
[367.485244] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[367.597847] [094/132] (653s left) api_intel_bb (blit-reloc-purge-cache)
[367.644119] Starting subtest: blit-reloc-purge-cache
[367.646111] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[367.773150] [095/132] (653s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[367.876509] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[367.877888] Starting dynamic subtest: pipe-A-default-mode
[370.573227] Dynamic subtest pipe-A-default-mode: SUCCESS (2.695s)
[370.574153] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.696s)
[371.396877] [096/132] (649s left) kms_psr (psr2-sprite-plane-onoff)
[371.494879] Starting subtest: psr2-sprite-plane-onoff
[371.496581] Starting dynamic subtest: eDP-1
[373.195057] Dynamic subtest eDP-1: SUCCESS (1.700s)
[373.196043] Subtest psr2-sprite-plane-onoff: SUCCESS (1.701s)
[374.049833] [097/132] (647s left) dmabuf_sync_file (export-basic)
[374.095312] Starting subtest: export-basic
[374.096555] Subtest export-basic: SUCCESS (0.001s)
[374.150572] [098/132] (647s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[374.257822] Starting subtest: 4-tiled-8bpp-rotate-270
[374.278909] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[374.400458] [099/132] (646s left) kms_psr (fbc-psr-cursor-blt)
[374.505533] Starting subtest: fbc-psr-cursor-blt
[374.506491] Starting dynamic subtest: eDP-1
[374.508323] Dynamic subtest eDP-1: SKIP (0.000s)
[374.510048] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[374.573379] [100/132] (646s left) kms_flip (2x-absolute-wf_vblank)
[374.665436] Starting subtest: 2x-absolute-wf_vblank
[374.676723] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[374.756578] [101/132] (646s left) kms_cursor_legacy (forked-move)
[374.881672] Starting subtest: forked-move
[374.882626] Starting dynamic subtest: pipe-A
[380.390550] Dynamic subtest pipe-A: SUCCESS (5.505s)
[380.400335] Starting dynamic subtest: pipe-B
[385.903049] Dynamic subtest pipe-B: SUCCESS (5.511s)
[385.912625] Starting dynamic subtest: pipe-C
[391.415402] Dynamic subtest pipe-C: SUCCESS (5.511s)
[391.422626] Starting dynamic subtest: pipe-D
[396.913252] Dynamic subtest pipe-D: SUCCESS (5.496s)
[396.922274] Starting dynamic subtest: all-pipes
[402.436432] Dynamic subtest all-pipes: SUCCESS (5.522s)
[402.437455] Subtest forked-move: SUCCESS (27.552s)
[402.560896] [102/132] (618s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[402.666918] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[402.667952] Starting dynamic subtest: pipe-A-eDP-1
[402.677542] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[402.685199] Starting dynamic subtest: pipe-B-eDP-1
[402.694570] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[402.701593] Starting dynamic subtest: pipe-C-eDP-1
[402.710404] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[402.717863] Starting dynamic subtest: pipe-D-eDP-1
[402.731512] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[402.733310] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[404.801122] [103/132] (616s left) gem_softpin (allocator-fork)
[404.862473] Starting subtest: allocator-fork
[407.078448] Subtest allocator-fork: SUCCESS (2.214s)
[407.197140] [104/132] (614s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[407.299944] Starting subtest: disable-crc-after-crtc
[407.300969] Starting dynamic subtest: pipe-A-eDP-1
[408.930761] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.630s)
[408.937810] Starting dynamic subtest: pipe-B-eDP-1
[411.197626] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.265s)
[411.204921] Starting dynamic subtest: pipe-C-eDP-1
[413.426062] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.227s)
[413.433454] Starting dynamic subtest: pipe-D-eDP-1
[415.679077] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.251s)
[415.680244] Subtest disable-crc-after-crtc: SUCCESS (8.377s)
[416.501642] [105/132] (604s left) drm_fdinfo (most-busy-check-all)
[416.541531] Starting subtest: most-busy-check-all
[416.542493] Starting dynamic subtest: rcs0
[416.546438] Dynamic subtest rcs0: SKIP (0.004s)
[416.553965] Starting dynamic subtest: bcs0
[416.555672] Dynamic subtest bcs0: SKIP (0.000s)
[416.562455] Starting dynamic subtest: vcs0
[416.564189] Dynamic subtest vcs0: SKIP (0.000s)
[416.570990] Starting dynamic subtest: vcs1
[416.572747] Dynamic subtest vcs1: SKIP (0.000s)
[416.579540] Starting dynamic subtest: vecs0
[416.581123] Dynamic subtest vecs0: SKIP (0.000s)
[416.587817] Starting dynamic subtest: ccs0
[416.589895] Dynamic subtest ccs0: SKIP (0.000s)
[416.591815] Subtest most-busy-check-all: SKIP (0.009s)
[416.621299] [106/132] (604s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[416.764843] Starting subtest: pipe-fbc-rte
[416.767509] Starting dynamic subtest: pipe-B-eDP-1
[421.145246] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.381s)
[421.149436] Subtest pipe-fbc-rte: SUCCESS (4.383s)
[422.339120] [107/132] (599s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[422.396544] Starting subtest: etime-multi-wait-all-available-unsubmitted
[422.503453] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.107s)
[422.569157] [108/132] (599s left) gem_ctx_freq (sysfs)
[422.626078] Starting subtest: sysfs
[422.626914] Starting dynamic subtest: gt0
[428.132905] Dynamic subtest gt0: SUCCESS (5.506s)
[428.142547] Starting dynamic subtest: gt1
[469.931018] Dynamic subtest gt1: SUCCESS (41.795s)
[469.933415] Subtest sysfs: SUCCESS (47.303s)
[470.000241] [109/132] (551s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[470.096908] Starting subtest: psr-1p-primscrn-cur-indfb-move
[475.126029] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (5.030s)
[475.243623] [110/132] (546s left) gem_ccs (ctrl-surf-copy)
[475.289426] Starting subtest: ctrl-surf-copy
[475.291393] Subtest ctrl-surf-copy: SKIP (0.000s)
[475.389226] [111/132] (546s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[475.515950] Starting subtest: basic-flip-before-cursor-atomic
[476.420729] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.904s)
[477.298745] [112/132] (544s left) gem_exec_fence (syncobj-invalid-wait)
[477.744573] Starting subtest: syncobj-invalid-wait
[477.745829] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[479.034363] [113/132] (542s left) gem_pxp (regular-baseline-src-copy-readible)
[479.162917] Starting subtest: regular-baseline-src-copy-readible
[479.221834] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s)
[479.339075] [114/132] (542s left) gem_exec_schedule (fifo)
[479.405977] Starting subtest: fifo
[479.406904] Starting dynamic subtest: rcs0
[479.503529] Dynamic subtest rcs0: SUCCESS (0.096s)
[479.512927] Starting dynamic subtest: vcs0
[479.582031] Dynamic subtest vcs0: SUCCESS (0.078s)
[479.591170] Starting dynamic subtest: vcs1
[479.654807] Dynamic subtest vcs1: SUCCESS (0.072s)
[479.662937] Starting dynamic subtest: vecs0
[479.726995] Dynamic subtest vecs0: SUCCESS (0.071s)
[479.736753] Starting dynamic subtest: ccs0
[479.836505] Dynamic subtest ccs0: SUCCESS (0.108s)
[479.838244] Subtest fifo: SUCCESS (0.430s)
[481.051844] [115/132] (540s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[481.161114] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[482.475218] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.314s)
[482.662944] [116/132] (539s left) gem_ctx_bad_destroy (double-destroy)
[482.714761] Starting subtest: double-destroy
[482.715897] Subtest double-destroy: SUCCESS (0.000s)
[482.783676] [117/132] (539s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[482.837935] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[482.896718] [118/132] (539s left) kms_big_fb (linear-16bpp-rotate-270)
[482.994871] Starting subtest: linear-16bpp-rotate-270
[483.014160] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[483.124220] [119/132] (538s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[483.226865] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[483.228912] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[484.319406] [120/132] (537s left) perf_pmu (invalid-open)
[484.356128] Starting subtest: invalid-open
[484.357126] Subtest invalid-open: SUCCESS (0.000s)
[484.463118] [121/132] (537s left) gem_ctx_persistence (hang)
[484.520858] Starting subtest: hang
[484.522750] Subtest hang: SKIP (0.000s)
[484.633882] [122/132] (537s left) vkms/vkms_configfs (enabled-plane-cannot-change)
[484.666297] Subtest enabled-plane-cannot-change: SKIP (0.000s)
[484.709027] [123/132] (537s left) gem_userptr_blits (coherency-sync)
[484.776357] Starting subtest: coherency-sync
[485.178112] Subtest coherency-sync: SKIP (0.386s)
[485.297057] [124/132] (536s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[485.438875] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[485.440820] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[485.545403] [125/132] (536s left) prime_mmap (test_map_unmap)
[485.602063] Starting subtest: test_map_unmap
[485.603052] Starting dynamic subtest: test_map_unmap-smem
[485.636747] Dynamic subtest test_map_unmap-smem: SUCCESS (0.036s)
[485.637883] Subtest test_map_unmap: SUCCESS (0.036s)
[485.741770] [126/132] (536s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[485.838724] Starting subtest: fbcpsr-1p-rte
[490.674611] Subtest fbcpsr-1p-rte: SUCCESS (4.838s)
[490.827625] [127/132] (531s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[490.928965] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[490.930899] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[491.027488] [128/132] (531s left) kms_psr (psr2-no-drrs)
[491.120979] Starting subtest: psr2-no-drrs
[491.121918] Starting dynamic subtest: eDP-1
[492.711740] Dynamic subtest eDP-1: SUCCESS (1.589s)
[492.712811] Subtest psr2-no-drrs: SUCCESS (1.590s)
[493.496304] [129/132] (528s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[493.596146] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[498.553594] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.956s)
[498.705321] [130/132] (523s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[498.793870] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[498.794753] Starting dynamic subtest: pipe-A-default-mode
[499.078945] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[499.080837] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.284s)
[499.865457] [131/132] (522s left) gem_mmap_gtt (bad-object)
[499.922596] Subtest bad-object: SKIP (0.000s)
[499.984091] [132/132] (522s left) gem_close (many-handles-one-vma)
[500.038137] Starting subtest: many-handles-one-vma
[500.065464] Subtest many-handles-one-vma: SUCCESS (0.027s)
[500.176503] Closing watchdogs
Done.