[57.404124] Initializing watchdogs
[57.404169]   /dev/watchdog0
[57.417753] [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.421910] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.423980] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.427191] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[57.548699] Starting subtest: fbcpsr-slowdraw
[82.570205] Subtest fbcpsr-slowdraw: SUCCESS (25.158s)
[82.702953] [002/133] (935s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[82.825258] Starting subtest: cursorA-vs-flipB-toggle
[82.829816] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[82.966181] [003/133] (935s left) gen9_exec_parse (bb-start-out)
[83.028516] Subtest bb-start-out: SKIP (0.000s)
[83.097066] [004/133] (934s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[83.185793] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[83.187726] Starting dynamic subtest: pipe-A-eDP-1
[84.489424] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.303s)
[84.765710] Starting dynamic subtest: pipe-B-eDP-1
[85.819035] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.062s)
[86.088044] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.903s)
[86.926655] [005/133] (931s left) prime_self_import (basic-llseek-bad)
[86.962071] Starting subtest: basic-llseek-bad
[86.982896] Subtest basic-llseek-bad: SUCCESS (0.023s)
[87.090163] [006/133] (931s left) kms_properties (invalid-properties-legacy)
[87.178070] Starting subtest: invalid-properties-legacy
[87.278620] Subtest invalid-properties-legacy: SUCCESS (0.102s)
[87.348183] [007/133] (930s left) gem_lmem_swapping (verify-random)
[87.393798] Subtest verify-random: SKIP (0.000s)
[87.433258] [008/133] (930s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[87.526633] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[94.398227] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.872s)
[94.524236] [009/133] (923s left) syncobj_timeline (wait-for-submit-snapshot)
[94.582454] Starting subtest: wait-for-submit-snapshot
[94.665043] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[94.745622] [010/133] (923s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[94.839264] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[94.844061] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[94.956446] [011/133] (923s left) core_setmaster (master-drop-set-user)
[95.039014] Starting subtest: master-drop-set-user
[95.052659] Subtest master-drop-set-user: SUCCESS (0.014s)
[95.087692] [012/133] (923s left) core_debugfs (read-all-entries)
[95.142573] Starting subtest: read-all-entries
[95.234095] Subtest read-all-entries: SUCCESS (0.095s)
[95.294644] [013/133] (923s left) gem_exec_schedule (u-semaphore-user)
[95.364288] Starting subtest: u-semaphore-user
[95.417222] Subtest u-semaphore-user: SUCCESS (0.058s)
[97.324812] [014/133] (921s left) kms_joiner (invalid-modeset-ultra-joiner)
[97.423433] Starting subtest: invalid-modeset-ultra-joiner
[97.428070] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[97.486765] [015/133] (920s left) sw_sync (sync_expired_merge)
[97.527434] Starting subtest: sync_expired_merge
[98.600782] Subtest sync_expired_merge: SUCCESS (1.074s)
[98.658355] [016/133] (919s left) kms_plane_multiple (2x-tiling-y)
[98.756060] Starting subtest: 2x-tiling-y
[98.760342] Subtest 2x-tiling-y: SKIP (0.000s)
[98.826926] [017/133] (919s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[98.922338] Starting subtest: yf-tiled-64bpp-rotate-180
[98.926722] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[99.009574] [018/133] (919s left) kms_getfb (getfb-repeated-different-handles)
[99.106267] Starting subtest: getfb-repeated-different-handles
[99.108415] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[99.192536] [019/133] (919s left) kms_pm_rpm (modeset-non-lpsp-stress)
[101.453760] Starting subtest: modeset-non-lpsp-stress
[102.605990] Subtest modeset-non-lpsp-stress: SKIP (1.153s)
[102.992212] [020/133] (915s left) perf_pmu (busy-double-start)
[103.041709] Starting subtest: busy-double-start
[103.044102] Starting dynamic subtest: rcs0
[106.689686] Dynamic subtest rcs0: FAIL (3.592s)
[106.698990] Starting dynamic subtest: bcs0
[110.201897] Dynamic subtest bcs0: SUCCESS (3.569s)
[110.211553] Starting dynamic subtest: vcs0
[113.814916] Dynamic subtest vcs0: SUCCESS (3.612s)
[113.824783] Starting dynamic subtest: vcs1
[117.848702] Dynamic subtest vcs1: SUCCESS (4.033s)
[117.859158] Starting dynamic subtest: vecs0
[121.796242] Dynamic subtest vecs0: SUCCESS (3.946s)
[121.806573] Starting dynamic subtest: ccs0
[125.430622] Dynamic subtest ccs0: FAIL (3.564s)
[125.432686] Subtest busy-double-start: FAIL (22.320s)
[125.471694] [021/133] (893s left) gem_exec_suspend (basic)
[125.535958] Starting subtest: basic
[125.538280] Starting dynamic subtest: smem
[127.303265] Dynamic subtest smem: SUCCESS (1.765s)
[127.306209] Subtest basic: SUCCESS (1.766s)
[127.489966] [022/133] (891s left) kms_flip (absolute-wf_vblank-interruptible)
[127.598801] Starting subtest: absolute-wf_vblank-interruptible
[127.601227] Starting dynamic subtest: A-eDP1
[136.367239] Dynamic subtest A-eDP1: SUCCESS (8.733s)
[136.377421] Starting dynamic subtest: B-eDP1
[145.096570] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[145.104616] Starting dynamic subtest: C-eDP1
[153.832052] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[153.841621] Starting dynamic subtest: D-eDP1
[162.564364] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[162.566730] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.922s)
[163.741388] [023/133] (854s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[163.846643] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[163.850778] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[163.950768] [024/133] (854s left) gem_lmem_swapping (massive)
[163.993223] Subtest massive: SKIP (0.000s)
[164.037646] [025/133] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[164.131952] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[164.136184] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[164.250184] [026/133] (854s left) gem_mmap_gtt (basic)
[164.305606] Subtest basic: SKIP (0.000s)
[164.377871] [027/133] (854s left) gem_exec_schedule (u-submit-golden-slice)
[164.452412] Starting subtest: u-submit-golden-slice
[164.454392] Starting dynamic subtest: rcs0
[164.475578] Dynamic subtest rcs0: SUCCESS (0.032s)
[164.489377] Starting dynamic subtest: bcs0
[164.503690] Dynamic subtest bcs0: SUCCESS (0.028s)
[164.513872] Starting dynamic subtest: vcs0
[164.535472] Dynamic subtest vcs0: SUCCESS (0.032s)
[164.546421] Starting dynamic subtest: vcs1
[164.563685] Dynamic subtest vcs1: SUCCESS (0.028s)
[164.571778] Starting dynamic subtest: vecs0
[164.590808] Dynamic subtest vecs0: SUCCESS (0.027s)
[164.598750] Starting dynamic subtest: ccs0
[164.622221] Dynamic subtest ccs0: SUCCESS (0.031s)
[164.624454] Subtest u-submit-golden-slice: SUCCESS (0.179s)
[166.369503] [028/133] (852s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[166.463297] Starting subtest: basic-max-pipe-crc-check
[166.467773] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[166.510290] [029/133] (852s left) gem_render_copy (linear)
[166.587791] Starting subtest: linear
[166.590232] Starting dynamic subtest: smem
[166.633080] Dynamic subtest smem: SUCCESS (0.045s)
[166.635484] Subtest linear: SUCCESS (0.045s)
[166.815710] [030/133] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[166.910845] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[166.915522] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[167.006205] [031/133] (852s left) kms_psr (pr-no-drrs)
[167.101921] Starting subtest: pr-no-drrs
[167.106603] Subtest pr-no-drrs: SKIP (0.000s)
[167.170253] [032/133] (851s left) kms_busy (basic-hang)
[167.274797] Starting subtest: basic-hang
[167.277170] Starting dynamic subtest: flip-pipe-A
[167.853434] Dynamic subtest flip-pipe-A: SUCCESS (0.580s)
[167.863285] Starting dynamic subtest: modeset-pipe-A
[171.279868] Dynamic subtest modeset-pipe-A: SUCCESS (3.425s)
[171.292343] Starting dynamic subtest: flip-pipe-D
[172.469468] Dynamic subtest flip-pipe-D: SUCCESS (1.187s)
[172.479546] Starting dynamic subtest: modeset-pipe-D
[175.896100] Dynamic subtest modeset-pipe-D: SUCCESS (3.428s)
[175.898400] Subtest basic-hang: SUCCESS (8.625s)
[176.705652] [033/133] (842s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[176.830205] Starting subtest: verify-pxp-key-change-after-suspend-resume
[184.827896] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.999s)
[184.956120] [034/133] (834s left) kms_addfb_basic (invalid-set-prop)
[185.028044] Starting subtest: invalid-set-prop
[185.030113] Subtest invalid-set-prop: SUCCESS (0.000s)
[185.167903] [035/133] (834s left) syncobj_timeline (invalid-query-one-illegal-handle)
[185.233210] Starting subtest: invalid-query-one-illegal-handle
[185.235544] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[185.326913] [036/133] (833s left) vgem_basic (create)
[185.423187] Starting subtest: create
[185.425062] Subtest create: SUCCESS (0.000s)
[185.474395] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[185.478057] [037/133] (833s left) syncobj_timeline (32bits-limit)
[185.530747] Starting subtest: 32bits-limit
[185.533244] Subtest 32bits-limit: SUCCESS (0.001s)
[185.649560] [038/133] (833s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[185.703657] Starting subtest: multi-wait-available-unsubmitted-signaled
[185.705927] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[185.801749] [039/133] (833s left) gem_render_copy_redux (flink-interruptible)
[185.875145] Starting subtest: flink-interruptible
[186.635056] Subtest flink-interruptible: SUCCESS (0.760s)
[186.809566] [040/133] (832s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[186.910051] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[186.921860] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s)
[186.998623] [041/133] (832s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[187.098175] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[187.101680] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[187.191459] [042/133] (832s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[187.297868] Starting subtest: 4-tiled-8bpp-rotate-180
[188.456377] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.157s)
[188.570265] [043/133] (830s left) kms_cursor_edge_walk (128x128-top-bottom)
[188.655053] Starting subtest: 128x128-top-bottom
[188.657367] Starting dynamic subtest: pipe-A-eDP-1
[192.153547] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.498s)
[192.162670] Starting dynamic subtest: pipe-D-eDP-1
[195.274499] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[195.276824] Subtest 128x128-top-bottom: SUCCESS (6.620s)
[196.075959] [044/133] (823s left) kms_setmode (invalid-clone-exclusive-crtc)
[196.138160] Starting subtest: invalid-clone-exclusive-crtc
[196.144491] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[196.250860] [045/133] (823s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[196.366152] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[196.371080] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[197.514450] [046/133] (822s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[197.649171] Starting subtest: dp-mst-type-1-suspend-resume
[197.653297] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[197.794364] [047/133] (821s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[197.890943] Starting subtest: primary-x-tiled-reflect-x-0
[204.891838] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.003s)
[206.068781] [048/133] (813s left) syncobj_timeline (signal)
[206.132232] Starting subtest: signal
[206.134258] Subtest signal: SUCCESS (0.000s)
[206.234722] [049/133] (813s left) gem_exec_balancer (hog)
[206.301296] Starting subtest: hog
[206.306041] Subtest hog: SKIP (0.000s)
[206.606212] [050/133] (813s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[206.706090] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[206.710311] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[206.796054] [051/133] (813s left) gem_mmap_gtt (big-bo-tiledx)
[206.855040] Subtest big-bo-tiledX: SKIP (0.000s)
[206.918274] [052/133] (813s left) syncobj_timeline (etime-multi-wait-all-submitted)
[206.972829] Starting subtest: etime-multi-wait-all-submitted
[207.081378] Subtest etime-multi-wait-all-submitted: SUCCESS (0.108s)
[207.158671] [053/133] (812s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[207.254652] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[207.256973] Starting dynamic subtest: pipe-A-eDP-1
[213.118310] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.866s)
[213.127833] Starting dynamic subtest: pipe-B-eDP-1
[219.740627] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.623s)
[219.743074] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.492s)
[220.620401] [054/133] (799s left) gem_exec_reloc (basic-write-gtt-active)
[220.683609] Subtest basic-write-gtt-active: SKIP (0.000s)
[220.749333] [055/133] (799s left) gem_exec_reloc (basic-concurrent0)
[220.812627] Subtest basic-concurrent0: SKIP (0.000s)
[220.882651] [056/133] (799s left) perf_pmu (module-unload)