[60.004671] Initializing watchdogs
[60.004746]   /dev/watchdog0
[60.018274] [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]
[60.022507] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.024828] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.028156] [001/131] (960s left) syncobj_wait (wait-all-snapshot)
[60.100134] Starting subtest: wait-all-snapshot
[60.180418] Subtest wait-all-snapshot: SUCCESS (0.081s)
[60.248430] [002/131] (960s left) kms_setmode (basic)
[60.306618] Starting subtest: basic
[60.669150] Starting dynamic subtest: pipe-A-eDP-1
[62.852229] Dynamic subtest pipe-A-eDP-1: FAIL (2.069s)
[63.093069] Starting dynamic subtest: pipe-B-eDP-1
[65.283373] Dynamic subtest pipe-B-eDP-1: FAIL (2.068s)
[65.469477] Subtest basic: FAIL (5.142s)
[66.294520] [003/131] (954s left) syncobj_timeline (reset-during-wait-for-submit)
[66.350048] Starting subtest: reset-during-wait-for-submit
[66.453841] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[66.521139] [004/131] (954s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[66.608048] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[66.610461] Starting dynamic subtest: pipe-A
[66.619510] Dynamic subtest pipe-A: SKIP (0.005s)
[66.625944] Starting dynamic subtest: pipe-B
[66.635136] Dynamic subtest pipe-B: SKIP (0.016s)
[66.641347] Starting dynamic subtest: pipe-C
[66.653468] Dynamic subtest pipe-C: SKIP (0.018s)
[66.659438] Starting dynamic subtest: pipe-D
[66.671056] Dynamic subtest pipe-D: SKIP (0.020s)
[66.675274] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.059s)
[66.765178] [005/131] (953s left) i915_pm_rps (thresholds-idle)
[66.840614] Starting subtest: thresholds-idle
[66.844989] Subtest thresholds-idle: SKIP (0.000s)
[66.911101] [006/131] (953s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[67.010368] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[67.014783] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[67.111701] [007/131] (953s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[67.215473] Starting subtest: y-tiled-32bpp-rotate-270
[67.220085] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[67.316667] [008/131] (953s left) gen9_exec_parse (batch-zero-length)
[67.378472] Subtest batch-zero-length: SKIP (0.000s)
[67.446292] [009/131] (953s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[67.554491] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[68.551578] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.996s)
[68.713050] [010/131] (952s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[68.843160] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[68.847266] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[68.970376] [011/131] (951s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[69.065792] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[69.069601] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[69.173068] [012/131] (951s left) kms_atomic (crtc-invalid-params)
[69.258485] Starting subtest: crtc-invalid-params
[69.260296] Starting dynamic subtest: pipe-A-eDP-1
[69.625433] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.364s)
[69.627834] Subtest crtc-invalid-params: SUCCESS (0.365s)
[70.427681] [013/131] (950s left) gem_pxp (create-regular-buffer)
[70.552037] Starting subtest: create-regular-buffer
[70.554515] Subtest create-regular-buffer: SUCCESS (0.000s)
[70.653987] [014/131] (950s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[70.763095] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[70.765426] Starting dynamic subtest: pipe-A-eDP-1
[70.787563] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[70.795793] Starting dynamic subtest: pipe-B-eDP-1
[70.817076] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[70.823492] Starting dynamic subtest: pipe-C-eDP-1
[70.845557] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[70.852438] Starting dynamic subtest: pipe-D-eDP-1
[70.874345] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[70.878507] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[72.885948] [015/131] (948s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[73.000664] Starting subtest: yf-tiled-8bpp-rotate-0
[73.004805] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[73.108945] [016/131] (947s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[73.239030] Starting subtest: modeset-atomic-cursor-hotspot
[73.243289] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[73.327900] [017/131] (947s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[73.423623] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[73.425984] Starting dynamic subtest: pipe-A-eDP-1
[73.450043] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[73.457090] Starting dynamic subtest: pipe-B-eDP-1
[73.478795] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[73.486753] Starting dynamic subtest: pipe-C-eDP-1
[73.508613] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[73.516532] Starting dynamic subtest: pipe-D-eDP-1
[73.538758] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[73.543243] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.002s)
[75.537210] [018/131] (945s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[75.649439] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[76.912560] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.660s)
[76.942759] [019/131] (944s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[77.043477] Starting subtest: fbcpsr-rgb565-draw-pwrite
[81.983397] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (4.940s)
[82.096619] [020/131] (939s left) gem_softpin (evict-active)
[82.160653] Starting subtest: evict-active
[82.167311] Subtest evict-active: SUCCESS (0.007s)
[82.287404] [021/131] (938s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[82.389073] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[82.391382] Starting dynamic subtest: pipe-A-default-mode
[82.678742] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[82.683690] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.287s)
[83.510194] [022/131] (937s left) kms_prop_blob (blob-multiple)
[83.573987] Starting subtest: blob-multiple
[83.576422] Subtest blob-multiple: SUCCESS (0.002s)
[83.688729] [023/131] (937s left) kms_getfb (getfb2-handle-protection)
[83.749355] Starting subtest: getfb2-handle-protection
[83.780998] Subtest getfb2-handle-protection: SUCCESS (0.032s)
[83.908836] [024/131] (937s left) gem_exec_whisper (basic-fds-all)
[83.969401] Starting subtest: basic-fds-all
[95.885221] Subtest basic-fds-all: SUCCESS (11.909s)
[96.058580] [025/131] (925s left) gem_userptr_blits (userfault)
[96.126537] Starting subtest: userfault
[96.128656] Subtest userfault: SUCCESS (0.009s)
[96.283783] [026/131] (925s left) api_intel_allocator (standalone)
[96.347880] Starting subtest: standalone
[96.369669] Subtest standalone: SUCCESS (0.023s)
[96.480603] [027/131] (924s left) syncobj_eventfd (timeline-wait-signaled)
[96.544977] Starting subtest: timeline-wait-signaled
[96.547402] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[96.650727] [028/131] (924s left) gem_wait (invalid-buf)
[96.714406] Starting subtest: invalid-buf
[96.716731] Subtest invalid-buf: SUCCESS (0.000s)
[96.959221] [029/131] (924s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[97.061993] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[97.064895] Starting dynamic subtest: pipe-A
[97.147898] Dynamic subtest pipe-A: SUCCESS (0.086s)
[97.157320] Starting dynamic subtest: pipe-B
[98.342794] Dynamic subtest pipe-B: SUCCESS (1.194s)
[98.351868] Starting dynamic subtest: pipe-C
[99.442684] Dynamic subtest pipe-C: SUCCESS (1.099s)
[99.451700] Starting dynamic subtest: pipe-D
[100.569803] Dynamic subtest pipe-D: SUCCESS (1.127s)
[100.572139] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.508s)
[101.713665] [030/131] (919s left) kms_vblank (query-forked-hang)
[101.818747] Starting subtest: query-forked-hang
[101.820984] Starting dynamic subtest: pipe-A-eDP-1
[128.688764] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.868s)
[128.703827] Starting dynamic subtest: pipe-D-eDP-1
[143.656181] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.963s)
[143.658520] Subtest query-forked-hang: SUCCESS (41.835s)
[144.461255] [031/131] (877s left) kms_vrr (flip-dpms)
[144.555036] Starting subtest: flip-dpms
[144.562075] Subtest flip-dpms: SKIP (0.000s)
[144.634251] [032/131] (876s left) perf_pmu (busy-check-all)
[144.678850] Starting subtest: busy-check-all
[144.681267] Starting dynamic subtest: rcs0
[145.258235] Dynamic subtest rcs0: SUCCESS (0.580s)
[145.269293] Starting dynamic subtest: bcs0
[145.805811] Dynamic subtest bcs0: SUCCESS (0.547s)
[145.815906] Starting dynamic subtest: vcs0
[146.922882] Dynamic subtest vcs0: SUCCESS (1.114s)
[146.933604] Starting dynamic subtest: vcs1
[148.906820] Dynamic subtest vcs1: SUCCESS (1.983s)
[148.917828] Starting dynamic subtest: vecs0
[150.891351] Dynamic subtest vecs0: SUCCESS (1.983s)
[150.901529] Starting dynamic subtest: ccs0
[151.446457] Dynamic subtest ccs0: SUCCESS (0.556s)
[151.449160] Subtest busy-check-all: SUCCESS (6.769s)
[151.567871] [033/131] (870s left) kms_atomic_interruptible (legacy-cursor)
[151.676870] Starting subtest: legacy-cursor
[151.679182] Starting dynamic subtest: pipe-A-eDP-1
[159.064633] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.388s)
[159.067086] Subtest legacy-cursor: SUCCESS (7.389s)
[159.906312] [034/131] (861s left) gem_flink_basic (bad-open)
[159.970274] Starting subtest: bad-open
[159.972701] Subtest bad-open: SUCCESS (0.000s)
[160.077412] [035/131] (861s left) kms_chamelium_frames (dp-crc-fast)
[160.458597] Subtest dp-crc-fast: SKIP (0.000s)
[161.305064] [036/131] (860s left) kms_pm_backlight (fade-with-suspend)
[161.402903] Starting subtest: fade-with-suspend
[177.002023] Starting dynamic subtest: eDP-1
[179.675612] Dynamic subtest eDP-1: SUCCESS (2.647s)
[179.678054] Subtest fade-with-suspend: SUCCESS (3.937s)
[180.519032] [037/131] (855s left) syncobj_timeline (wait-all-snapshot)
[180.571150] Starting subtest: wait-all-snapshot
[180.652301] Subtest wait-all-snapshot: SUCCESS (0.081s)
[180.721479] [038/131] (855s left) gem_exec_reloc (basic-concurrent16)
[180.784747] Subtest basic-concurrent16: SKIP (0.000s)
[180.852231] [039/131] (855s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[180.939272] Starting subtest: fbc-psr-cursor-mmap-gtt
[180.941640] Starting dynamic subtest: eDP-1
[180.945957] Dynamic subtest eDP-1: SKIP (0.000s)
[180.950445] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[181.007877] [040/131] (855s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[181.111307] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[181.116040] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[181.223001] [041/131] (854s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[186.210361] Starting subtest: psr2-plane-move-sf-dmg-area
[186.212448] Starting dynamic subtest: pipe-A-eDP-1
[191.303180] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.075s)
[191.313474] Starting dynamic subtest: pipe-B-eDP-1
[196.609131] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.293s)
[196.611885] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.371s)
[197.475151] [042/131] (838s left) gem_exec_balancer (full-pulse)
[197.550837] Starting subtest: full-pulse
[202.046130] Subtest full-pulse: SUCCESS (4.492s)
[202.374537] [043/131] (833s left) gem_create (create-massive)
[202.427042] Starting subtest: create-massive
[202.429107] Subtest create-massive: SUCCESS (0.000s)
[202.607854] [044/131] (833s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[202.714763] Starting subtest: fbc-rgb101010-draw-blt
[206.281318] Subtest fbc-rgb101010-draw-blt: SUCCESS (3.567s)
[206.401780] [045/131] (830s left) syncobj_wait (wait-delayed-signal)
[206.464568] Starting subtest: wait-delayed-signal
[206.565492] Subtest wait-delayed-signal: SUCCESS (0.102s)
[206.633307] [046/131] (829s left) gem_gtt_cpu_tlb
[206.748963] [047/131] (829s left) gem_exec_fence (submit3)
[206.938890] Starting subtest: submit3
[206.944068] Subtest submit3: SKIP (0.000s)
[208.310556] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[208.313888] [048/131] (828s left) gem_workarounds (reset-context)
[208.387337] Starting subtest: reset-context
[208.564982] Subtest reset-context: SUCCESS (0.178s)
[208.686842] [049/131] (827s left) kms_lease (lease-unleased-crtc)
[208.786067] Starting subtest: lease-unleased-crtc
[208.788364] Starting dynamic subtest: pipe-A-eDP-1
[209.075518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[209.085478] Starting dynamic subtest: pipe-B-eDP-1
[209.869313] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.791s)
[209.880130] Starting dynamic subtest: pipe-C-eDP-1
[209.882331] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[209.891433] Starting dynamic subtest: pipe-D-eDP-1
[209.893672] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[209.895961] Subtest lease-unleased-crtc: SUCCESS (1.101s)
[210.232027] [050/131] (826s left) kms_flip (basic-flip-vs-wf_vblank)
[210.324136] Starting subtest: basic-flip-vs-wf_vblank
[210.326466] Starting dynamic subtest: A-eDP1
[212.273158] Dynamic subtest A-eDP1: SUCCESS (1.947s)
[212.283803] Starting dynamic subtest: B-eDP1
[214.203735] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[214.212458] Starting dynamic subtest: C-eDP1
[216.116285] Dynamic subtest C-eDP1: SUCCESS (1.911s)
[216.125669] Starting dynamic subtest: D-eDP1
[218.042357] Dynamic subtest D-eDP1: SUCCESS (1.924s)
[218.044869] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.717s)
[219.254518] [051/131] (817s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[219.362162] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[219.366656] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[219.420183] [052/131] (817s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[224.413830] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[224.416274] Starting dynamic subtest: pipe-A-eDP-1
[225.204831] Dynamic subtest pipe-A-eDP-1: SKIP (0.785s)
[225.214082] Starting dynamic subtest: pipe-B-eDP-1
[226.336002] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[226.340796] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.916s)
[227.511034] [053/131] (809s left) kms_psr (psr-cursor-mmap-gtt)
[227.615248] Starting subtest: psr-cursor-mmap-gtt
[227.617560] Starting dynamic subtest: eDP-1
[229.294466] Dynamic subtest eDP-1: SUCCESS (1.678s)
[229.296505] Subtest psr-cursor-mmap-gtt: SUCCESS (1.679s)
[230.161260] [054/131] (806s left) sw_sync (sync_merge)
[230.202127] Starting subtest: sync_merge
[230.204382] Subtest sync_merge: SUCCESS (0.000s)
[230.247046] [055/131] (806s left) gem_set_tiling_vs_pwrite
[230.361266] [056/131] (806s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[230.463783] Starting subtest: random-ccs-data-yf-tiled-ccs
[230.466163] Starting dynamic subtest: pipe-A-eDP-1
[230.491210] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.500022] Starting dynamic subtest: pipe-B-eDP-1
[230.523787] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.532358] Starting dynamic subtest: pipe-C-eDP-1
[230.556512] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[230.564871] Starting dynamic subtest: pipe-D-eDP-1
[230.589535] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[230.593642] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[232.618043] [057/131] (804s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[232.729285] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[237.261038] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.532s)
[237.382346] [058/131] (799s left) gem_create (create-clear)
[237.454633] Starting subtest: create-clear
[237.457737] Starting dynamic subtest: smem0
[271.371677] Dynamic subtest smem0: SUCCESS (33.895s)
[271.373984] Subtest create-clear: SUCCESS (33.897s)
[271.554385] [059/131] (765s left) gem_exec_balancer (bonded-dual)
[271.618090] Starting subtest: bonded-dual
[271.622652] Subtest bonded-dual: SKIP (0.000s)
[271.924489] [060/131] (765s left) gem_lmem_swapping (verify-random-ccs)
[271.968175] Subtest verify-random-ccs: SKIP (0.000s)
[272.009018] [061/131] (765s left) gem_exec_fence (syncobj-signal)
[272.509676] Starting subtest: syncobj-signal
[272.516803] Subtest syncobj-signal: SUCCESS (0.007s)
[274.350446] [062/131] (762s left) sriov_basic (bind-unbind-vf)
[274.404470] Starting subtest: bind-unbind-vf
[274.406875] Starting dynamic subtest: vf-1
[274.480160] Dynamic subtest vf-1: FAIL (0.005s)
[274.490551] Starting dynamic subtest: vf-2
[274.565838] Dynamic subtest vf-2: FAIL (0.003s)
[274.576160] Starting dynamic subtest: vf-3
[274.649294] Dynamic subtest vf-3: FAIL (0.003s)
[274.658907] Starting dynamic subtest: vf-4
[274.729241] Dynamic subtest vf-4: FAIL (0.003s)
[274.737534] Starting dynamic subtest: vf-5
[274.807121] Dynamic subtest vf-5: FAIL (0.003s)
[274.815555] Starting dynamic subtest: vf-6
[274.886044] Dynamic subtest vf-6: FAIL (0.003s)
[274.893808] Starting dynamic subtest: vf-7
[274.967352] Dynamic subtest vf-7: FAIL (0.003s)
[274.977595] Starting dynamic subtest: vf-random
[275.051530] Dynamic subtest vf-random: FAIL (0.004s)
[275.061516] Starting dynamic subtest: vf-last
[275.135331] Dynamic subtest vf-last: FAIL (0.498s)
[275.137472] Subtest bind-unbind-vf: FAIL (0.533s)
[275.169923] [063/131] (761s left) gem_workarounds (reset)
[275.233568] Starting subtest: reset
[275.414562] Subtest reset: SUCCESS (0.181s)
[275.546537] [064/131] (761s left) gem_ctx_shared (exec-single-timeline)
[275.616601] Starting subtest: exec-single-timeline
[275.618478] Starting dynamic subtest: rcs0
[276.716355] Dynamic subtest rcs0: SUCCESS (1.101s)
[276.728155] Starting dynamic subtest: bcs0
[277.804433] Dynamic subtest bcs0: SUCCESS (1.086s)
[277.820571] Starting dynamic subtest: vcs0
[278.892930] Dynamic subtest vcs0: SUCCESS (1.088s)
[278.905404] Starting dynamic subtest: vcs1
[279.981546] Dynamic subtest vcs1: SUCCESS (1.087s)
[279.993320] Starting dynamic subtest: vecs0
[281.068897] Dynamic subtest vecs0: SUCCESS (1.086s)
[281.080387] Starting dynamic subtest: ccs0
[282.157767] Dynamic subtest ccs0: SUCCESS (1.087s)
[282.160916] Subtest exec-single-timeline: SUCCESS (6.548s)
[282.344301] [065/131] (754s left) gem_exec_reloc (basic-write-gtt-active)
[282.417756] Subtest basic-write-gtt-active: SKIP (0.000s)
[282.502323] [066/131] (754s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[282.555825] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[282.560143] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[282.737931] [067/131] (754s left) gem_mmap_gtt (basic-write-read-distinct)
[282.788297] Subtest basic-write-read-distinct: SKIP (0.000s)
[282.852064] [068/131] (754s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[283.158392] Starting subtest: cursor-rapid-movement-max-size
[283.165367] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[283.317210] [069/131] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[283.421626] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[283.426048] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[283.534170] [070/131] (753s left) drm_fdinfo (virtual-busy-idle)
[283.575683] Starting subtest: virtual-busy-idle
[283.580281] Subtest virtual-busy-idle: SKIP (0.000s)
[283.645636] [071/131] (753s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[283.705217] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[283.756788] [072/131] (753s left) gem_exec_suspend (basic)
[283.811489] Starting subtest: basic
[283.813360] Starting dynamic subtest: smem
[285.264181] Dynamic subtest smem: SUCCESS (1.453s)
[285.267204] Subtest basic: SUCCESS (1.455s)
[285.440913] [073/131] (752s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[285.498095] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[285.502868] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[285.677542] [074/131] (751s left) kms_plane_scaling (2x-scaler-multi-pipe)
[285.778800] Starting subtest: 2x-scaler-multi-pipe
[285.783174] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[285.878235] [075/131] (751s left) kms_fbcon_fbt (fbc)
[285.943461] Starting subtest: fbc
[291.224086] Subtest fbc: SUCCESS (5.282s)
[291.321037] [076/131] (746s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[291.380563] Starting subtest: multi-wait-all-for-submit-unsubmitted
[291.484130] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[291.555063] [077/131] (746s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[291.663578] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[291.667871] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[291.739880] [078/131] (745s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[291.845094] Starting subtest: primary-4-tiled-reflect-x-180
[298.905465] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.061s)
[300.056977] [079/131] (737s left) kms_big_fb (linear-64bpp-rotate-0)
[300.157632] Starting subtest: linear-64bpp-rotate-0
[302.469700] Subtest linear-64bpp-rotate-0: SUCCESS (2.311s)
[302.740475] [080/131] (734s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[302.841301] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[306.423658] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (3.589s)
[306.567151] [081/131] (731s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[306.661878] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[306.666230] Starting dynamic subtest: pipe-A-eDP-1
[307.172524] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.508s)
[307.184354] Starting dynamic subtest: pipe-B-eDP-1
[307.204792] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[307.215878] Starting dynamic subtest: pipe-C-eDP-1
[307.235815] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[307.245677] Starting dynamic subtest: pipe-D-eDP-1
[307.264486] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[307.266331] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.524s)
[309.437907] [082/131] (728s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[309.489057] Starting subtest: multi-wait-all-for-submit-available-submitted
[309.491457] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[309.581352] [083/131] (728s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[309.686193] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[309.690133] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[309.776673] [084/131] (728s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[309.842251] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[309.910780] [085/131] (727s left) i915_pm_freq_api (freq-reset-multiple)
[309.968064] Starting subtest: freq-reset-multiple
[309.970467] Starting dynamic subtest: gt0
[319.756371] Dynamic subtest gt0: SUCCESS (9.785s)
[319.766571] Starting dynamic subtest: gt1
[328.332452] Dynamic subtest gt1: SUCCESS (8.576s)
[328.335083] Subtest freq-reset-multiple: SUCCESS (18.363s)
[328.405018] [086/131] (709s left) kms_content_protection (dp-mst-type-0)
[328.597323] Starting subtest: dp-mst-type-0
[328.602053] Subtest dp-mst-type-0: SKIP (0.000s)
[328.721878] [087/131] (709s left) syncobj_wait (wait-all-for-submit-complex)
[328.778492] Starting subtest: wait-all-for-submit-complex
[328.991526] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[329.061569] [088/131] (708s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[329.161293] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[329.163746] Starting dynamic subtest: pipe-A-default-mode
[329.448625] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[329.453311] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.283s)
[330.256457] [089/131] (707s left) gem_exec_parallel (contexts)
[330.322404] Starting subtest: contexts
[330.324814] Starting dynamic subtest: rcs0
[333.676767] Dynamic subtest rcs0: SUCCESS (3.352s)
[333.692473] Starting dynamic subtest: bcs0
[337.489962] Dynamic subtest bcs0: SUCCESS (3.811s)
[337.501860] Starting dynamic subtest: vcs0
[341.737725] Dynamic subtest vcs0: SUCCESS (4.246s)
[341.748814] Starting dynamic subtest: vcs1
[345.716802] Dynamic subtest vcs1: SUCCESS (3.977s)
[345.728046] Starting dynamic subtest: vecs0
[349.691226] Dynamic subtest vecs0: SUCCESS (3.973s)
[349.702486] Starting dynamic subtest: ccs0
[353.426884] Dynamic subtest ccs0: SUCCESS (3.733s)
[353.429477] Subtest contexts: SUCCESS (23.098s)
[353.608078] [090/131] (684s left) kms_atomic_transition (plane-all-transition-fencing)
[353.703471] Starting subtest: plane-all-transition-fencing
[353.705971] Starting dynamic subtest: pipe-A-eDP-1
[356.212038] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.506s)
[356.498701] Starting dynamic subtest: pipe-B-eDP-1
[359.695486] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.203s)
[359.970558] Subtest plane-all-transition-fencing: SUCCESS (6.265s)
[360.804462] [091/131] (677s left) perf (mi-rpc)
[360.916081] Starting subtest: mi-rpc
[360.920082] Subtest mi-rpc: SKIP (0.000s)
[360.952946] [092/131] (677s left) gem_exec_reloc (basic-gtt-read-active)
[361.018748] Subtest basic-gtt-read-active: SKIP (0.000s)
[361.093731] [093/131] (677s left) kms_psr (fbc-pr-dpms)
[361.192884] Starting subtest: fbc-pr-dpms
[361.196829] Subtest fbc-pr-dpms: SKIP (0.000s)
[361.263298] [094/131] (676s left) kms_flip (blocking-absolute-wf_vblank)
[361.361343] Starting subtest: blocking-absolute-wf_vblank
[361.363749] Starting dynamic subtest: A-eDP1
[370.161910] Dynamic subtest A-eDP1: SUCCESS (8.797s)
[370.177703] Starting dynamic subtest: B-eDP1
[378.895579] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[378.907775] Starting dynamic subtest: C-eDP1
[387.612121] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[387.623136] Starting dynamic subtest: D-eDP1
[396.335590] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[396.337824] Subtest blocking-absolute-wf_vblank: SUCCESS (34.968s)
[397.546675] [095/131] (640s left) kms_psr (pr-dpms)
[397.653876] Starting subtest: pr-dpms
[397.658101] Subtest pr-dpms: SKIP (0.000s)
[397.721303] [096/131] (640s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[397.832794] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[397.845978] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[397.916313] [097/131] (640s left) kms_color (legacy-gamma)
[398.012806] Starting subtest: legacy-gamma
[398.015217] Starting dynamic subtest: pipe-A-eDP-1
[398.722818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[398.732064] Starting dynamic subtest: pipe-B-eDP-1
[400.184460] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.459s)
[400.194003] Starting dynamic subtest: pipe-C-eDP-1
[401.525410] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.341s)
[401.534840] Starting dynamic subtest: pipe-D-eDP-1
[402.840837] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.316s)
[402.843234] Subtest legacy-gamma: SUCCESS (4.828s)
[403.659943] [098/131] (634s left) kms_display_modes (mst-extended-mode-negative)
[403.761377] Starting subtest: mst-extended-mode-negative
[403.765961] Subtest mst-extended-mode-negative: SKIP (0.000s)
[403.801921] [099/131] (634s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[403.908350] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[403.913016] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[405.003305] [100/131] (633s left) kms_psr (pr-suspend)
[405.111055] Starting subtest: pr-suspend
[405.115514] Subtest pr-suspend: SKIP (0.000s)
[405.180001] [101/131] (633s left) gem_eio (wait-wedge-immediate)
[405.406842] Starting subtest: wait-wedge-immediate
[407.322680] Subtest wait-wedge-immediate: SUCCESS (1.916s)
[407.466922] [102/131] (631s left) drm_fdinfo (memory-info-active)
[407.507442] Starting subtest: memory-info-active
[407.509758] Starting dynamic subtest: smem0
[410.665573] Dynamic subtest smem0: SUCCESS (3.157s)
[410.668555] Subtest memory-info-active: SUCCESS (3.158s)
[410.733391] [103/131] (627s left) gem_eio (wait-10ms)
[410.982522] Starting subtest: wait-10ms
[411.393619] Subtest wait-10ms: SUCCESS (0.412s)
[411.541891] [104/131] (627s left) gem_lmem_swapping (heavy-verify-random-ccs)
[411.588446] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[411.625636] [105/131] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[411.734512] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[411.738602] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[411.847067] [106/131] (626s left) syncobj_wait (single-wait-signaled)
[411.913656] Starting subtest: single-wait-signaled
[411.916076] Subtest single-wait-signaled: SUCCESS (0.000s)
[412.006472] [107/131] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[412.114805] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[416.644336] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.532s)
[416.787330] [108/131] (621s left) kms_properties (invalid-properties-atomic)
[416.890139] Starting subtest: invalid-properties-atomic
[417.135521] Subtest invalid-properties-atomic: SUCCESS (0.243s)
[417.206945] [109/131] (621s left) kms_cursor_crc (cursor-random-max-size)
[417.496538] Starting subtest: cursor-random-max-size
[417.503071] Subtest cursor-random-max-size: SKIP (0.000s)
[417.632996] [110/131] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[417.732609] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[422.929077] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.200s)
[423.083097] [111/131] (615s left) gem_mmap_wc (pf-nonblock)
[423.144769] Subtest pf-nonblock: SKIP (0.000s)
[423.195887] [112/131] (615s left) syncobj_timeline (invalid-query-bad-pad)
[423.255596] Starting subtest: invalid-query-bad-pad
[423.257926] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[423.366934] [113/131] (615s left) i915_suspend (basic-s3-without-i915)
[423.407056] Starting subtest: basic-s3-without-i915
[426.942745] Subtest basic-s3-without-i915: SKIP (3.531s)
[428.342798] [114/131] (610s left) kms_pm_rpm (modeset-lpsp-stress)
[430.396696] Starting subtest: modeset-lpsp-stress
[447.015662] Subtest modeset-lpsp-stress: SUCCESS (16.619s)
[447.109480] [115/131] (591s left) gem_exec_schedule (timeslicing)
[447.178742] Starting subtest: timeslicing
[447.180893] Starting dynamic subtest: rcs0
[447.194942] Dynamic subtest rcs0: SUCCESS (0.022s)
[447.209125] Starting dynamic subtest: bcs0
[447.216799] Dynamic subtest bcs0: SUCCESS (0.021s)
[447.225068] Starting dynamic subtest: vcs0
[447.237450] Dynamic subtest vcs0: SUCCESS (0.020s)
[447.245955] Starting dynamic subtest: vcs1
[447.259145] Dynamic subtest vcs1: SUCCESS (0.021s)
[447.267109] Starting dynamic subtest: vecs0
[447.280827] Dynamic subtest vecs0: SUCCESS (0.020s)
[447.288884] Starting dynamic subtest: ccs0
[447.301509] Dynamic subtest ccs0: SUCCESS (0.020s)
[447.303845] Subtest timeslicing: SUCCESS (0.129s)
[449.268909] [116/131] (589s left) gem_ctx_persistence (engines-mixed-process)
[449.336516] Starting subtest: engines-mixed-process
[449.339065] Starting dynamic subtest: rcs0
[451.233060] Dynamic subtest rcs0: SUCCESS (1.897s)
[451.242817] Starting dynamic subtest: bcs0
[453.285072] Dynamic subtest bcs0: SUCCESS (2.050s)
[453.294883] Starting dynamic subtest: vcs0
[455.259719] Dynamic subtest vcs0: SUCCESS (1.974s)
[455.270122] Starting dynamic subtest: vcs1
[457.259881] Dynamic subtest vcs1: SUCCESS (1.998s)
[457.270817] Starting dynamic subtest: vecs0
[459.242930] Dynamic subtest vecs0: SUCCESS (1.981s)
[459.253473] Starting dynamic subtest: ccs0
[461.274411] Dynamic subtest ccs0: SUCCESS (2.030s)
[461.276895] Subtest engines-mixed-process: SUCCESS (11.939s)
[461.350076] [117/131] (577s left) sysfs_heartbeat_interval (mixed)
[461.429896] Starting subtest: mixed
[461.432237] Starting dynamic subtest: vecs0
[466.708227] Dynamic subtest vecs0: SUCCESS (5.277s)
[466.719301] Starting dynamic subtest: ccs0
[471.938599] Dynamic subtest ccs0: SUCCESS (5.228s)
[471.949922] Starting dynamic subtest: vcs0
[477.193833] Dynamic subtest vcs0: SUCCESS (5.253s)
[477.204772] Starting dynamic subtest: bcs0
[482.412140] Dynamic subtest bcs0: SUCCESS (5.217s)
[482.422849] Starting dynamic subtest: rcs0
[487.575136] Dynamic subtest rcs0: SUCCESS (5.161s)
[487.586052] Starting dynamic subtest: vcs1
[492.778271] Dynamic subtest vcs1: SUCCESS (5.201s)
[492.780809] Subtest mixed: SUCCESS (31.346s)
[492.851729] [118/131] (546s left) kms_chamelium_frames (vga-frame-dump)
[493.244966] Subtest vga-frame-dump: SKIP (0.000s)
[494.064109] [119/131] (545s left) kms_frontbuffer_tracking (psr-slowdraw)
[494.166667] Starting subtest: psr-slowdraw
[517.205817] Subtest psr-slowdraw: SUCCESS (23.038s)
[517.346794] [120/131] (521s left) perf_pmu (pmu-read)
[517.391798] Starting subtest: pmu-read
[517.394111] Subtest pmu-read: SUCCESS (0.002s)
[517.488677] [121/131] (521s left) kms_pipe_crc_basic (suspend-read-crc)
[517.604286] Starting subtest: suspend-read-crc
[517.606584] Starting dynamic subtest: pipe-A-eDP-1
[534.915340] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.533s)
[534.925621] Starting dynamic subtest: pipe-B-eDP-1
[552.588099] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.730s)
[552.597237] Starting dynamic subtest: pipe-C-eDP-1
[570.562512] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.715s)
[570.572073] Starting dynamic subtest: pipe-D-eDP-1
[588.564521] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s)
[588.567025] Subtest suspend-read-crc: SUCCESS (10.747s)
[589.426542] [122/131] (510s left) kms_frontbuffer_tracking (fbc-suspend)
[589.528324] Starting subtest: fbc-suspend
[625.202519] Subtest fbc-suspend: SUCCESS (6.016s)
[625.314242] [123/131] (503s left) kms_atomic (plane-primary-legacy)
[625.420783] Starting subtest: plane-primary-legacy
[625.423305] Starting dynamic subtest: pipe-A-eDP-1
[625.892577] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.463s)
[625.895213] Subtest plane-primary-legacy: SUCCESS (0.464s)
[626.689206] [124/131] (502s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[626.810098] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[630.620993] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.788s)
[630.765004] [125/131] (498s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[630.863118] Starting subtest: psr-1p-primscrn-cur-indfb-move
[635.967116] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (5.082s)
[636.133948] [126/131] (493s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-out-visible-area)
[636.604212] Subtest fbc-dirty-rectangle-out-visible-area: SKIP (0.000s)
[636.657254] [FACT kms_fbc_dirty_rect (fbc-dirty-rectangle-out-visible-area)] new: kernel.kmod_is_loaded.xe: true
[636.661260] [127/131] (492s left) gem_userptr_blits (nohangcheck)
[636.741513] Starting subtest: nohangcheck
[636.997788] Subtest nohangcheck: SUCCESS (0.253s)
[637.122060] [128/131] (492s left) kms_flip (2x-wf_vblank-ts-check)
[637.230614] Starting subtest: 2x-wf_vblank-ts-check
[637.241996] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[637.318749] [129/131] (492s left) core_setmaster (master-drop-set-root)
[639.213510] Starting subtest: master-drop-set-root
[639.225779] Subtest master-drop-set-root: SUCCESS (0.012s)
[639.266645] [FACT core_setmaster (master-drop-set-root)] new: kernel.kmod_is_loaded.amdgpu: true
[639.271049] [130/131] (490s left) gem_exec_schedule (preemptive-hang)
[639.449166] Starting subtest: preemptive-hang
[639.452232] Starting dynamic subtest: rcs0
[649.033217] Dynamic subtest rcs0: SUCCESS (9.567s)
[649.045609] Starting dynamic subtest: bcs0
[658.055751] Dynamic subtest bcs0: SUCCESS (9.024s)
[658.067295] Starting dynamic subtest: vcs0
[667.016879] Dynamic subtest vcs0: SUCCESS (8.962s)
[667.028372] Starting dynamic subtest: vcs1
[676.041502] Dynamic subtest vcs1: SUCCESS (9.027s)
[676.053292] Starting dynamic subtest: vecs0
[685.062752] Dynamic subtest vecs0: SUCCESS (9.018s)
[685.073908] Starting dynamic subtest: ccs0
[694.027053] Dynamic subtest ccs0: SUCCESS (8.960s)
[694.029611] Subtest preemptive-hang: SUCCESS (54.562s)
[694.280843] [131/131] (435s left) prime_vgem (basic-read)
[694.361537] Starting subtest: basic-read
[694.370232] Subtest basic-read: SKIP (0.009s)
[694.492566] Closing watchdogs
Done.