[59.411858] Initializing watchdogs
[59.411902]   /dev/watchdog0
[59.426104] [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]
[59.430607] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.432679] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.434620] [001/133] (960s left) gem_userptr_blits (process-exit)
[59.504224] Starting subtest: process-exit
[59.512751] Subtest process-exit: SUCCESS (0.009s)
[59.658747] [002/133] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[59.747922] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[59.749798] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[60.846696] [003/133] (959s left) i915_pm_rps (waitboost)
[60.910843] Starting subtest: waitboost
[67.009719] Subtest waitboost: SUCCESS (6.125s)
[67.620902] [004/133] (952s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[67.821983] Starting subtest: flip-vs-cursor-crc-atomic
[69.280142] Subtest flip-vs-cursor-crc-atomic: SUCCESS (1.458s)
[69.676840] [005/133] (950s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[69.776946] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[69.778728] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[69.874782] [006/133] (950s left) i915_pm_freq_api (freq-basic-api)
[69.931220] Starting subtest: freq-basic-api
[69.932230] Starting dynamic subtest: gt0
[69.933178] Dynamic subtest gt0: SUCCESS (0.002s)
[69.939318] Starting dynamic subtest: gt1
[69.940089] Dynamic subtest gt1: SUCCESS (0.003s)
[69.940850] Subtest freq-basic-api: SUCCESS (0.005s)
[70.011650] [007/133] (950s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[70.050096] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[70.155542] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.103s)
[70.230544] [008/133] (949s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[70.321114] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[70.322092] Starting dynamic subtest: pipe-A-eDP-1
[70.329911] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[70.337532] Starting dynamic subtest: pipe-B-eDP-1
[70.345049] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[70.353370] Starting dynamic subtest: pipe-C-eDP-1
[70.363899] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[70.375585] Starting dynamic subtest: pipe-D-eDP-1
[70.383596] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[70.384494] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[72.635843] [009/133] (947s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[72.746277] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[72.748112] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[72.820987] [010/133] (947s left) kms_pm_rpm (modeset-non-lpsp-stress)
[75.027876] Starting subtest: modeset-non-lpsp-stress
[76.172609] Subtest modeset-non-lpsp-stress: SKIP (1.145s)
[76.538639] [011/133] (943s left) kms_cursor_crc (cursor-dpms)
[76.659275] Starting subtest: cursor-dpms
[76.660365] Starting dynamic subtest: pipe-A-eDP-1
[79.706451] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.046s)
[79.712876] Starting dynamic subtest: pipe-D-eDP-1
[83.281547] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.573s)
[83.282479] Subtest cursor-dpms: SUCCESS (6.621s)
[84.134776] [012/133] (936s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[84.243206] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[84.244855] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[84.347638] [013/133] (935s left) kms_content_protection (uevent-hdcp14)
[84.492438] Starting subtest: uevent-hdcp14
[84.494915] Subtest uevent-hdcp14: SKIP (0.000s)
[84.622474] [014/133] (935s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[84.669369] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[84.745923] [015/133] (935s left) perf_pmu (init-wait)
[84.782323] Starting subtest: init-wait
[84.783537] Starting dynamic subtest: rcs0
[84.784741] Dynamic subtest rcs0: SUCCESS (0.002s)
[84.792367] Starting dynamic subtest: bcs0
[84.793230] Dynamic subtest bcs0: SUCCESS (0.000s)
[84.798557] Starting dynamic subtest: vcs0
[84.799385] Dynamic subtest vcs0: SUCCESS (0.001s)
[84.804464] Starting dynamic subtest: vcs1
[84.805270] Dynamic subtest vcs1: SUCCESS (0.001s)
[84.810256] Starting dynamic subtest: vecs0
[84.811048] Dynamic subtest vecs0: SUCCESS (0.001s)
[84.816079] Starting dynamic subtest: ccs0
[84.816863] Dynamic subtest ccs0: SUCCESS (0.000s)
[84.817676] Subtest init-wait: SUCCESS (0.006s)
[84.903605] [016/133] (935s left) kms_addfb_basic (master-rmfb)
[84.954604] Starting subtest: master-rmfb
[84.955501] Subtest master-rmfb: SUCCESS (0.001s)
[85.115534] [017/133] (935s left) gem_userptr_blits (unsync-unmap-cycles)
[85.183957] Subtest unsync-unmap-cycles: SKIP (0.000s)
[85.339380] [018/133] (935s left) gem_mmap_gtt (zero-extend)
[85.395402] Subtest zero-extend: SKIP (0.000s)
[85.441266] [019/133] (935s left) perf (blocking-parameterized)
[85.560860] Starting subtest: blocking-parameterized
[105.583310] Subtest blocking-parameterized: SUCCESS (20.017s)
[105.622692] [020/133] (914s left) gem_exec_reloc (basic-wc-gtt-active)
[105.778103] Subtest basic-wc-gtt-active: SKIP (0.000s)
[105.834576] [021/133] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[105.925551] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[105.927260] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[106.025447] [022/133] (914s left) kms_vblank (ts-continuation-idle-hang)
[106.114782] Starting subtest: ts-continuation-idle-hang
[106.117137] Starting dynamic subtest: pipe-A-eDP-1
[132.750207] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.631s)
[132.758427] Starting dynamic subtest: pipe-D-eDP-1
[157.673959] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.922s)
[157.674879] Subtest ts-continuation-idle-hang: SUCCESS (51.557s)
[158.508046] [023/133] (862s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[158.553166] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[158.554184] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[158.671716] [024/133] (861s left) kms_psr (psr-cursor-render)
[158.760426] Starting subtest: psr-cursor-render
[158.769027] Starting dynamic subtest: eDP-1
[160.494093] Dynamic subtest eDP-1: SUCCESS (1.733s)
[160.495207] Subtest psr-cursor-render: SUCCESS (1.734s)
[161.359292] [025/133] (859s left) gem_tiled_blits (interruptible)
[161.419040] Subtest interruptible: SKIP (0.000s)
[161.498550] [026/133] (859s left) kms_tiled_display (basic-test-pattern)
[161.615091] Subtest basic-test-pattern: SKIP (0.000s)
[161.649588] [027/133] (859s left) gem_exec_params (dr1-dirt)
[161.702094] Starting subtest: DR1-dirt
[161.703109] Subtest DR1-dirt: SUCCESS (0.000s)
[161.817208] [028/133] (858s left) gem_eio (banned)
[162.012788] Starting subtest: banned
[162.594628] Subtest banned: SUCCESS (0.583s)
[162.764226] [029/133] (858s left) syncobj_timeline (wait-all-interrupted)
[162.828518] Starting subtest: wait-all-interrupted
[162.932914] Subtest wait-all-interrupted: SUCCESS (0.102s)
[163.009298] [030/133] (857s left) gem_lmem_swapping (heavy-random)
[163.048504] Subtest heavy-random: SKIP (0.000s)
[163.084274] [031/133] (857s left) kms_atomic (crtc-invalid-params-fence)
[163.169784] Starting subtest: crtc-invalid-params-fence
[163.170862] Starting dynamic subtest: pipe-A-eDP-1
[163.578128] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.407s)
[163.579141] Subtest crtc-invalid-params-fence: SUCCESS (0.408s)
[164.397951] [032/133] (856s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[164.498625] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[164.527495] Starting dynamic subtest: pipe-A-plane-0
[164.529367] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[164.537030] Starting dynamic subtest: pipe-A-plane-3
[164.538662] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[164.544351] Starting dynamic subtest: pipe-A-plane-5
[164.545968] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[165.587300] Starting dynamic subtest: pipe-B-plane-0
[165.588819] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[165.594975] Starting dynamic subtest: pipe-B-plane-3
[165.597326] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[165.608130] Starting dynamic subtest: pipe-B-plane-5
[165.609734] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[165.905012] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (1.405s)
[166.781879] [033/133] (854s left) gem_exec_fence (nb-await)
[166.961589] Starting subtest: nb-await
[166.962779] Starting dynamic subtest: rcs0
[167.033985] Dynamic subtest rcs0: SUCCESS (0.071s)
[167.043324] Starting dynamic subtest: bcs0
[167.091333] Dynamic subtest bcs0: SUCCESS (0.057s)
[167.099504] Starting dynamic subtest: vcs0
[167.149834] Dynamic subtest vcs0: SUCCESS (0.057s)
[167.158731] Starting dynamic subtest: vcs1
[167.208755] Dynamic subtest vcs1: SUCCESS (0.058s)
[167.216911] Starting dynamic subtest: vecs0
[167.268577] Dynamic subtest vecs0: SUCCESS (0.058s)
[167.277746] Starting dynamic subtest: ccs0
[167.327782] Dynamic subtest ccs0: SUCCESS (0.058s)
[167.329349] Subtest nb-await: SUCCESS (0.366s)
[168.982297] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[168.984006] [034/133] (851s left) syncobj_timeline (reset-signaled)
[169.052329] Starting subtest: reset-signaled
[169.053302] Subtest reset-signaled: SUCCESS (0.000s)
[169.170431] [035/133] (851s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[169.222503] Subtest writes-after-reads: SKIP (0.000s)
[169.289104] [036/133] (851s left) kms_invalid_mode (bad-vsync-start)
[169.378679] Starting subtest: bad-vsync-start
[169.379536] Starting dynamic subtest: pipe-A-eDP-1
[169.669697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[169.677212] Starting dynamic subtest: pipe-B-eDP-1
[169.678106] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[169.683937] Starting dynamic subtest: pipe-C-eDP-1
[169.684863] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[169.690593] Starting dynamic subtest: pipe-D-eDP-1
[169.691496] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[169.692455] Subtest bad-vsync-start: SUCCESS (0.296s)
[170.511078] [037/133] (850s left) gem_mmap_gtt (basic-small-bo-tiledy)
[170.568162] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[170.619272] [038/133] (850s left) kms_flip (flip-vs-fences-interruptible)
[170.719179] Starting subtest: flip-vs-fences-interruptible
[170.720858] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[170.829519] [039/133] (850s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[170.916711] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[170.918441] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[171.044495] [040/133] (850s left) kms_flip (dpms-off-confusion)
[171.138868] Starting subtest: dpms-off-confusion
[171.140888] Starting dynamic subtest: A-eDP1
[179.816495] Dynamic subtest A-eDP1: SUCCESS (8.675s)
[179.823827] Starting dynamic subtest: B-eDP1
[188.464454] Dynamic subtest B-eDP1: SUCCESS (8.648s)
[188.472833] Starting dynamic subtest: C-eDP1
[197.086356] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[197.095897] Starting dynamic subtest: D-eDP1
[205.717890] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[205.719959] Subtest dpms-off-confusion: SUCCESS (34.580s)
[206.893423] [041/133] (814s left) kms_plane_alpha_blend (coverage-7efc)
[206.985480] Starting subtest: coverage-7efc
[207.333141] Starting dynamic subtest: pipe-A-eDP-1
[207.897563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[207.920815] Starting dynamic subtest: pipe-D-eDP-1
[209.179442] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.264s)
[209.180302] Subtest coverage-7efc: SUCCESS (2.194s)
[210.065700] [042/133] (811s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[210.169606] Starting subtest: 4-tiled-64bpp-rotate-0
[212.085870] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.916s)
[212.258452] [043/133] (808s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[212.368756] Starting subtest: cursor-tearing-framebuffer-change
[212.369662] Starting dynamic subtest: pipe-A-eDP-1
[212.922067] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[212.929383] Starting dynamic subtest: pipe-D-eDP-1
[214.172617] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.250s)
[214.173468] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.804s)
[215.014161] [044/133] (806s left) kms_plane (pixel-format-yf-tiled-modifier)
[215.106424] Starting subtest: pixel-format-yf-tiled-modifier
[215.133171] Starting dynamic subtest: pipe-A-plane-0
[215.135874] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[215.143973] Starting dynamic subtest: pipe-A-plane-3
[215.146038] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[215.154288] Starting dynamic subtest: pipe-A-plane-5
[215.156281] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[216.207365] Starting dynamic subtest: pipe-B-plane-0
[216.209188] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[216.215373] Starting dynamic subtest: pipe-B-plane-3
[216.217276] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[216.223356] Starting dynamic subtest: pipe-B-plane-5
[216.225300] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[216.510060] Subtest pixel-format-yf-tiled-modifier: SKIP (1.403s)
[217.410851] [045/133] (803s left) gem_exec_balancer (bonded-true-hang)
[217.663424] Starting subtest: bonded-true-hang
[217.665793] Subtest bonded-true-hang: SKIP (0.000s)
[217.776353] [046/133] (803s left) gem_mmap_gtt (basic-write-read-distinct)
[217.822924] Subtest basic-write-read-distinct: SKIP (0.000s)
[217.874781] [047/133] (803s left) kms_pm_lpsp (screens-disabled)
[218.964370] Starting subtest: screens-disabled
[218.966249] Subtest screens-disabled: SKIP (0.000s)
[219.045803] [048/133] (802s left) gem_ctx_persistence (engines-queued)
[219.107624] Starting subtest: engines-queued
[219.108531] Starting dynamic subtest: rcs0
[219.172154] Dynamic subtest rcs0: SUCCESS (0.064s)
[219.180562] Starting dynamic subtest: bcs0
[219.268716] Dynamic subtest bcs0: SUCCESS (0.095s)
[219.277684] Starting dynamic subtest: vcs0
[220.857051] Dynamic subtest vcs0: SUCCESS (1.584s)
[220.872626] Starting dynamic subtest: vcs1
[222.841077] Dynamic subtest vcs1: SUCCESS (1.981s)
[222.857917] Starting dynamic subtest: vecs0
[224.822270] Dynamic subtest vecs0: SUCCESS (1.978s)
[224.832234] Starting dynamic subtest: ccs0
[225.012290] Dynamic subtest ccs0: SUCCESS (0.190s)
[225.013302] Subtest engines-queued: SUCCESS (5.905s)
[225.142674] [049/133] (796s left) kms_psr (psr-no-drrs)
[225.244205] Starting subtest: psr-no-drrs
[225.245109] Starting dynamic subtest: eDP-1
[226.862750] Dynamic subtest eDP-1: SUCCESS (1.618s)
[226.863770] Subtest psr-no-drrs: SUCCESS (1.619s)
[227.757291] [050/133] (793s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[227.852599] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[227.854270] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[227.982335] [051/133] (793s left) gem_exec_async (concurrent-writes)
[228.040218] Starting subtest: concurrent-writes
[228.041296] Starting dynamic subtest: rcs0
[228.059381] Dynamic subtest rcs0: SUCCESS (0.018s)
[228.068650] Starting dynamic subtest: bcs0
[228.069598] Dynamic subtest bcs0: SUCCESS (0.006s)
[228.076847] Starting dynamic subtest: vcs0
[228.077964] Dynamic subtest vcs0: SUCCESS (0.005s)
[228.084698] Starting dynamic subtest: vcs1
[228.085564] Dynamic subtest vcs1: SUCCESS (0.006s)
[228.091754] Starting dynamic subtest: vecs0
[228.092592] Dynamic subtest vecs0: SUCCESS (0.006s)
[228.098721] Starting dynamic subtest: ccs0
[228.099552] Dynamic subtest ccs0: SUCCESS (0.005s)
[228.100355] Subtest concurrent-writes: SUCCESS (0.049s)
[228.324714] [052/133] (793s left) gem_flink_basic (basic)
[228.385494] Starting subtest: basic
[228.386472] Subtest basic: SUCCESS (0.000s)
[228.520099] [053/133] (793s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[228.612018] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[228.612827] Starting dynamic subtest: pipe-A-default-mode
[231.429573] Dynamic subtest pipe-A-default-mode: SUCCESS (2.816s)
[231.430448] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.817s)
[232.264693] [054/133] (789s left) kms_lease (possible-crtcs-filtering)
[232.361349] Starting subtest: possible-crtcs-filtering
[232.366419] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[232.491299] [055/133] (789s left) gem_exec_parallel (userptr)
[232.549894] Starting subtest: userptr
[232.550930] Starting dynamic subtest: rcs0
[233.974866] Dynamic subtest rcs0: SUCCESS (1.424s)
[233.985050] Starting dynamic subtest: bcs0
[235.441936] Dynamic subtest bcs0: SUCCESS (1.465s)
[235.448522] Starting dynamic subtest: vcs0
[236.916972] Dynamic subtest vcs0: SUCCESS (1.472s)
[236.924053] Starting dynamic subtest: vcs1
[238.934898] Dynamic subtest vcs1: SUCCESS (2.016s)
[238.943865] Starting dynamic subtest: vecs0
[240.919033] Dynamic subtest vecs0: SUCCESS (1.982s)
[240.927772] Starting dynamic subtest: ccs0
[242.425271] Dynamic subtest ccs0: SUCCESS (1.506s)
[242.426448] Subtest userptr: SUCCESS (9.876s)
[242.616298] [056/133] (779s left) gen7_exec_parse (cmd-crossing-page)
[242.672749] Subtest cmd-crossing-page: SKIP (0.000s)
[242.751932] [057/133] (778s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[242.856699] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[249.716798] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.861s)
[249.867904] [058/133] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[249.955858] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[249.957598] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[250.079566] [059/133] (771s left) kms_rotation_crc (sprite-rotation-90)
[250.171351] Starting subtest: sprite-rotation-90
[250.172992] Subtest sprite-rotation-90: SKIP (0.001s)
[250.247974] [060/133] (771s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[250.342160] Starting subtest: x-tiled-16bpp-rotate-90
[250.362937] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[250.494242] [061/133] (771s left) kms_chamelium_color (ctm-0-75)
[250.595826] Subtest ctm-0-75: SKIP (0.000s)
[250.635679] [062/133] (771s left) gem_pxp (reject-modify-context-protection-off-2)
[250.758130] Starting subtest: reject-modify-context-protection-off-2
[250.760831] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[250.874566] [063/133] (770s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[250.960555] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[250.962184] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[251.074323] [064/133] (770s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[251.132934] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[251.243298] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[251.319683] [065/133] (770s left) gen9_exec_parse (valid-registers)
[251.381553] Subtest valid-registers: SKIP (0.000s)
[251.457886] [066/133] (770s left) gem_eio (in-flight-internal-immediate)
[251.694058] Starting subtest: in-flight-internal-immediate
[252.961170] Subtest in-flight-internal-immediate: SUCCESS (1.267s)
[253.121941] [067/133] (768s left) gem_tiled_pread_basic (basic)
[253.181065] Subtest basic: SKIP (0.000s)
[253.247350] [068/133] (768s left) kms_addfb_basic (unused-handle)
[253.299274] Starting subtest: unused-handle
[253.300148] Subtest unused-handle: SUCCESS (0.000s)
[253.435804] [069/133] (768s left) kms_psr (pr-primary-blt)
[253.531106] Starting subtest: pr-primary-blt
[253.532723] Subtest pr-primary-blt: SKIP (0.000s)
[253.608673] [070/133] (768s left) gem_exec_schedule (pi-ringfull)
[253.778967] Starting subtest: pi-ringfull
[253.779963] Starting dynamic subtest: rcs0
[253.815579] Dynamic subtest rcs0: SUCCESS (0.037s)
[253.823318] Starting dynamic subtest: bcs0
[253.853986] Dynamic subtest bcs0: SUCCESS (0.038s)
[253.860828] Starting dynamic subtest: vcs0
[253.890114] Dynamic subtest vcs0: SUCCESS (0.035s)
[253.896862] Starting dynamic subtest: vcs1
[253.920502] Dynamic subtest vcs1: SUCCESS (0.030s)
[253.927435] Starting dynamic subtest: vecs0
[253.951102] Dynamic subtest vecs0: SUCCESS (0.030s)
[253.957859] Starting dynamic subtest: ccs0
[253.980568] Dynamic subtest ccs0: SUCCESS (0.029s)
[253.981337] Subtest pi-ringfull: SUCCESS (0.203s)
[254.221569] [071/133] (767s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[254.277737] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[254.279436] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[254.475387] [072/133] (767s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[254.532816] Starting subtest: multi-wait-for-submit-submitted-signaled
[254.533898] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[254.650806] [073/133] (767s left) gem_close_race (multigpu-basic-process)
[254.717114] Starting subtest: multigpu-basic-process
[254.718971] Subtest multigpu-basic-process: SKIP (0.000s)
[254.990828] [074/133] (767s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[255.085719] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[256.087295] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.002s)
[256.249276] [075/133] (766s left) gem_softpin (overlap)
[256.326735] Starting subtest: overlap
[257.261279] Subtest overlap: SUCCESS (0.933s)
[257.391221] [076/133] (764s left) perf_pmu (interrupts-sync)
[257.429155] Starting subtest: interrupts-sync
[258.545497] Subtest interrupts-sync: SUCCESS (1.113s)
[258.676608] [077/133] (763s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[258.778357] Starting subtest: fbc-psr2-cursor-mmap-cpu
[258.779373] Starting dynamic subtest: eDP-1
[258.781367] Dynamic subtest eDP-1: SKIP (0.000s)
[258.783104] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[258.856493] [078/133] (763s left) kms_feature_discovery (dp-mst)
[258.936501] Starting subtest: dp-mst
[258.938424] Subtest dp-mst: SKIP (0.000s)
[259.017957] [079/133] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[259.113703] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[259.115344] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[259.227857] [080/133] (763s left) syncobj_timeline (etime-single-wait-all-submitted)
[259.279126] Starting subtest: etime-single-wait-all-submitted
[259.387645] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s)
[259.467173] [081/133] (762s left) gem_ctx_persistence (legacy-engines-mixed-process)
[259.507714] Starting subtest: legacy-engines-mixed-process
[259.508659] Starting dynamic subtest: render
[260.910517] Dynamic subtest render: SUCCESS (1.402s)
[260.921363] Starting dynamic subtest: bsd1
[262.891303] Dynamic subtest bsd1: SUCCESS (1.979s)
[262.902340] Starting dynamic subtest: bsd2
[264.898070] Dynamic subtest bsd2: SUCCESS (2.004s)
[264.907107] Starting dynamic subtest: blt
[266.933509] Dynamic subtest blt: SUCCESS (2.033s)
[266.944432] Starting dynamic subtest: vebox
[268.904466] Dynamic subtest vebox: SUCCESS (1.969s)
[268.907437] Subtest legacy-engines-mixed-process: SUCCESS (9.398s)
[268.990371] [082/133] (753s left) kms_frontbuffer_tracking (psr-suspend)
[269.096544] Starting subtest: psr-suspend
[308.021617] Subtest psr-suspend: SUCCESS (8.764s)
[314.179526] [083/133] (714s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[314.275025] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[314.276729] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[315.392093] [084/133] (713s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[315.776266] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[316.599241] [085/133] (712s left) gem_mmap_wc (bad-offset)
[316.658579] Subtest bad-offset: SKIP (0.000s)
[316.721697] [086/133] (711s left) gem_exec_schedule (timeslicing)
[316.785514] Starting subtest: timeslicing
[316.786484] Starting dynamic subtest: rcs0
[316.805770] Dynamic subtest rcs0: SUCCESS (0.022s)
[316.816532] Starting dynamic subtest: bcs0
[316.825449] Dynamic subtest bcs0: SUCCESS (0.020s)
[316.833140] Starting dynamic subtest: vcs0
[316.846023] Dynamic subtest vcs0: SUCCESS (0.021s)
[316.854380] Starting dynamic subtest: vcs1
[316.866947] Dynamic subtest vcs1: SUCCESS (0.020s)
[316.874486] Starting dynamic subtest: vecs0
[316.886756] Dynamic subtest vecs0: SUCCESS (0.020s)
[316.894296] Starting dynamic subtest: ccs0
[316.906457] Dynamic subtest ccs0: SUCCESS (0.020s)
[316.907398] Subtest timeslicing: SUCCESS (0.126s)
[318.099656] [087/133] (710s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[318.206605] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[318.208260] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[318.327805] [088/133] (710s left) sysfs_heartbeat_interval (invalid)
[318.389609] Starting subtest: invalid
[318.390751] Starting dynamic subtest: vecs0
[318.391802] Dynamic subtest vecs0: SUCCESS (0.000s)
[318.401295] Starting dynamic subtest: ccs0
[318.402156] Dynamic subtest ccs0: SUCCESS (0.000s)
[318.409481] Starting dynamic subtest: vcs0
[318.410380] Dynamic subtest vcs0: SUCCESS (0.000s)
[318.417670] Starting dynamic subtest: bcs0
[318.418555] Dynamic subtest bcs0: SUCCESS (0.000s)
[318.425694] Starting dynamic subtest: rcs0
[318.426585] Dynamic subtest rcs0: SUCCESS (0.000s)
[318.433870] Starting dynamic subtest: vcs1
[318.434841] Dynamic subtest vcs1: SUCCESS (0.000s)
[318.435731] Subtest invalid: SUCCESS (0.005s)
[318.521797] [089/133] (710s left) kms_psr (fbc-pr-primary-blt)
[318.620278] Starting subtest: fbc-pr-primary-blt
[318.621964] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[318.699519] [090/133] (710s left) gem_exec_schedule (wide)
[318.866120] Starting subtest: wide
[318.867005] Starting dynamic subtest: rcs0
[329.309105] Dynamic subtest rcs0: SUCCESS (10.572s)
[329.317923] Starting dynamic subtest: vcs0
[340.319643] Dynamic subtest vcs0: SUCCESS (11.047s)
[340.329688] Starting dynamic subtest: vcs1
[352.038458] Dynamic subtest vcs1: SUCCESS (11.719s)
[352.049813] Starting dynamic subtest: vecs0
[362.778186] Dynamic subtest vecs0: SUCCESS (10.738s)
[362.789139] Starting dynamic subtest: ccs0
[380.260346] Dynamic subtest ccs0: SUCCESS (17.483s)
[380.261500] Subtest wide: SUCCESS (61.566s)
[382.359007] [091/133] (646s left) api_intel_bb (offset-control)
[382.417308] Starting subtest: offset-control
[382.429547] Subtest offset-control: SUCCESS (0.014s)
[382.527608] [092/133] (646s left) fbdev (info)
[382.559289] Starting subtest: info
[382.560468] Subtest info: SUCCESS (0.000s)
[382.635772] [093/133] (646s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[382.733513] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[382.735342] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[382.854783] [094/133] (646s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[383.229575] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[384.039689] [095/133] (644s left) gem_exec_reloc (basic-gtt)
[384.098310] Subtest basic-gtt: SKIP (0.000s)
[384.161968] [096/133] (644s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[384.256240] Starting subtest: y-tiled-8bpp-rotate-0
[384.258297] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[384.385183] [097/133] (644s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[384.479958] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[384.480946] Starting dynamic subtest: pipe-A-eDP-1
[384.505839] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.026s)
[384.515117] Starting dynamic subtest: pipe-B-eDP-1
[384.528966] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[384.538141] Starting dynamic subtest: pipe-C-eDP-1
[384.551939] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[384.561370] Starting dynamic subtest: pipe-D-eDP-1
[384.574961] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[384.575773] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.097s)
[386.825045] [098/133] (642s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[386.914618] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[393.900355] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.989s)
[394.019864] [099/133] (635s left) kms_big_fb (linear-8bpp-rotate-270)
[394.125599] Starting subtest: linear-8bpp-rotate-270
[394.146098] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[394.278798] [100/133] (634s left) api_intel_bb (blit-reloc-keep-cache)
[394.331932] Starting subtest: blit-reloc-keep-cache
[394.333578] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[394.480314] [101/133] (634s left) gem_tiled_partial_pwrite_pread (reads)
[394.540284] Subtest reads: SKIP (0.000s)
[394.616583] [102/133] (634s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[394.734688] Starting subtest: cursorA-vs-flipA-atomic
[405.847805] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.117s)
[406.690177] [103/133] (622s left) kms_busy (extended-modeset-hang-newfb)
[406.795344] Starting subtest: extended-modeset-hang-newfb
[406.796293] Starting dynamic subtest: pipe-A
[441.979461] Dynamic subtest pipe-A: SUCCESS (35.175s)
[441.988738] Starting dynamic subtest: pipe-D
[465.013591] Dynamic subtest pipe-D: SUCCESS (23.032s)
[465.014455] Subtest extended-modeset-hang-newfb: SUCCESS (58.212s)
[465.805294] [104/133] (563s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[465.858489] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[465.965346] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[466.040981] [105/133] (563s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[466.131124] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[473.399465] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.270s)
[473.589332] [106/133] (555s left) kms_color_pipeline (plane-ctm3x4)
[473.693112] Starting subtest: plane-ctm3x4
[473.707796] Starting dynamic subtest: pipe-A-eDP-1
[474.172287] Dynamic subtest pipe-A-eDP-1: FAIL (0.314s)
[475.111768] Starting dynamic subtest: pipe-B-eDP-1
[475.597624] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[476.455700] Starting dynamic subtest: pipe-C-eDP-1
[476.876096] Dynamic subtest pipe-C-eDP-1: FAIL (0.213s)
[477.703383] Starting dynamic subtest: pipe-D-eDP-1
[478.147398] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[478.209586] Subtest plane-ctm3x4: FAIL (4.517s)
[479.082955] [107/133] (550s left) kms_cursor_crc (cursor-random-512x170)
[479.387172] Starting subtest: cursor-random-512x170
[479.388939] Subtest cursor-random-512x170: SKIP (0.001s)
[479.553157] [108/133] (549s left) kms_plane_scaling (invalid-num-scalers)
[479.645995] Starting subtest: invalid-num-scalers
[479.646884] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[479.664252] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.016s)
[479.672595] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[479.692809] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.028s)
[479.702156] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[479.722031] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.027s)
[479.729963] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[479.765977] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.043s)
[479.768120] Subtest invalid-num-scalers: SUCCESS (0.121s)
[479.909580] [109/133] (549s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[480.028448] Starting subtest: short-flip-after-cursor-atomic-transitions
[480.991531] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.963s)
[481.801012] [110/133] (547s left) gem_exec_params (invalid-bsd-ring)
[481.868150] Starting subtest: invalid-bsd-ring
[481.869308] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[481.990176] [111/133] (547s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[482.087401] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[486.234431] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.148s)
[487.425707] [112/133] (542s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[487.516015] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[487.517865] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[487.635086] [113/133] (541s left) dmabuf_sync_file (export-wait-after-attach)
[487.676136] Starting subtest: export-wait-after-attach
[487.677045] Subtest export-wait-after-attach: SUCCESS (0.001s)
[487.740936] [114/133] (541s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[487.825488] Starting subtest: fbc-psr-sprite-mmap-cpu
[487.826429] Starting dynamic subtest: eDP-1
[487.828189] Dynamic subtest eDP-1: SKIP (0.000s)
[487.829875] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[487.909877] [115/133] (541s left) gem_mmap_gtt (basic-copy)
[487.963847] Subtest basic-copy: SKIP (0.000s)
[488.012312] [116/133] (541s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[488.112753] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[488.114143] Starting dynamic subtest: pipe-A-eDP-1
[488.210666] Dynamic subtest pipe-A-eDP-1: SKIP (0.098s)
[488.220591] Starting dynamic subtest: pipe-B-eDP-1
[489.381326] Dynamic subtest pipe-B-eDP-1: SKIP (1.169s)
[489.383163] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.271s)
[490.576675] [117/133] (539s left) drm_read (invalid-buffer)
[490.722529] Starting subtest: invalid-buffer
[490.723674] Subtest invalid-buffer: SUCCESS (0.000s)
[490.883707] [118/133] (538s left) kms_display_modes (extended-mode-basic)
[490.975310] Starting subtest: extended-mode-basic
[490.977094] Subtest extended-mode-basic: SKIP (0.000s)
[491.015661] [119/133] (538s left) prime_busy (hang)
[491.078401] Starting subtest: hang
[491.079372] Starting dynamic subtest: rcs0
[504.590472] Dynamic subtest rcs0: SUCCESS (13.514s)
[504.598765] Starting dynamic subtest: bcs0
[511.735789] Dynamic subtest bcs0: SUCCESS (7.144s)
[511.743988] Starting dynamic subtest: vcs0
[518.713506] Dynamic subtest vcs0: SUCCESS (6.978s)
[518.721464] Starting dynamic subtest: vcs1
[525.749373] Dynamic subtest vcs1: SUCCESS (7.038s)
[525.757138] Starting dynamic subtest: vecs0
[532.723669] Dynamic subtest vecs0: SUCCESS (6.975s)
[532.731397] Starting dynamic subtest: ccs0
[546.587413] Dynamic subtest ccs0: SUCCESS (13.858s)
[546.588693] Subtest hang: SUCCESS (55.515s)
[546.717732] [120/133] (483s left) i915_pm_rpm (gem-execbuf)
[548.242756] Starting subtest: gem-execbuf
[548.244266] Starting dynamic subtest: smem0
[549.971455] Dynamic subtest smem0: SUCCESS (1.731s)
[549.972397] Subtest gem-execbuf: SUCCESS (1.732s)
[550.076648] [121/133] (479s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[550.167958] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[550.169685] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[550.300221] [122/133] (479s left) sw_sync (sync_busy_fork_unixsocket)
[550.332171] Starting subtest: sync_busy_fork_unixsocket
[550.339902] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[550.403861] [123/133] (479s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[550.498941] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[557.407704] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.906s)
[557.551991] [124/133] (472s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[557.662834] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[557.663772] Starting dynamic subtest: pipe-A
[557.736695] Dynamic subtest pipe-A: SUCCESS (0.073s)
[557.749288] Starting dynamic subtest: pipe-B
[558.957808] Dynamic subtest pipe-B: SUCCESS (1.219s)
[558.968155] Starting dynamic subtest: pipe-C
[560.069764] Dynamic subtest pipe-C: SUCCESS (1.111s)
[560.085273] Starting dynamic subtest: pipe-D
[561.208438] Dynamic subtest pipe-D: SUCCESS (1.136s)
[561.210582] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.547s)
[562.373048] [125/133] (467s left) gem_mmap_gtt (big-copy-xy)
[562.427745] Subtest big-copy-XY: SKIP (0.000s)
[562.487604] [126/133] (467s left) prime_self_import (export-vs-gem_close-race)
[562.513263] Starting subtest: export-vs-gem_close-race
[567.623181] Subtest export-vs-gem_close-race: SUCCESS (5.110s)
[567.712473] [127/133] (462s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[567.819958] Starting subtest: yf-tiled-64bpp-rotate-90
[567.821897] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[567.945404] [128/133] (462s left) gem_softpin (evict-prime)
[568.010125] Starting subtest: evict-prime
[568.011281] Starting dynamic subtest: rcs0
[569.192213] Dynamic subtest rcs0: SUCCESS (1.183s)
[569.206791] Starting dynamic subtest: bcs0
[570.344207] Dynamic subtest bcs0: SUCCESS (1.150s)
[570.356340] Starting dynamic subtest: vcs0
[572.102865] Dynamic subtest vcs0: SUCCESS (1.753s)
[572.114234] Starting dynamic subtest: vcs1
[574.089005] Dynamic subtest vcs1: SUCCESS (1.984s)
[574.100506] Starting dynamic subtest: vecs0
[576.077078] Dynamic subtest vecs0: SUCCESS (1.985s)
[576.088580] Starting dynamic subtest: ccs0
[577.226489] Dynamic subtest ccs0: SUCCESS (1.149s)
[577.239361] Starting dynamic subtest: all
[579.088719] Dynamic subtest all: SUCCESS (1.857s)
[579.090500] Subtest evict-prime: SUCCESS (11.078s)
[579.174006] [129/133] (450s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[579.266984] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[579.268933] Starting dynamic subtest: pipe-A-default-mode
[582.021271] Dynamic subtest pipe-A-default-mode: SUCCESS (2.752s)
[582.022140] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.754s)
[582.864687] [130/133] (447s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[582.966752] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[582.968519] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[583.077427] [131/133] (447s left) gem_exec_fence (basic-await)
[583.250435] Starting subtest: basic-await
[583.251353] Starting dynamic subtest: rcs0
[583.325294] Dynamic subtest rcs0: SUCCESS (0.075s)
[583.340437] Starting dynamic subtest: bcs0
[583.398845] Dynamic subtest bcs0: SUCCESS (0.072s)
[583.411670] Starting dynamic subtest: vcs0
[583.473427] Dynamic subtest vcs0: SUCCESS (0.072s)
[583.486999] Starting dynamic subtest: vcs1
[583.545779] Dynamic subtest vcs1: SUCCESS (0.071s)
[583.557319] Starting dynamic subtest: vecs0
[583.619826] Dynamic subtest vecs0: SUCCESS (0.072s)
[583.631983] Starting dynamic subtest: ccs0
[583.694426] Dynamic subtest ccs0: SUCCESS (0.073s)
[583.695816] Subtest basic-await: SUCCESS (0.446s)
[585.175129] [132/133] (445s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[585.299017] Starting subtest: flip-vs-cursor-legacy
[592.396966] Subtest flip-vs-cursor-legacy: SUCCESS (7.098s)
[593.209467] [133/133] (437s left) gem_lmem_swapping (verify-random-ccs)
[593.244415] Subtest verify-random-ccs: SKIP (0.000s)
[593.279020] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: i915_pm_rps
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_pm_freq_api
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: gem_tiled_blits
results: parsing output: 25/ for test: kms_tiled_display
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: kms_atomic
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 35/ for test: kms_invalid_mode
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_plane_alpha_blend
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_plane
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_pm_lpsp
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_async
results: parsing output: 51/ for test: gem_flink_basic
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_lease
results: parsing output: 54/ for test: gem_exec_parallel
results: parsing output: 55/ for test: gen7_exec_parse
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: gem_pxp
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: gen9_exec_parse
results: parsing output: 65/ for test: gem_eio
results: parsing output: 66/ for test: gem_tiled_pread_basic
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: gem_close_race
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_feature_discovery
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_chamelium_hpd
results: parsing output: 84/ for test: gem_mmap_wc
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: sysfs_heartbeat_interval
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: api_intel_bb
results: parsing output: 91/ for test: fbdev
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_chamelium_edid
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_busy
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_color_pipeline
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: drm_read
results: parsing output: 117/ for test: kms_display_modes
results: parsing output: 118/ for test: prime_busy
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: prime_self_import
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: gem_lmem_swapping
Done.