[58.926921] Initializing watchdogs
[58.926968]   /dev/watchdog0
[58.941265] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.945334] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.947515] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.950923] [001/129] (960s left) gem_exec_balancer (individual)
[59.069096] Starting subtest: individual
[60.891590] Subtest individual: SUCCESS (1.804s)
[61.153182] [002/129] (958s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[61.267839] Starting subtest: fbc-rgb565-draw-mmap-gtt
[61.272300] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[61.367596] [003/129] (958s left) kms_vblank (query-forked-busy)
[61.467071] Starting subtest: query-forked-busy
[61.469527] Starting dynamic subtest: pipe-A-eDP-1
[63.392994] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.909s)
[63.406298] Starting dynamic subtest: pipe-D-eDP-1
[65.907663] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.503s)
[65.910233] Subtest query-forked-busy: SUCCESS (4.415s)
[66.702330] [004/129] (952s left) syncobj_basic (test-valid-cycle)
[66.754212] Starting subtest: test-valid-cycle
[66.756281] Subtest test-valid-cycle: SUCCESS (0.000s)
[66.836996] [005/129] (952s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[66.934716] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[66.938750] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[67.031601] [006/129] (952s left) gen3_mixed_blits
[67.150913] [007/129] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[67.267681] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[71.581437] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.306s)
[71.810170] [008/129] (947s left) gem_lmem_swapping (heavy-random)
[71.874874] Subtest heavy-random: SKIP (0.000s)
[71.913889] [009/129] (947s left) kms_cursor_crc (cursor-sliding-256x256)
[72.256575] Starting subtest: cursor-sliding-256x256
[72.259280] Starting dynamic subtest: pipe-A-eDP-1
[75.831331] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.566s)
[75.858151] Starting dynamic subtest: pipe-D-eDP-1
[80.046586] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.188s)
[80.048539] Subtest cursor-sliding-256x256: SUCCESS (7.780s)
[80.836672] [010/129] (938s left) gem_mmap_wc (bad-size)
[80.907159] Subtest bad-size: SKIP (0.000s)
[80.959330] [011/129] (938s left) kms_lease (page-flip-implicit-plane)
[81.064064] Starting subtest: page-flip-implicit-plane
[81.066411] Starting dynamic subtest: pipe-A-eDP-1
[81.542938] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.477s)
[81.551548] Starting dynamic subtest: pipe-B-eDP-1
[82.672953] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s)
[82.680570] Starting dynamic subtest: pipe-C-eDP-1
[83.783114] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[83.791541] Starting dynamic subtest: pipe-D-eDP-1
[84.914084] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[84.916437] Subtest page-flip-implicit-plane: SUCCESS (3.847s)
[85.740599] [012/129] (934s left) kms_dp_link_training (uhbr-sst)
[85.841131] Starting subtest: uhbr-sst
[85.850376] Subtest uhbr-sst: SKIP (0.000s)
[85.906212] [013/129] (934s left) kms_addfb_basic (invalid-get-prop)
[85.963790] Starting subtest: invalid-get-prop
[85.966089] Subtest invalid-get-prop: SUCCESS (0.000s)
[86.092188] [014/129] (933s left) api_intel_bb (blit-noreloc-keep-cache)
[86.144344] Starting subtest: blit-noreloc-keep-cache
[86.151933] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[86.272743] [015/129] (933s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[86.372333] Starting subtest: fbc-psr-cursor-mmap-gtt
[86.374658] Starting dynamic subtest: eDP-1
[86.378850] Dynamic subtest eDP-1: SKIP (0.000s)
[86.383106] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[86.438528] [016/129] (933s left) gem_userptr_blits (unsync-unmap-cycles)
[86.504253] Subtest unsync-unmap-cycles: SKIP (0.000s)
[86.629809] [017/129] (933s left) gem_softpin (noreloc-s3)
[86.690065] Starting subtest: noreloc-S3
[106.776607] Subtest noreloc-S3: SUCCESS (5.408s)
[106.943784] [018/129] (927s left) i915_pm_rps (reset)
[107.016476] Starting subtest: reset
[107.111708] Subtest reset: FAIL (0.012s)
[107.186385] [019/129] (927s left) perf_pmu (busy-no-semaphores)
[107.231578] Starting subtest: busy-no-semaphores
[107.234201] Starting dynamic subtest: rcs0
[107.803268] Dynamic subtest rcs0: SUCCESS (0.562s)
[107.821099] Starting dynamic subtest: bcs0
[108.365456] Dynamic subtest bcs0: SUCCESS (0.553s)
[108.374952] Starting dynamic subtest: vcs0
[108.923746] Dynamic subtest vcs0: SUCCESS (0.550s)
[108.933236] Starting dynamic subtest: vcs1
[110.070724] Dynamic subtest vcs1: SUCCESS (1.134s)
[110.080084] Starting dynamic subtest: vecs0
[112.056398] Dynamic subtest vecs0: SUCCESS (1.965s)
[112.066048] Starting dynamic subtest: ccs0
[114.039320] Dynamic subtest ccs0: SUCCESS (1.968s)
[114.042109] Subtest busy-no-semaphores: SUCCESS (6.737s)
[114.164219] [020/129] (920s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[114.273226] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[114.275809] Starting dynamic subtest: pipe-A-eDP-1
[115.143701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.852s)
[115.152888] Starting dynamic subtest: pipe-B-eDP-1
[116.697516] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.546s)
[116.706904] Starting dynamic subtest: pipe-C-eDP-1
[118.213682] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.510s)
[118.221724] Starting dynamic subtest: pipe-D-eDP-1
[119.655919] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.436s)
[119.658461] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.347s)
[120.827374] [021/129] (914s left) gem_mmap_gtt (close-race)
[120.904176] Subtest close-race: SKIP (0.000s)
[120.959108] [022/129] (914s left) kms_flip (dpms-vs-vblank-race-interruptible)
[121.056586] Starting subtest: dpms-vs-vblank-race-interruptible
[121.059061] Starting dynamic subtest: A-eDP1
[126.013736] Dynamic subtest A-eDP1: SUCCESS (4.940s)
[126.023050] Starting dynamic subtest: B-eDP1
[130.611654] Dynamic subtest B-eDP1: SUCCESS (4.594s)
[130.620696] Starting dynamic subtest: C-eDP1
[135.112597] Dynamic subtest C-eDP1: SUCCESS (4.497s)
[135.120518] Starting dynamic subtest: D-eDP1
[139.701499] Dynamic subtest D-eDP1: SUCCESS (4.588s)
[139.704038] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.625s)
[140.572132] [023/129] (894s left) gem_ctx_persistence (legacy-engines-queued)
[140.644843] Starting subtest: legacy-engines-queued
[140.647780] Starting dynamic subtest: render
[140.755258] Dynamic subtest render: SUCCESS (0.110s)
[140.766575] Starting dynamic subtest: bsd1
[142.478762] Dynamic subtest bsd1: SUCCESS (1.720s)
[142.489925] Starting dynamic subtest: bsd2
[144.461561] Dynamic subtest bsd2: SUCCESS (1.979s)
[144.471944] Starting dynamic subtest: blt
[144.544202] Dynamic subtest blt: SUCCESS (0.082s)
[144.554555] Starting dynamic subtest: vebox
[146.510343] Dynamic subtest vebox: SUCCESS (1.963s)
[146.513464] Subtest legacy-engines-queued: SUCCESS (5.864s)
[146.585118] [024/129] (888s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[146.690161] Starting subtest: primary-x-tiled-reflect-x-0
[154.033219] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.339s)
[155.235713] [025/129] (879s left) syncobj_timeline (multi-wait-available-submitted)
[155.293456] Starting subtest: multi-wait-available-submitted
[155.296145] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[155.378422] [026/129] (879s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[155.479829] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[155.484681] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[155.597848] [027/129] (879s left) gen9_exec_parse (basic-rejected-ctx-param)
[155.656605] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[155.722462] [028/129] (879s left) gem_eio (in-flight-immediate)
[155.952780] Starting subtest: in-flight-immediate
[164.602148] Subtest in-flight-immediate: SUCCESS (8.645s)
[164.755706] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[164.759307] [029/129] (870s left) gem_ctx_persistence (hostile)
[164.825041] Starting subtest: hostile
[174.351233] Subtest hostile: SUCCESS (9.518s)
[174.483452] [030/129] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[174.593577] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[174.598685] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[174.694318] [031/129] (860s left) dumb_buffer (map-valid)
[174.762926] Starting subtest: map-valid
[174.765655] Subtest map-valid: SUCCESS (0.000s)
[174.873077] [032/129] (860s left) gem_exec_whisper (basic-fds-forked-all)
[174.937932] Starting subtest: basic-fds-forked-all
[198.640319] Subtest basic-fds-forked-all: SUCCESS (23.691s)
[198.823185] [033/129] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[198.937200] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[198.942328] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[199.055643] [034/129] (836s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[199.159622] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[199.164541] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[199.238006] [035/129] (836s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[199.342427] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[203.918900] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.584s)
[204.037215] [036/129] (831s left) sriov_basic (enable-vfs-autoprobe-off)
[204.100890] Starting subtest: enable-vfs-autoprobe-off
[204.103457] Starting dynamic subtest: numvfs-1
[204.192903] Dynamic subtest numvfs-1: FAIL (0.005s)
[204.203311] Starting dynamic subtest: numvfs-2
[204.293928] Dynamic subtest numvfs-2: FAIL (0.003s)
[204.303827] Starting dynamic subtest: numvfs-3
[204.390738] Dynamic subtest numvfs-3: FAIL (0.003s)
[204.400409] Starting dynamic subtest: numvfs-4
[204.487849] Dynamic subtest numvfs-4: FAIL (0.003s)
[204.496660] Starting dynamic subtest: numvfs-5
[204.583804] Dynamic subtest numvfs-5: FAIL (0.003s)
[204.593132] Starting dynamic subtest: numvfs-6
[204.679879] Dynamic subtest numvfs-6: FAIL (0.003s)
[204.689389] Starting dynamic subtest: numvfs-7
[204.766555] Dynamic subtest numvfs-7: FAIL (0.004s)
[204.774465] Starting dynamic subtest: numvfs-random
[204.857515] Dynamic subtest numvfs-random: FAIL (0.003s)
[204.867654] Starting dynamic subtest: numvfs-all
[204.929597] Dynamic subtest numvfs-all: FAIL (0.598s)
[204.931324] Subtest enable-vfs-autoprobe-off: FAIL (0.630s)
[204.960189] [037/129] (830s left) gem_exec_flush (basic-uc-ro-default)
[205.016508] Starting subtest: basic-uc-ro-default
[210.488711] Subtest basic-uc-ro-default: SUCCESS (5.473s)
[210.671172] [038/129] (824s left) kms_feature_discovery (display)
[210.780070] Starting subtest: display
[210.782916] Subtest display: SUCCESS (0.000s)
[210.848404] [039/129] (824s left) gem_exec_params (invalid-ring)
[210.912292] Starting subtest: invalid-ring
[210.914926] Subtest invalid-ring: SUCCESS (0.000s)
[211.025376] [040/129] (824s left) kms_plane_multiple (tiling-4)
[211.124309] Starting subtest: tiling-4
[211.126697] Starting dynamic subtest: pipe-A-eDP-1
[214.798915] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.675s)
[214.808144] Starting dynamic subtest: pipe-B-eDP-1
[219.218598] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.418s)
[219.227595] Starting dynamic subtest: pipe-C-eDP-1
[223.514529] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.295s)
[223.523696] Starting dynamic subtest: pipe-D-eDP-1
[227.823209] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.305s)
[227.826077] Subtest tiling-4: SUCCESS (16.696s)
[228.641188] [041/129] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[228.752835] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[228.757963] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[228.838172] [042/129] (806s left) kms_content_protection (uevent)
[229.013695] Starting subtest: uevent
[232.360378] Subtest uevent: SKIP (3.343s)
[233.531445] [043/129] (802s left) gem_exec_schedule (preempt-hang)
[233.718679] Starting subtest: preempt-hang
[233.721839] Starting dynamic subtest: rcs0
[233.958031] Dynamic subtest rcs0: SUCCESS (0.236s)
[233.967716] Starting dynamic subtest: bcs0
[234.188916] Dynamic subtest bcs0: SUCCESS (0.230s)
[234.197848] Starting dynamic subtest: vcs0
[234.418535] Dynamic subtest vcs0: SUCCESS (0.229s)
[234.428106] Starting dynamic subtest: vcs1
[234.642921] Dynamic subtest vcs1: SUCCESS (0.224s)
[234.651515] Starting dynamic subtest: vecs0
[234.868065] Dynamic subtest vecs0: SUCCESS (0.225s)
[234.877333] Starting dynamic subtest: ccs0
[235.095672] Dynamic subtest ccs0: SUCCESS (0.226s)
[235.098303] Subtest preempt-hang: SUCCESS (1.375s)
[235.596021] [044/129] (800s left) kms_psr (pr-sprite-mmap-cpu)
[235.694709] Starting subtest: pr-sprite-mmap-cpu
[235.699670] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[235.761920] [045/129] (800s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[235.822721] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[235.932220] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[236.007391] [046/129] (799s left) kms_flip (blocking-wf_vblank)
[236.099734] Starting subtest: blocking-wf_vblank
[236.102665] Starting dynamic subtest: A-eDP1
[245.078742] Dynamic subtest A-eDP1: SUCCESS (8.978s)
[245.088484] Starting dynamic subtest: B-eDP1
[254.008589] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[254.018962] Starting dynamic subtest: C-eDP1
[262.926728] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[262.936441] Starting dynamic subtest: D-eDP1
[271.851481] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[271.854121] Subtest blocking-wf_vblank: SUCCESS (35.749s)
[273.064571] [047/129] (762s left) gem_workarounds (suspend-resume-context)
[273.141401] Starting subtest: suspend-resume-context
[288.559098] Subtest suspend-resume-context: SUCCESS (1.161s)
[289.713223] [048/129] (761s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[289.814618] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[289.816962] Starting dynamic subtest: pipe-A-eDP-1
[289.840556] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[289.851554] Starting dynamic subtest: pipe-B-eDP-1
[289.873522] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[289.881923] Starting dynamic subtest: pipe-C-eDP-1
[289.904151] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[289.913154] Starting dynamic subtest: pipe-D-eDP-1
[289.937245] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[289.941976] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[292.027195] [049/129] (759s left) prime_self_import (basic-llseek-bad)
[292.072381] Starting subtest: basic-llseek-bad
[292.101224] Subtest basic-llseek-bad: SUCCESS (0.026s)
[292.195394] [050/129] (759s left) kms_plane_alpha_blend (alpha-opaque-fb)
[292.288300] Starting subtest: alpha-opaque-fb
[292.729657] Starting dynamic subtest: pipe-A-eDP-1
[293.386661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.642s)
[293.402880] Starting dynamic subtest: pipe-D-eDP-1
[294.692515] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.289s)
[294.694841] Subtest alpha-opaque-fb: SUCCESS (2.366s)
[295.541078] [051/129] (755s left) perf (non-sampling-read-error)
[295.659287] Starting subtest: non-sampling-read-error
[295.676535] Subtest non-sampling-read-error: SUCCESS (0.017s)
[295.728880] [052/129] (755s left) syncobj_wait (multi-wait-all-signaled)
[295.785284] Starting subtest: multi-wait-all-signaled
[295.787664] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[295.882668] [053/129] (755s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[295.984390] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[295.988854] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[296.104887] [054/129] (755s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[296.172508] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[296.258963] [055/129] (755s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[296.372423] Starting subtest: 2x-long-cursor-vs-flip-atomic
[296.376900] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[296.468799] [056/129] (755s left) gem_exec_fence (syncobj-import)
[296.934351] Starting subtest: syncobj-import
[296.940238] Subtest syncobj-import: SUCCESS (0.005s)
[298.863944] [057/129] (752s left) sysfs_preempt_timeout (idempotent)
[298.923205] Starting subtest: idempotent
[298.925692] Starting dynamic subtest: vecs0
[298.928109] Dynamic subtest vecs0: SUCCESS (0.000s)
[298.938729] Starting dynamic subtest: ccs0
[298.941041] Dynamic subtest ccs0: SUCCESS (0.000s)
[298.949521] Starting dynamic subtest: vcs0
[298.951441] Dynamic subtest vcs0: SUCCESS (0.000s)
[298.967323] Starting dynamic subtest: bcs0
[298.969595] Dynamic subtest bcs0: SUCCESS (0.000s)
[298.977953] Starting dynamic subtest: rcs0
[298.980213] Dynamic subtest rcs0: SUCCESS (0.000s)
[298.988613] Starting dynamic subtest: vcs1
[298.990856] Dynamic subtest vcs1: SUCCESS (0.000s)
[298.993131] Subtest idempotent: SUCCESS (0.006s)
[299.044659] [058/129] (752s left) kms_joiner (invalid-modeset-force-big-joiner)
[299.160427] Starting subtest: invalid-modeset-force-big-joiner
[299.162740] Starting dynamic subtest: big_joiner_on_last_pipe
[299.502926] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.346s)
[299.504939] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.346s)
[300.309781] [059/129] (751s left) syncobj_wait (multi-wait-signaled)
[300.372564] Starting subtest: multi-wait-signaled
[300.374829] Subtest multi-wait-signaled: SUCCESS (0.000s)
[300.483754] [060/129] (751s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[300.587730] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[300.590074] Starting dynamic subtest: pipe-A-eDP-1
[300.612533] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[300.621745] Starting dynamic subtest: pipe-B-eDP-1
[300.643474] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[300.651768] Starting dynamic subtest: pipe-C-eDP-1
[300.673619] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[300.681675] Starting dynamic subtest: pipe-D-eDP-1
[300.703165] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[300.707706] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[302.783574] [061/129] (749s left) gem_pxp (create-protected-buffer)
[302.904087] Starting subtest: create-protected-buffer
[302.906524] Subtest create-protected-buffer: SUCCESS (0.000s)
[303.004439] [062/129] (748s left) kms_busy (extended-modeset-hang-oldfb)
[303.104598] Starting subtest: extended-modeset-hang-oldfb
[303.106933] Starting dynamic subtest: pipe-A
[314.978954] Dynamic subtest pipe-A: SUCCESS (11.841s)
[314.987501] Starting dynamic subtest: pipe-D
[327.340320] Dynamic subtest pipe-D: SUCCESS (12.352s)
[327.342611] Subtest extended-modeset-hang-oldfb: SUCCESS (24.197s)
[328.126253] [063/129] (723s left) kms_chamelium_audio (hdmi-audio-edid)
[328.516116] Subtest hdmi-audio-edid: SKIP (0.000s)
[329.328100] [064/129] (722s left) drm_read (invalid-buffer)
[329.500520] Starting subtest: invalid-buffer
[329.503015] Subtest invalid-buffer: SUCCESS (0.000s)
[329.646563] [065/129] (722s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[329.701592] Starting subtest: etime-single-wait-all-available-unsubmitted
[329.804188] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s)
[329.874587] [066/129] (722s left) prime_mmap_coherency (write)
[329.930984] Starting subtest: write
[335.310033] Subtest write: SUCCESS (5.377s)
[335.718032] [067/129] (716s left) gem_exec_reloc (basic-wc-read-noreloc)
[335.789494] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[335.868904] [068/129] (716s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[335.967182] Starting subtest: flip-primary-invalidate-overlay
[348.509500] Subtest flip-primary-invalidate-overlay: SUCCESS (12.541s)
[348.834033] [069/129] (703s left) kms_vblank (wait-forked-busy-hang)
[348.929582] Starting subtest: wait-forked-busy-hang
[348.931960] Starting dynamic subtest: pipe-A-eDP-1
[375.506509] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.564s)
[375.522008] Starting dynamic subtest: pipe-D-eDP-1
[400.539220] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.031s)
[400.541602] Subtest wait-forked-busy-hang: SUCCESS (51.599s)
[401.406981] [070/129] (650s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[401.514935] Starting subtest: yf-tiled-64bpp-rotate-90
[401.519158] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[401.621223] [071/129] (650s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[401.731946] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[401.736401] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[401.846434] [072/129] (650s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[401.956909] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[401.961004] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[402.045763] [073/129] (650s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[402.140853] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[403.397418] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.259s)
[403.641399] [074/129] (648s left) kms_hdr (bpc-switch)
[403.737546] Starting subtest: bpc-switch
[404.778834] Starting dynamic subtest: pipe-A-eDP-1
[408.160642] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.382s)
[408.162949] Subtest bpc-switch: SUCCESS (4.422s)
[408.289498] [075/129] (644s left) prime_vgem (basic-fence-flip)
[408.387891] Starting subtest: basic-fence-flip
[408.709615] Subtest basic-fence-flip: SUCCESS (0.323s)
[408.829958] [076/129] (643s left) kms_chamelium_color (ctm-limited-range)
[408.938499] Subtest ctm-limited-range: SKIP (0.000s)
[408.979274] [077/129] (643s left) i915_query (hwconfig_table)
[409.034795] Starting subtest: hwconfig_table
[409.337216] Subtest hwconfig_table: SUCCESS (0.001s)
[409.370282] [078/129] (643s left) gem_wait (invalid-buf)
[409.418270] Starting subtest: invalid-buf
[409.420601] Subtest invalid-buf: SUCCESS (0.000s)
[409.657156] [079/129] (642s left) gem_ctx_exec (basic-nohangcheck)
[409.713170] Starting subtest: basic-nohangcheck
[409.961377] Subtest basic-nohangcheck: SUCCESS (0.248s)
[410.077572] [080/129] (642s left) gem_exec_params (rs-invalid)
[410.140912] Starting subtest: rs-invalid
[410.146579] Subtest rs-invalid: SUCCESS (0.003s)
[410.269503] [081/129] (642s left) gem_exec_fence (concurrent)
[410.459661] Starting subtest: concurrent
[410.464590] Subtest concurrent: SKIP (0.000s)
[411.901660] [082/129] (640s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[412.020825] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[412.025083] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[412.136542] [083/129] (640s left) gem_mmap_wc (read-write)
[412.195225] Subtest read-write: SKIP (0.000s)
[412.252790] [084/129] (640s left) kms_atomic (plane-cursor-legacy)
[412.359606] Starting subtest: plane-cursor-legacy
[412.361890] Starting dynamic subtest: pipe-A-eDP-1
[412.754030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.393s)
[412.756434] Subtest plane-cursor-legacy: SUCCESS (0.394s)
[413.536157] [085/129] (639s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[413.643487] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[413.647721] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[413.747336] [086/129] (639s left) core_setmaster (master-drop-set-user)
[415.803854] Starting subtest: master-drop-set-user
[415.817166] Subtest master-drop-set-user: SUCCESS (0.014s)
[415.845594] [FACT core_setmaster (master-drop-set-user)] new: kernel.kmod_is_loaded.amdgpu: true
[415.846273] [FACT core_setmaster (master-drop-set-user)] new: kernel.kmod_is_loaded.xe: true
[415.849468] [087/129] (637s left) gem_wait (write-wait)
[415.919358] Starting subtest: write-wait
[415.921903] Starting dynamic subtest: all-engines
[417.039677] Dynamic subtest all-engines: SUCCESS (1.119s)
[417.054696] Starting dynamic subtest: rcs0
[418.095083] Dynamic subtest rcs0: SUCCESS (1.054s)
[418.111562] Starting dynamic subtest: bcs0
[419.149697] Dynamic subtest bcs0: SUCCESS (1.053s)
[419.164752] Starting dynamic subtest: vcs0
[420.201958] Dynamic subtest vcs0: SUCCESS (1.050s)
[420.217402] Starting dynamic subtest: vcs1
[421.253658] Dynamic subtest vcs1: SUCCESS (1.050s)
[421.269760] Starting dynamic subtest: vecs0
[422.306692] Dynamic subtest vecs0: SUCCESS (1.051s)
[422.321914] Starting dynamic subtest: ccs0
[423.363183] Dynamic subtest ccs0: SUCCESS (1.054s)
[423.366304] Subtest write-wait: SUCCESS (7.444s)
[423.563306] [088/129] (629s left) syncobj_wait (multi-wait-all-submitted)
[423.620606] Starting subtest: multi-wait-all-submitted
[423.722527] Subtest multi-wait-all-submitted: SUCCESS (0.101s)
[423.796543] [089/129] (629s left) gem_ctx_sseu (invalid-args)
[423.846755] Subtest invalid-args: SKIP (0.000s)
[423.925573] [090/129] (629s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[424.022703] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[424.025005] Starting dynamic subtest: pipe-A-default-mode
[424.309326] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[424.313973] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.284s)
[425.154881] [091/129] (627s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[425.254713] Starting subtest: x-tiled-addfb-size-offset-overflow
[425.256569] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[425.340420] [092/129] (627s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[425.406205] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[425.507404] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[425.585563] [093/129] (627s left) drm_fdinfo (memory-info-idle)
[425.626098] Starting subtest: memory-info-idle
[425.628276] Starting dynamic subtest: smem0
[425.710322] Dynamic subtest smem0: SUCCESS (0.085s)
[425.712765] Subtest memory-info-idle: SUCCESS (0.086s)
[425.779182] [094/129] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[425.881841] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[431.156834] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.277s)
[431.277629] [095/129] (621s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20)
[431.382533] Starting subtest: planes-downscale-factor-0-25-upscale-20x20
[431.385348] Starting dynamic subtest: pipe-A
[431.401434] Dynamic subtest pipe-A: SKIP (0.012s)
[431.412812] Starting dynamic subtest: pipe-B
[431.425003] Dynamic subtest pipe-B: SKIP (0.025s)
[431.433627] Starting dynamic subtest: pipe-C
[431.454000] Dynamic subtest pipe-C: SKIP (0.027s)
[431.465507] Starting dynamic subtest: pipe-D
[431.481055] Dynamic subtest pipe-D: SKIP (0.028s)
[431.485394] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.094s)
[431.589921] [096/129] (621s left) gem_partial_pwrite_pread (reads-snoop)
[431.651553] Subtest reads-snoop: SKIP (0.000s)
[431.728803] [097/129] (621s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[431.853936] Starting subtest: flip-vs-cursor-atomic-transitions
[439.211328] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.354s)
[440.032848] [098/129] (613s left) gem_exec_reloc (basic-gtt-read-active)
[440.087336] Subtest basic-gtt-read-active: SKIP (0.000s)
[440.164887] [099/129] (613s left) prime_self_import (basic-with_one_bo)
[440.202346] Starting subtest: basic-with_one_bo
[440.217494] Subtest basic-with_one_bo: SUCCESS (0.016s)
[440.312970] [100/129] (613s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[440.408656] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[440.410984] Starting dynamic subtest: pipe-A-default-mode
[440.694647] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[440.699120] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.283s)
[441.557883] [101/129] (611s left) syncobj_timeline (wait-all-interrupted)
[441.624773] Starting subtest: wait-all-interrupted
[441.731270] Subtest wait-all-interrupted: SUCCESS (0.105s)
[441.808956] [102/129] (611s left) kms_big_fb (linear-8bpp-rotate-90)
[441.918699] Starting subtest: linear-8bpp-rotate-90
[441.939697] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[442.065772] [103/129] (611s left) perf_pmu (init-wait)
[442.109827] Starting subtest: init-wait
[442.112133] Starting dynamic subtest: rcs0
[442.114472] Dynamic subtest rcs0: SUCCESS (0.001s)
[442.124520] Starting dynamic subtest: bcs0
[442.126612] Dynamic subtest bcs0: SUCCESS (0.001s)
[442.135063] Starting dynamic subtest: vcs0
[442.137240] Dynamic subtest vcs0: SUCCESS (0.001s)
[442.145803] Starting dynamic subtest: vcs1
[442.148055] Dynamic subtest vcs1: SUCCESS (0.001s)
[442.156716] Starting dynamic subtest: vecs0
[442.158956] Dynamic subtest vecs0: SUCCESS (0.001s)
[442.167194] Starting dynamic subtest: ccs0
[442.169499] Dynamic subtest ccs0: SUCCESS (0.001s)
[442.171698] Subtest init-wait: SUCCESS (0.007s)
[442.234628] [104/129] (611s left) kms_chamelium_hpd (vga-hpd)
[442.624809] Subtest vga-hpd: SKIP (0.000s)
[443.464845] [105/129] (610s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[443.561884] Starting subtest: fbc-pr-sprite-mmap-cpu
[443.566586] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[443.631007] [106/129] (609s left) i915_module_load (resize-bar)
[443.669342] Starting subtest: resize-bar
[443.678624] Subtest resize-bar: SKIP (0.006s)
[443.716772] [107/129] (609s left) kms_pm_rpm (i2c)
[445.958843] Starting subtest: i2c
[451.300187] Subtest i2c: SUCCESS (5.340s)
[451.385132] [108/129] (602s left) syncobj_wait (multi-wait-for-submit-submitted)
[451.445995] Starting subtest: multi-wait-for-submit-submitted
[451.545956] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[451.623158] [109/129] (602s left) kms_psr (psr-sprite-blt)
[451.728188] Starting subtest: psr-sprite-blt
[451.730553] Starting dynamic subtest: eDP-1
[453.498816] Dynamic subtest eDP-1: SUCCESS (1.772s)
[453.501263] Subtest psr-sprite-blt: SUCCESS (1.772s)
[454.327317] [110/129] (599s left) syncobj_timeline (multi-wait-submitted-signaled)
[454.378587] Starting subtest: multi-wait-submitted-signaled
[454.380767] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[454.481511] [111/129] (599s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[454.879473] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[455.640557] [112/129] (598s left) kms_psr (fbc-psr-primary-page-flip)
[455.744285] Starting subtest: fbc-psr-primary-page-flip
[455.746303] Starting dynamic subtest: eDP-1
[455.750302] Dynamic subtest eDP-1: SKIP (0.000s)
[455.754216] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[455.813683] [113/129] (598s left) gem_userptr_blits (forbidden-operations)
[455.887551] Starting subtest: forbidden-operations
[455.891647] Subtest forbidden-operations: SKIP (0.000s)
[456.025400] [114/129] (597s left) gem_userptr_blits (mmap-offset-banned)
[456.092829] Starting subtest: mmap-offset-banned
[456.095166] Starting dynamic subtest: wb
[456.097063] Dynamic subtest wb: SUCCESS (0.000s)
[456.106675] Starting dynamic subtest: wc
[456.108909] Dynamic subtest wc: SUCCESS (0.000s)
[456.117435] Starting dynamic subtest: uc
[456.119628] Dynamic subtest uc: SUCCESS (0.000s)
[456.121768] Subtest mmap-offset-banned: SUCCESS (0.002s)
[456.221593] [115/129] (597s left) gem_softpin (evict-prime)
[456.273513] Starting subtest: evict-prime
[456.275729] Starting dynamic subtest: rcs0
[457.467490] Dynamic subtest rcs0: SUCCESS (1.193s)
[457.479171] Starting dynamic subtest: bcs0
[458.601431] Dynamic subtest bcs0: SUCCESS (1.132s)
[458.612805] Starting dynamic subtest: vcs0
[459.773965] Dynamic subtest vcs0: SUCCESS (1.169s)
[459.786306] Starting dynamic subtest: vcs1
[461.822682] Dynamic subtest vcs1: SUCCESS (2.045s)
[461.835097] Starting dynamic subtest: vecs0
[463.734994] Dynamic subtest vecs0: SUCCESS (1.911s)
[463.746912] Starting dynamic subtest: ccs0
[464.898897] Dynamic subtest ccs0: SUCCESS (1.163s)
[464.911144] Starting dynamic subtest: all
[466.765292] Dynamic subtest all: SUCCESS (1.863s)
[466.768036] Subtest evict-prime: SUCCESS (10.488s)
[466.902797] [116/129] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[467.019180] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[472.010845] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.992s)
[472.142289] [117/129] (581s left) kms_big_fb (4-tiled-addfb)
[472.246697] Starting subtest: 4-tiled-addfb
[472.248571] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[472.333938] [118/129] (581s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[472.436253] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[472.440186] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[472.536076] [119/129] (581s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[472.587907] Starting subtest: x-tiled-to-vebox-yf-tiled
[472.592501] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[472.773500] [120/129] (581s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[477.771456] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[477.773828] Starting dynamic subtest: pipe-A-eDP-1
[478.561661] Dynamic subtest pipe-A-eDP-1: SKIP (0.787s)
[478.570629] Starting dynamic subtest: pipe-B-eDP-1
[479.688763] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[479.693138] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.915s)
[480.859722] [121/129] (573s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[480.952614] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[480.954858] Starting dynamic subtest: pipe-A-eDP-1
[481.012541] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[481.022837] Starting dynamic subtest: pipe-B-eDP-1
[481.080504] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[481.090553] Starting dynamic subtest: pipe-C-eDP-1
[481.148559] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[481.158813] Starting dynamic subtest: pipe-D-eDP-1
[481.218077] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[481.222353] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[483.110187] [122/129] (571s left) kms_cursor_crc (cursor-random-64x21)
[483.292584] Starting subtest: cursor-random-64x21
[483.333154] Subtest cursor-random-64x21: SKIP (0.035s)
[483.561938] [123/129] (570s left) kms_cursor_edge_walk (128x128-top-bottom)
[483.656533] Starting subtest: 128x128-top-bottom
[483.658852] Starting dynamic subtest: pipe-A-eDP-1
[487.064994] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.404s)
[487.074561] Starting dynamic subtest: pipe-D-eDP-1
[490.176093] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.110s)
[490.178501] Subtest 128x128-top-bottom: SUCCESS (6.517s)
[490.982000] [124/129] (563s left) kms_psr2_su (page_flip-xrgb8888)
[491.050313] Subtest page_flip-XRGB8888: SKIP (0.000s)
[491.113908] [125/129] (563s left) kms_pm_dc (dc5-retention-flops)
[492.228550] Starting subtest: dc5-retention-flops
[492.232697] Subtest dc5-retention-flops: SKIP (0.000s)
[492.297601] [126/129] (562s left) gem_ccs (block-multicopy-inplace)
[492.361301] Starting subtest: block-multicopy-inplace
[492.365547] Subtest block-multicopy-inplace: SKIP (0.000s)
[492.452585] [127/129] (561s left) gem_exec_store (dword)
[492.516874] Starting subtest: dword
[492.519027] Starting dynamic subtest: rcs0
[492.623348] Dynamic subtest rcs0: SUCCESS (0.108s)
[492.640050] Starting dynamic subtest: bcs0
[492.666166] Dynamic subtest bcs0: SUCCESS (0.041s)
[492.676719] Starting dynamic subtest: vcs0
[492.707684] Dynamic subtest vcs0: SUCCESS (0.040s)
[492.716810] Starting dynamic subtest: vcs1
[492.749580] Dynamic subtest vcs1: SUCCESS (0.041s)
[492.759193] Starting dynamic subtest: vecs0
[492.791514] Dynamic subtest vecs0: SUCCESS (0.040s)
[492.801287] Starting dynamic subtest: ccs0
[492.832724] Dynamic subtest ccs0: SUCCESS (0.040s)
[492.835082] Subtest dword: SUCCESS (0.318s)
[493.020703] [128/129] (561s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[493.133224] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[493.137521] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[493.246788] [129/129] (561s left) syncobj_wait (wait-all-interrupted)
[493.313360] Starting subtest: wait-all-interrupted
[493.414879] Subtest wait-all-interrupted: SUCCESS (0.101s)
[493.485399] Closing watchdogs
Done.