[61.413936] Initializing watchdogs
[61.413985]   /dev/watchdog0
[61.428570] [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]
[61.432928] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.435123] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.437135] [001/134] (960s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[61.529115] Starting subtest: addfb25-y-tiled-legacy
[61.530094] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[61.644061] [002/134] (960s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[61.754108] Starting subtest: 4-tiled-16bpp-rotate-0
[63.119762] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.366s)
[63.256368] [003/134] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[63.359808] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[67.613842] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.255s)
[68.782715] [004/134] (953s left) kms_plane_cursor (viewport)
[68.879058] Starting subtest: viewport
[68.880875] Starting dynamic subtest: pipe-A-eDP-1-size-64
[71.320382] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.441s)
[71.380063] Starting dynamic subtest: pipe-A-eDP-1-size-128
[73.844606] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.472s)
[73.904261] Starting dynamic subtest: pipe-A-eDP-1-size-256
[76.334063] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.438s)
[76.687872] Starting dynamic subtest: pipe-B-eDP-1-size-64
[79.806264] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.128s)
[79.865940] Starting dynamic subtest: pipe-B-eDP-1-size-128
[82.252078] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.394s)
[82.311219] Starting dynamic subtest: pipe-B-eDP-1-size-256
[84.722537] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.418s)
[85.072298] Starting dynamic subtest: pipe-C-eDP-1-size-64
[87.846755] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.781s)
[87.883517] Starting dynamic subtest: pipe-C-eDP-1-size-128
[89.891640] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.014s)
[89.928301] Starting dynamic subtest: pipe-C-eDP-1-size-256
[91.980734] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.058s)
[92.310685] Starting dynamic subtest: pipe-D-eDP-1-size-64
[95.078138] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.773s)
[95.114847] Starting dynamic subtest: pipe-D-eDP-1-size-128
[97.133858] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.025s)
[97.169854] Starting dynamic subtest: pipe-D-eDP-1-size-256
[99.189364] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.025s)
[99.505227] Subtest viewport: SUCCESS (30.623s)
[100.307295] [005/134] (921s left) kms_atomic_interruptible (legacy-cursor)
[100.401498] Starting subtest: legacy-cursor
[100.402426] Starting dynamic subtest: pipe-A-eDP-1
[107.830676] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.429s)
[107.831545] Subtest legacy-cursor: SUCCESS (7.430s)
[108.664880] [006/134] (913s left) gem_exec_balancer (smoke)
[108.741284] Starting subtest: smoke
[131.295201] Subtest smoke: SUCCESS (22.551s)
[133.022899] [007/134] (889s left) gem_exec_params (no-bsd)
[133.079303] Starting subtest: no-bsd
[133.082553] Subtest no-bsd: SUCCESS (0.003s)
[134.994385] [008/134] (887s left) gem_ctx_persistence (legacy-engines-hostile)
[135.068927] Starting subtest: legacy-engines-hostile
[135.069879] Starting dynamic subtest: render
[135.250963] Dynamic subtest render: SUCCESS (0.182s)
[135.262557] Starting dynamic subtest: bsd1
[135.382104] Dynamic subtest bsd1: SUCCESS (0.128s)
[135.392629] Starting dynamic subtest: bsd2
[135.514993] Dynamic subtest bsd2: SUCCESS (0.130s)
[135.525359] Starting dynamic subtest: blt
[135.646025] Dynamic subtest blt: SUCCESS (0.128s)
[135.655896] Starting dynamic subtest: vebox
[135.778088] Dynamic subtest vebox: SUCCESS (0.129s)
[135.779240] Subtest legacy-engines-hostile: SUCCESS (0.711s)
[135.859828] [009/134] (886s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[140.870053] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[140.871082] Starting dynamic subtest: pipe-A-eDP-1
[141.657173] Dynamic subtest pipe-A-eDP-1: SKIP (0.785s)
[141.666492] Starting dynamic subtest: pipe-B-eDP-1
[142.799928] Dynamic subtest pipe-B-eDP-1: SKIP (1.142s)
[142.801523] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.931s)
[143.997405] [010/134] (878s left) kms_pm_rpm (modeset-non-lpsp-stress)
[146.026319] Starting subtest: modeset-non-lpsp-stress
[147.183901] Subtest modeset-non-lpsp-stress: SKIP (1.159s)
[147.569314] [011/134] (874s left) i915_pm_rpm (system-suspend)
[149.090870] Starting subtest: system-suspend
[167.777972] Subtest system-suspend: SUCCESS (3.375s)
[174.164467] [012/134] (854s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[174.283601] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[178.661265] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.374s)
[179.870905] [013/134] (848s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[179.974832] Starting subtest: bad-aux-stride-yf-tiled-ccs
[179.977059] Starting dynamic subtest: pipe-A-eDP-1
[179.985725] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[179.992164] Starting dynamic subtest: pipe-B-eDP-1
[180.000233] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[180.006852] Starting dynamic subtest: pipe-C-eDP-1
[180.014933] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[180.021149] Starting dynamic subtest: pipe-D-eDP-1
[180.029129] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[180.030719] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.013s)
[182.325274] [014/134] (846s left) gem_exec_fence (submit3)
[182.514394] Starting subtest: submit3
[182.516499] Subtest submit3: SKIP (0.000s)
[184.301833] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[184.303715] [015/134] (844s left) core_getstats (basic)
[184.353024] Starting subtest: basic
[184.354005] Subtest basic: SUCCESS (0.000s)
[184.474138] [016/134] (843s left) kms_psr (psr2-cursor-plane-move)
[184.579531] Starting subtest: psr2-cursor-plane-move
[184.580534] Starting dynamic subtest: eDP-1
[186.316404] Dynamic subtest eDP-1: SUCCESS (1.736s)
[186.317343] Subtest psr2-cursor-plane-move: SUCCESS (1.738s)
[187.122230] [017/134] (841s left) i915_hangman (engine-error-state-capture)
[187.189481] Starting subtest: engine-error-state-capture
[187.190513] Starting dynamic subtest: rcs0
[191.176671] Dynamic subtest rcs0: SUCCESS (3.983s)
[191.186846] Starting dynamic subtest: bcs0
[197.126638] Dynamic subtest bcs0: SUCCESS (5.946s)
[197.137030] Starting dynamic subtest: vcs0
[202.118302] Dynamic subtest vcs0: SUCCESS (4.988s)
[202.134978] Starting dynamic subtest: vcs1
[208.135100] Dynamic subtest vcs1: SUCCESS (6.014s)
[208.145517] Starting dynamic subtest: vecs0
[213.124070] Dynamic subtest vecs0: SUCCESS (4.989s)
[213.134530] Starting dynamic subtest: ccs0
[218.180103] Dynamic subtest ccs0: SUCCESS (5.053s)
[218.181526] Subtest engine-error-state-capture: SUCCESS (30.988s)
[218.264496] [018/134] (810s left) kms_flip (2x-flip-vs-wf_vblank)
[218.355425] Starting subtest: 2x-flip-vs-wf_vblank
[218.365936] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[218.450989] [019/134] (810s left) gem_userptr_blits (unsync-unmap-after-close)
[218.512885] Subtest unsync-unmap-after-close: SKIP (0.000s)
[218.670660] [020/134] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[218.765885] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[218.767761] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[218.878033] [021/134] (809s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[218.942852] Starting subtest: invalid-single-wait-all-unsubmitted
[218.943907] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[219.046941] [022/134] (809s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[219.137587] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[219.138465] Starting dynamic subtest: pipe-A
[219.366531] Dynamic subtest pipe-A: SUCCESS (0.229s)
[219.373915] Starting dynamic subtest: pipe-B
[220.684635] Dynamic subtest pipe-B: SUCCESS (1.317s)
[220.691714] Starting dynamic subtest: pipe-C
[222.014007] Dynamic subtest pipe-C: SUCCESS (1.328s)
[222.023310] Starting dynamic subtest: pipe-D
[223.361413] Dynamic subtest pipe-D: SUCCESS (1.347s)
[223.362353] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.225s)
[224.547750] [023/134] (804s left) gem_eio (execbuf)
[224.731273] Starting subtest: execbuf
[224.995666] Subtest execbuf: SUCCESS (0.265s)
[225.170484] [024/134] (803s left) gem_partial_pwrite_pread (writes-after-reads)
[225.228005] Subtest writes-after-reads: SKIP (0.000s)
[225.310428] [025/134] (803s left) sysfs_heartbeat_interval (mixed)
[225.368782] Starting subtest: mixed
[225.369724] Starting dynamic subtest: vecs0
[230.635318] Dynamic subtest vecs0: SUCCESS (5.265s)
[230.646471] Starting dynamic subtest: ccs0
[235.868260] Dynamic subtest ccs0: SUCCESS (5.230s)
[235.878688] Starting dynamic subtest: vcs0
[241.101823] Dynamic subtest vcs0: SUCCESS (5.230s)
[241.113872] Starting dynamic subtest: bcs0
[246.344624] Dynamic subtest bcs0: SUCCESS (5.239s)
[246.354618] Starting dynamic subtest: rcs0
[251.598446] Dynamic subtest rcs0: SUCCESS (5.251s)
[251.609058] Starting dynamic subtest: vcs1
[256.799382] Dynamic subtest vcs1: SUCCESS (5.198s)
[256.800838] Subtest mixed: SUCCESS (31.429s)
[256.882011] [026/134] (771s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[256.973597] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[256.975397] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[257.085794] [027/134] (771s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[257.143342] Subtest writes-after-reads-snoop: SKIP (0.000s)
[257.223807] [028/134] (771s left) i915_suspend (debugfs-reader)
[257.270640] Starting subtest: debugfs-reader
[275.964162] Subtest debugfs-reader: SUCCESS (3.522s)
[281.131510] [029/134] (752s left) kms_cursor_edge_walk (256x256-left-edge)
[281.234983] Starting subtest: 256x256-left-edge
[281.235924] Starting dynamic subtest: pipe-A-eDP-1
[284.682409] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s)
[284.689513] Starting dynamic subtest: pipe-D-eDP-1
[287.800062] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[287.800931] Subtest 256x256-left-edge: SUCCESS (6.562s)
[288.617696] [030/134] (745s left) gem_exec_parallel (engines)
[288.681967] Starting subtest: engines
[288.682863] Starting dynamic subtest: basic
[290.347191] Dynamic subtest basic: SUCCESS (1.662s)
[290.357425] Starting dynamic subtest: contexts
[294.693978] Dynamic subtest contexts: SUCCESS (4.344s)
[294.701961] Starting dynamic subtest: fds
[298.499549] Dynamic subtest fds: SUCCESS (3.802s)
[298.509269] Starting dynamic subtest: userptr
[300.330583] Dynamic subtest userptr: SUCCESS (1.828s)
[300.332106] Subtest engines: SUCCESS (11.645s)
[300.529975] [031/134] (733s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[300.651906] Starting subtest: 2x-long-flip-vs-cursor-atomic
[300.654627] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[300.793631] [032/134] (733s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[300.844947] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[300.845792] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[300.964069] [033/134] (733s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[301.069246] Starting subtest: fbcpsr-rgb101010-draw-blt
[307.870727] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.801s)
[308.002228] [034/134] (726s left) gem_exec_whisper (basic-forked-all)
[308.060507] Starting subtest: basic-forked-all
[321.325703] Subtest basic-forked-all: SUCCESS (13.260s)
[321.517703] [035/134] (712s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[321.622027] Starting subtest: fbcpsr-tiling-4
[328.689049] Subtest fbcpsr-tiling-4: SUCCESS (7.068s)
[328.853096] [036/134] (705s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[328.957024] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[328.958618] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[329.075207] [037/134] (705s left) syncobj_eventfd (invalid-bad-pad)
[329.117109] Starting subtest: invalid-bad-pad
[329.118493] Subtest invalid-bad-pad: SUCCESS (0.000s)
[329.236153] [038/134] (705s left) kms_dsc (dsc-with-formats)
[329.329007] Starting subtest: dsc-with-formats
[329.343879] Subtest dsc-with-formats: SKIP (0.001s)
[329.407529] [039/134] (704s left) kms_joiner (basic-force-ultra-joiner)
[329.500258] Starting subtest: basic-force-ultra-joiner
[329.501925] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[329.574815] [040/134] (704s left) gem_exec_reloc (basic-range)
[329.637746] Subtest basic-range: SKIP (0.000s)
[329.723285] [041/134] (704s left) gem_bad_reloc (negative-reloc-bltcopy)
[329.779896] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[329.869057] [042/134] (704s left) api_intel_bb (blit-noreloc-keep-cache)
[329.923110] Starting subtest: blit-noreloc-keep-cache
[329.933529] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s)
[330.022752] [043/134] (704s left) gem_spin_batch (legacy-resubmit)
[330.085358] Starting subtest: legacy-resubmit
[330.086374] Starting dynamic subtest: default
[330.092888] Dynamic subtest default: SUCCESS (0.007s)
[330.103382] Starting dynamic subtest: render
[330.104353] Dynamic subtest render: SUCCESS (0.001s)
[330.116529] Starting dynamic subtest: bsd
[330.121249] Dynamic subtest bsd: SUCCESS (0.003s)
[330.129108] Starting dynamic subtest: bsd1
[330.130060] Dynamic subtest bsd1: SUCCESS (0.003s)
[330.138096] Starting dynamic subtest: bsd2
[330.139080] Dynamic subtest bsd2: SUCCESS (0.001s)
[330.147613] Starting dynamic subtest: blt
[330.148565] Dynamic subtest blt: SUCCESS (0.003s)
[330.155973] Starting dynamic subtest: vebox
[330.156837] Dynamic subtest vebox: SUCCESS (0.003s)
[330.157726] Subtest legacy-resubmit: SUCCESS (0.026s)
[330.384514] [044/134] (704s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[330.473700] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[331.121098] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.648s)
[331.286338] [045/134] (703s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[331.379801] Starting subtest: fbc-psr-sprite-mmap-cpu
[331.380747] Starting dynamic subtest: eDP-1
[331.382617] Dynamic subtest eDP-1: SKIP (0.000s)
[331.384423] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.002s)
[331.460028] [046/134] (703s left) gem_ctx_exec (basic-invalid-context)
[331.510122] Starting subtest: basic-invalid-context
[331.516595] Subtest basic-invalid-context: SUCCESS (0.007s)
[331.639803] [047/134] (702s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[331.733452] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[331.734415] Starting dynamic subtest: pipe-A-default-mode
[332.017258] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[332.019058] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.284s)
[332.903305] [048/134] (701s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[332.998275] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[340.222924] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.225s)
[340.376675] [049/134] (694s left) gem_tiled_pread_pwrite
[340.495436] [050/134] (694s left) gem_lmem_swapping (parallel-random-verify)
[340.528892] Subtest parallel-random-verify: SKIP (0.000s)
[340.563448] [051/134] (694s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[345.611453] Starting subtest: psr2-cursor-plane-move-continuous-sf
[345.613440] Starting dynamic subtest: pipe-A-eDP-1
[356.690399] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.074s)
[356.700950] Starting dynamic subtest: pipe-B-eDP-1
[367.721225] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.026s)
[367.722253] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.106s)
[368.528129] [052/134] (666s left) gem_exec_schedule (reorder-wide)
[368.710712] Subtest reorder-wide: SKIP (0.000s)
[368.908033] [053/134] (665s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[369.000095] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[369.028627] Starting dynamic subtest: pipe-A-plane-0
[369.030400] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[369.038625] Starting dynamic subtest: pipe-A-plane-3
[369.040358] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[369.047912] Starting dynamic subtest: pipe-A-plane-5
[369.049618] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[370.103769] Starting dynamic subtest: pipe-B-plane-0
[370.105335] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[370.115649] Starting dynamic subtest: pipe-B-plane-3
[370.117623] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[370.126334] Starting dynamic subtest: pipe-B-plane-5
[370.127922] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[370.415888] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (1.415s)
[371.288201] [054/134] (663s left) perf (global-sseu-config-invalid)
[371.407075] Starting subtest: global-sseu-config-invalid
[371.408797] Subtest global-sseu-config-invalid: SKIP (0.000s)
[371.439500] [055/134] (663s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[371.552289] Starting subtest: cursorB-vs-flipA-varying-size
[371.555153] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[371.707127] [056/134] (663s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[371.817252] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[371.819099] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[371.936185] [057/134] (662s left) kms_dp_aux_dev
[372.298996] [058/134] (662s left) kms_psr (fbc-psr2-cursor-plane-move)
[372.389999] Starting subtest: fbc-psr2-cursor-plane-move
[372.390876] Starting dynamic subtest: eDP-1
[372.392499] Dynamic subtest eDP-1: SKIP (0.000s)
[372.394154] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[372.472613] [059/134] (662s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[372.574560] Starting subtest: x-tiled-32bpp-rotate-180
[373.956092] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.382s)
[374.118434] [060/134] (660s left) sw_sync (sync_expired_merge)
[374.147394] Starting subtest: sync_expired_merge
[375.223996] Subtest sync_expired_merge: SUCCESS (1.074s)
[375.287516] [061/134] (659s left) gem_exec_nop (basic-sequential)
[375.352753] Starting subtest: basic-sequential
[391.499093] Subtest basic-sequential: SUCCESS (16.144s)
[391.744121] [062/134] (643s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[391.838978] Starting subtest: compare-crc-sanitycheck-nv12
[391.839927] Starting dynamic subtest: pipe-A-eDP-1
[392.471640] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s)
[392.479681] Starting dynamic subtest: pipe-B-eDP-1
[393.713529] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.240s)
[393.721514] Starting dynamic subtest: pipe-C-eDP-1
[394.964922] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.250s)
[394.974189] Starting dynamic subtest: pipe-D-eDP-1
[396.218780] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s)
[396.219609] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.380s)
[397.036303] [063/134] (638s left) syncobj_wait (wait-for-submit-complex)
[397.097520] Starting subtest: wait-for-submit-complex
[397.159702] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[397.243109] [064/134] (637s left) gem_mmap_wc (bad-offset)
[397.298010] Subtest bad-offset: SKIP (0.000s)
[397.361999] [065/134] (637s left) gem_exec_reloc (basic-wc)
[397.423092] Subtest basic-wc: SKIP (0.000s)
[397.515825] [066/134] (637s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[397.613866] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[397.641542] Starting dynamic subtest: pipe-A-plane-0
[397.643477] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[397.652482] Starting dynamic subtest: pipe-A-plane-3
[397.656850] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[397.664405] Starting dynamic subtest: pipe-A-plane-5
[397.666052] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[398.711023] Starting dynamic subtest: pipe-B-plane-0
[398.712990] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[398.723216] Starting dynamic subtest: pipe-B-plane-3
[398.724896] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[398.732456] Starting dynamic subtest: pipe-B-plane-5
[398.734193] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[399.029100] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (1.414s)
[399.901452] [067/134] (635s left) kms_sequence (get-busy)
[399.995097] Starting subtest: get-busy
[399.995964] Starting dynamic subtest: pipe-A-eDP-1
[401.930018] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[401.939407] Starting dynamic subtest: pipe-B-eDP-1
[404.503483] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.571s)
[404.512739] Starting dynamic subtest: pipe-C-eDP-1
[407.143800] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.637s)
[407.168824] Starting dynamic subtest: pipe-D-eDP-1
[409.750327] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.604s)
[409.751250] Subtest get-busy: SUCCESS (9.755s)
[410.632935] [068/134] (624s left) syncobj_timeline (reset-multiple-signaled)
[410.687035] Starting subtest: reset-multiple-signaled
[410.688015] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[410.802537] [069/134] (624s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[410.904003] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[410.904802] Starting dynamic subtest: pipe-A-eDP-1
[410.912312] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[410.921050] Starting dynamic subtest: pipe-B-eDP-1
[410.928470] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[410.936753] Starting dynamic subtest: pipe-C-eDP-1
[410.944376] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[410.953948] Starting dynamic subtest: pipe-D-eDP-1
[410.961466] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[410.962336] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[413.120386] [070/134] (622s left) gem_exec_reloc (basic-wc-gtt)
[413.171705] Subtest basic-wc-gtt: SKIP (0.000s)
[413.250466] [071/134] (622s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[413.332122] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[413.332962] Starting dynamic subtest: pipe-A-eDP-1
[413.341218] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[413.349279] Starting dynamic subtest: pipe-B-eDP-1
[413.357613] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[413.365854] Starting dynamic subtest: pipe-C-eDP-1
[413.373844] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[413.381655] Starting dynamic subtest: pipe-D-eDP-1
[413.389810] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[413.391368] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[415.597387] [072/134] (619s left) kms_chamelium_frames (hdmi-crc-multiple)
[415.984262] Subtest hdmi-crc-multiple: SKIP (0.000s)
[416.785714] [073/134] (618s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[416.882786] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[425.432192] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.552s)
[425.567821] [074/134] (609s left) kms_pm_rpm (cursor-dpms)
[427.588044] Starting subtest: cursor-dpms
[427.590070] Subtest cursor-dpms: SKIP (0.000s)
[427.959018] [075/134] (607s left) gem_eio (wait-wedge-immediate)
[428.201437] Starting subtest: wait-wedge-immediate
[429.495698] Subtest wait-wedge-immediate: SUCCESS (1.293s)
[429.644090] [076/134] (605s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[429.739858] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[429.755044] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.014s)
[429.837309] [077/134] (605s left) i915_query (query-topology-matches-eu-total)
[429.883944] Starting subtest: query-topology-matches-eu-total
[429.884827] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[429.996512] [078/134] (605s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[430.094959] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[430.096505] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[430.212093] [079/134] (605s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[430.312771] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[430.313763] Starting dynamic subtest: pipe-A
[430.377416] Dynamic subtest pipe-A: SUCCESS (0.065s)
[430.387043] Starting dynamic subtest: pipe-B
[431.490482] Dynamic subtest pipe-B: SUCCESS (1.112s)
[431.500305] Starting dynamic subtest: pipe-C
[432.596601] Dynamic subtest pipe-C: SUCCESS (1.105s)
[432.604521] Starting dynamic subtest: pipe-D
[433.735906] Dynamic subtest pipe-D: SUCCESS (1.138s)
[433.736867] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.423s)
[434.895560] [080/134] (600s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[434.994013] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[434.994849] Starting dynamic subtest: pipe-A-eDP-1
[435.004913] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[435.014391] Starting dynamic subtest: pipe-B-eDP-1
[435.022472] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[435.030810] Starting dynamic subtest: pipe-C-eDP-1
[435.039112] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[435.046697] Starting dynamic subtest: pipe-D-eDP-1
[435.055328] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[435.057034] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[437.258533] [081/134] (598s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[437.345918] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[442.202360] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.856s)
[443.384613] [082/134] (592s left) kms_chamelium_hpd (common-hpd-after-suspend)
[443.759600] Subtest common-hpd-after-suspend: SKIP (0.000s)
[444.562159] [083/134] (591s left) drm_read (short-buffer-nonblock)
[444.701723] Starting subtest: short-buffer-nonblock
[444.702872] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[444.846430] [084/134] (590s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[444.948315] Starting subtest: psr-abgr161616f-draw-mmap-wc
[444.949956] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[445.076902] [085/134] (590s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[445.200187] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[445.201943] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[445.387210] [086/134] (590s left) gem_exec_schedule (noreorder-priority)
[445.564085] Starting subtest: noreorder-priority
[445.565340] Starting dynamic subtest: rcs0
[446.712509] Dynamic subtest rcs0: SUCCESS (1.148s)
[446.724851] Starting dynamic subtest: vcs0
[448.408606] Dynamic subtest vcs0: SUCCESS (1.691s)
[448.418936] Starting dynamic subtest: vcs1
[450.440751] Dynamic subtest vcs1: SUCCESS (2.029s)
[450.458494] Starting dynamic subtest: vecs0
[452.354648] Dynamic subtest vecs0: SUCCESS (1.911s)
[452.365225] Starting dynamic subtest: ccs0
[453.514418] Dynamic subtest ccs0: SUCCESS (1.160s)
[453.515747] Subtest noreorder-priority: SUCCESS (7.951s)
[453.709131] [087/134] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[453.801791] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[453.803546] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[453.923613] [088/134] (582s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[453.970461] Starting subtest: etime-single-wait-for-submit-submitted
[454.079013] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s)
[454.157755] [089/134] (581s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[454.217945] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[454.219950] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[454.415974] [090/134] (581s left) kms_addfb_basic (clobberred-modifier)
[454.476632] Starting subtest: clobberred-modifier
[454.478622] Subtest clobberred-modifier: SKIP (0.000s)
[454.630806] [091/134] (581s left) kms_cursor_crc (cursor-onscreen-64x64)
[454.810165] Starting subtest: cursor-onscreen-64x64
[454.814900] Starting dynamic subtest: pipe-A-eDP-1
[456.922246] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.108s)
[456.958298] Starting dynamic subtest: pipe-D-eDP-1
[459.661832] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.713s)
[459.662710] Subtest cursor-onscreen-64x64: SUCCESS (4.850s)
[460.486967] [092/134] (575s left) gem_unfence_active_buffers
[460.665568] [093/134] (575s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[460.768534] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[460.770131] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[460.905023] [094/134] (575s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[461.008890] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[462.428640] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.419s)
[463.251724] [095/134] (572s left) syncobj_basic (illegal-fd-to-handle)
[463.305911] Starting subtest: illegal-fd-to-handle
[463.306926] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[463.428406] [096/134] (572s left) kms_psr (fbc-pr-no-drrs)
[463.522924] Starting subtest: fbc-pr-no-drrs
[463.524580] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[463.605581] [097/134] (572s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[463.696492] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[463.698156] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[463.826837] [098/134] (572s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[463.915343] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[463.917104] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[464.033719] [099/134] (572s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[464.122055] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[464.123965] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[464.244228] [100/134] (572s left) gem_eio (kms)
[464.496746] Starting subtest: kms
[484.291090] Subtest kms: SUCCESS (19.790s)
[485.469571] [101/134] (550s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[485.560789] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[485.561613] Starting dynamic subtest: pipe-A-eDP-1
[485.570561] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[485.579163] Starting dynamic subtest: pipe-B-eDP-1
[485.588466] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[485.598815] Starting dynamic subtest: pipe-C-eDP-1
[485.607480] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[485.615395] Starting dynamic subtest: pipe-D-eDP-1
[485.624478] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[485.626128] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[487.744118] [102/134] (548s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[487.780444] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[487.817438] [103/134] (548s left) gem_spin_batch (user-each)
[487.878088] Starting subtest: user-each
[491.240398] Subtest user-each: SUCCESS (3.361s)
[491.504710] [104/134] (544s left) kms_big_fb (linear-64bpp-rotate-0)
[491.609722] Starting subtest: linear-64bpp-rotate-0
[493.088793] Subtest linear-64bpp-rotate-0: SUCCESS (1.479s)
[493.290649] [105/134] (543s left) drm_read (empty-nonblock)
[493.434736] Starting subtest: empty-nonblock
[493.435711] Subtest empty-nonblock: SUCCESS (0.000s)
[493.599924] [106/134] (542s left) syncobj_timeline (wait-for-submit-delayed-submit)
[493.654184] Starting subtest: wait-for-submit-delayed-submit
[493.758478] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[493.840759] [107/134] (542s left) core_debugfs (read-all-entries)
[493.891112] Starting subtest: read-all-entries
[493.972190] Subtest read-all-entries: SUCCESS (0.082s)
[494.045591] [108/134] (542s left) gem_mmap_offset (blt-coherency)
[494.110780] Starting subtest: blt-coherency
[494.116685] Subtest blt-coherency: SUCCESS (0.007s)
[494.270385] [109/134] (542s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[494.368651] Starting subtest: 4-tiled-8bpp-rotate-270
[494.389648] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[494.514791] [110/134] (542s left) kms_addfb_basic (invalid-set-prop-any)
[494.567188] Starting subtest: invalid-set-prop-any
[494.568787] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[494.699037] [111/134] (542s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[494.791072] Starting subtest: y-tiled-16bpp-rotate-90
[494.792892] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[494.908699] [112/134] (541s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[495.009112] Starting subtest: primary-y-tiled-reflect-x-270
[495.011011] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[495.089574] [113/134] (541s left) gen7_exec_parse (bitmasks)
[495.145892] Subtest bitmasks: SKIP (0.000s)
[495.211329] [114/134] (541s left) kms_content_protection (mei-interface)
[495.361702] Starting subtest: mei-interface
[495.364214] Subtest mei-interface: SKIP (0.001s)
[495.514581] [115/134] (541s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[495.634827] Starting subtest: flip-vs-cursor-legacy
[502.726955] Subtest flip-vs-cursor-legacy: SUCCESS (7.090s)
[503.581630] [116/134] (533s left) kms_vblank (ts-continuation-dpms-rpm)
[503.670038] Starting subtest: ts-continuation-dpms-rpm
[503.670971] Starting dynamic subtest: pipe-A-eDP-1
[506.152392] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.482s)
[506.161751] Starting dynamic subtest: pipe-D-eDP-1
[508.404743] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.246s)
[508.405568] Subtest ts-continuation-dpms-rpm: SUCCESS (4.732s)
[509.220575] [117/134] (527s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[509.317850] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[509.319518] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[509.423013] [118/134] (527s left) gem_busy (parallel)
[509.611488] Starting subtest: parallel
[509.612603] Starting dynamic subtest: rcs0
[511.403879] Dynamic subtest rcs0: SUCCESS (1.789s)
[511.415985] Starting dynamic subtest: bcs0
[513.387985] Dynamic subtest bcs0: SUCCESS (1.981s)
[513.399286] Starting dynamic subtest: vcs0
[515.371079] Dynamic subtest vcs0: SUCCESS (1.980s)
[515.382171] Starting dynamic subtest: vcs1
[517.418884] Dynamic subtest vcs1: SUCCESS (2.046s)
[517.430104] Starting dynamic subtest: vecs0
[519.404599] Dynamic subtest vecs0: SUCCESS (1.983s)
[519.415970] Starting dynamic subtest: ccs0
[521.387880] Dynamic subtest ccs0: SUCCESS (1.980s)
[521.389403] Subtest parallel: SUCCESS (11.774s)
[521.675927] [119/134] (515s left) prime_vgem (coherency-blt)
[521.779643] Starting subtest: coherency-blt
[523.546070] Subtest coherency-blt: SUCCESS (1.764s)
[523.697177] [120/134] (513s left) gem_exec_balancer (invalid-balancer)
[523.758904] Starting subtest: invalid-balancer
[524.653960] Subtest invalid-balancer: SUCCESS (0.892s)
[524.975654] [121/134] (512s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[525.073574] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[531.975525] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.898s)
[532.143179] [122/134] (504s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[532.244172] Starting subtest: yf-tiled-64bpp-rotate-90
[532.245951] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[532.358172] [123/134] (504s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[532.647146] Starting subtest: cursor-rapid-movement-max-size
[532.649672] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[532.797703] [124/134] (504s left) kms_color (ctm-green-to-red)
[532.890022] Starting subtest: ctm-green-to-red
[532.891014] Starting dynamic subtest: pipe-A-eDP-1
[533.563404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.674s)
[533.572233] Starting dynamic subtest: pipe-B-eDP-1
[534.882873] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.317s)
[534.891328] Starting dynamic subtest: pipe-C-eDP-1
[536.175509] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.293s)
[536.183760] Starting dynamic subtest: pipe-D-eDP-1
[537.516740] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[537.517560] Subtest ctm-green-to-red: SUCCESS (4.627s)
[538.358056] [125/134] (498s left) kms_flip (flip-vs-blocking-wf-vblank)
[538.445808] Starting subtest: flip-vs-blocking-wf-vblank
[538.447980] Starting dynamic subtest: A-eDP1
[547.400886] Dynamic subtest A-eDP1: SUCCESS (8.953s)
[547.410220] Starting dynamic subtest: B-eDP1
[556.327747] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[556.339853] Starting dynamic subtest: C-eDP1
[565.245896] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[565.256229] Starting dynamic subtest: D-eDP1
[574.171444] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[574.173934] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.724s)
[575.390871] [126/134] (461s left) gem_ctx_engines (independent)
[575.456817] Starting subtest: independent
[575.457718] Starting dynamic subtest: rcs0
[575.606017] Dynamic subtest rcs0: SUCCESS (0.147s)
[575.616838] Starting dynamic subtest: bcs0
[575.766742] Dynamic subtest bcs0: SUCCESS (0.160s)
[575.778063] Starting dynamic subtest: vcs0
[575.910058] Dynamic subtest vcs0: SUCCESS (0.143s)
[575.919712] Starting dynamic subtest: vcs1
[576.057967] Dynamic subtest vcs1: SUCCESS (0.147s)
[576.067034] Starting dynamic subtest: vecs0
[576.225073] Dynamic subtest vecs0: SUCCESS (0.166s)
[576.235644] Starting dynamic subtest: ccs0
[576.391935] Dynamic subtest ccs0: SUCCESS (0.166s)
[576.401233] Starting dynamic subtest: all-engines
[577.034102] Dynamic subtest all-engines: SUCCESS (0.641s)
[577.035017] Subtest independent: SUCCESS (1.576s)
[577.573440] [127/134] (459s left) i915_query (query-topology-coherent-slice-mask)
[577.628033] Starting subtest: query-topology-coherent-slice-mask
[577.629948] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[577.745489] [128/134] (459s left) sw_sync (sync_merge)
[577.785696] Starting subtest: sync_merge
[577.786654] Subtest sync_merge: SUCCESS (0.000s)
[577.851609] [129/134] (459s left) i915_drm_fdinfo (memory-info-resident)
[577.883546] Starting subtest: memory-info-resident
[577.884565] Starting dynamic subtest: smem0
[580.872655] Dynamic subtest smem0: SUCCESS (2.989s)
[580.874102] Subtest memory-info-resident: SUCCESS (2.991s)
[580.958104] [130/134] (456s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[581.060488] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[587.597541] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.537s)
[587.708376] [131/134] (449s left) kms_psr (psr2-sprite-plane-move)
[587.804503] Starting subtest: psr2-sprite-plane-move
[587.805424] Starting dynamic subtest: eDP-1
[589.533287] Dynamic subtest eDP-1: SUCCESS (1.728s)
[589.534119] Subtest psr2-sprite-plane-move: SUCCESS (1.729s)
[590.367583] [132/134] (447s left) kms_selftest (drm_cmdline_parser)
[590.403614] Starting subtest: drm_cmdline_parser
[590.446680] Starting dynamic subtest: drm_test_cmdline_force_d_only
[590.566847] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.119s)
[590.576500] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[590.679099] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.113s)
[590.688562] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[590.816983] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.135s)
[590.826360] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[590.952652] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.134s)
[590.962293] Starting dynamic subtest: drm_test_cmdline_force_e_only
[591.096741] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.143s)
[591.106120] Starting dynamic subtest: drm_test_cmdline_res
[591.214921] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.118s)
[591.224020] Starting dynamic subtest: drm_test_cmdline_res_vesa
[591.336851] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.121s)
[591.346016] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[591.429030] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.093s)
[591.438108] Starting dynamic subtest: drm_test_cmdline_res_rblank
[591.558466] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.125s)
[591.567724] Starting dynamic subtest: drm_test_cmdline_res_bpp
[591.680073] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.122s)
[591.688026] Starting dynamic subtest: drm_test_cmdline_res_refresh
[591.822975] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.143s)
[591.832118] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[591.901285] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.076s)
[591.910756] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[592.013654] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.112s)
[592.023021] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[592.132890] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.114s)
[592.142364] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[592.263895] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.130s)
[592.271982] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[592.383736] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.119s)
[592.391811] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[592.513813] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.130s)
[592.521974] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[592.636747] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.122s)
[592.645888] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[592.775817] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.138s)
[592.784494] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[592.887608] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.112s)
[592.896723] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[593.015984] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.126s)
[593.025117] Starting dynamic subtest: drm_test_cmdline_name
[593.142823] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.123s)
[593.151206] Starting dynamic subtest: drm_test_cmdline_name_bpp
[593.253586] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.111s)
[593.262443] Starting dynamic subtest: drm_test_cmdline_name_option
[593.372076] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.117s)
[593.380040] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[593.512128] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.140s)
[593.520045] Starting dynamic subtest: drm_test_cmdline_rotate_0
[593.642012] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.128s)
[593.651103] Starting dynamic subtest: drm_test_cmdline_rotate_90
[593.784858] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.140s)
[593.792733] Starting dynamic subtest: drm_test_cmdline_rotate_180
[593.928898] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.143s)
[593.937608] Starting dynamic subtest: drm_test_cmdline_rotate_270
[594.059771] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.130s)
[594.069427] Starting dynamic subtest: drm_test_cmdline_hmirror
[594.180800] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.120s)
[594.190068] Starting dynamic subtest: drm_test_cmdline_vmirror
[594.312025] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.130s)
[594.321511] Starting dynamic subtest: drm_test_cmdline_margin_options
[594.454734] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.143s)
[594.462545] Starting dynamic subtest: drm_test_cmdline_multiple_options
[594.591769] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.136s)
[594.599643] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[594.733625] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.141s)
[594.741527] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[594.848750] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.115s)
[594.858223] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[594.958363] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.110s)
[594.968310] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[595.039746] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.080s)
[595.050061] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[595.166834] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.126s)
[595.176584] Starting dynamic subtest: drm_test_cmdline_invalid
[595.308740] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.143s)
[595.316585] Starting dynamic subtest: drm_test_cmdline_tv_options
[595.437345] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.128s)
[595.438254] Subtest drm_cmdline_parser: SUCCESS (5.035s)
[595.637143] [133/134] (441s left) perf_pmu (semaphore-busy)
[595.673177] Starting subtest: semaphore-busy
[595.674059] Starting dynamic subtest: rcs0
[597.334596] Dynamic subtest rcs0: SUCCESS (1.657s)
[597.345618] Starting dynamic subtest: bcs0
[598.968984] Dynamic subtest bcs0: SUCCESS (1.631s)
[598.978423] Starting dynamic subtest: vcs0
[602.917307] Dynamic subtest vcs0: SUCCESS (3.945s)
[602.926959] Starting dynamic subtest: vcs1
[608.932279] Dynamic subtest vcs1: SUCCESS (6.011s)
[608.941045] Starting dynamic subtest: vecs0
[614.885634] Dynamic subtest vecs0: SUCCESS (5.951s)
[614.897050] Starting dynamic subtest: ccs0
[617.958194] Dynamic subtest ccs0: SUCCESS (3.068s)
[617.959738] Subtest semaphore-busy: SUCCESS (22.280s)
[618.086139] [134/134] (419s left) gem_pxp (reject-modify-context-protection-off-2)
[618.208938] Starting subtest: reject-modify-context-protection-off-2
[618.210028] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[618.337388] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_plane_cursor
results: parsing output: 4/ for test: kms_atomic_interruptible
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: i915_pm_rpm
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: core_getstats
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: i915_hangman
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: gem_partial_pwrite_pread
results: parsing output: 24/ for test: sysfs_heartbeat_interval
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_partial_pwrite_pread
results: parsing output: 27/ for test: i915_suspend
results: parsing output: 28/ for test: kms_cursor_edge_walk
results: parsing output: 29/ for test: gem_exec_parallel
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_whisper
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_eventfd
results: parsing output: 37/ for test: kms_dsc
results: parsing output: 38/ for test: kms_joiner
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: gem_bad_reloc
results: parsing output: 41/ for test: api_intel_bb
results: parsing output: 42/ for test: gem_spin_batch
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: gem_ctx_exec
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_tiled_pread_pwrite
results: parsing output: 49/ for test: gem_lmem_swapping
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: kms_plane
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_dp_aux_dev
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: sw_sync
results: parsing output: 60/ for test: gem_exec_nop
results: parsing output: 61/ for test: kms_pipe_crc_basic
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_plane
results: parsing output: 66/ for test: kms_sequence
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_chamelium_frames
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_pm_rpm
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: i915_query
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: drm_read
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: gem_unfence_active_buffers
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: syncobj_basic
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: gem_lmem_swapping
results: parsing output: 102/ for test: gem_spin_batch
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: drm_read
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: core_debugfs
results: parsing output: 107/ for test: gem_mmap_offset
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_addfb_basic
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_rotation_crc
results: parsing output: 112/ for test: gen7_exec_parse
results: parsing output: 113/ for test: kms_content_protection
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_busy
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_color
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: gem_ctx_engines
results: parsing output: 126/ for test: i915_query
results: parsing output: 127/ for test: sw_sync
results: parsing output: 128/ for test: i915_drm_fdinfo
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_selftest
results: parsing output: 132/ for test: perf_pmu
results: parsing output: 133/ for test: gem_pxp
Done.