[56.433605] Initializing watchdogs
[56.433651]   /dev/watchdog0
[56.448098] [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]
[56.453073] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.455405] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.458833] [001/132] (960s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[56.590091] Starting subtest: 4-tiled-addfb-size-offset-overflow
[56.592010] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[56.703253] [002/132] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[56.810957] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[56.813339] Starting dynamic subtest: pipe-A-eDP-1
[56.935342] Dynamic subtest pipe-A-eDP-1: SKIP (0.129s)
[56.945379] Starting dynamic subtest: pipe-B-eDP-1
[58.116934] Dynamic subtest pipe-B-eDP-1: SKIP (1.186s)
[58.121488] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.317s)
[59.291209] [003/132] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[59.387563] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[59.392082] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[59.466063] [004/132] (957s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[59.705027] Starting subtest: cursor-rapid-movement-256x256
[59.709485] Starting dynamic subtest: pipe-A-eDP-1
[60.306741] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s)
[60.327959] Starting dynamic subtest: pipe-D-eDP-1
[61.489502] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.171s)
[61.491924] Subtest cursor-rapid-movement-256x256: SUCCESS (1.791s)
[62.351524] [005/132] (954s left) syncobj_wait (wait-delayed-signal)
[62.420631] Starting subtest: wait-delayed-signal
[62.523679] Subtest wait-delayed-signal: SUCCESS (0.102s)
[62.608530] [006/132] (954s left) gem_ctx_param (root-set)
[62.668117] Starting subtest: root-set
[62.670494] Subtest root-set: SUCCESS (0.001s)
[62.791046] [007/132] (954s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[62.851617] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[62.856202] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[63.042559] [008/132] (954s left) i915_query (query-regions-garbage-items)
[63.104424] Starting subtest: query-regions-garbage-items
[63.106609] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[63.222084] [009/132] (954s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[63.303022] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[63.305220] Starting dynamic subtest: pipe-A-default-mode
[66.073052] Dynamic subtest pipe-A-default-mode: SUCCESS (2.775s)
[66.075504] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.776s)
[66.945224] [010/132] (950s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[67.318074] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[67.320411] Starting dynamic subtest: pipe-A
[67.381256] Dynamic subtest pipe-A: SUCCESS (0.065s)
[67.393632] Starting dynamic subtest: pipe-B
[68.520838] Dynamic subtest pipe-B: SUCCESS (1.141s)
[68.530597] Starting dynamic subtest: pipe-C
[69.630573] Dynamic subtest pipe-C: SUCCESS (1.110s)
[69.639542] Starting dynamic subtest: pipe-D
[70.756879] Dynamic subtest pipe-D: SUCCESS (1.127s)
[70.759390] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.446s)
[71.933865] [011/132] (945s left) kms_psr (fbc-psr2-primary-blt)
[72.043877] Starting subtest: fbc-psr2-primary-blt
[72.045958] Starting dynamic subtest: eDP-1
[72.050069] Dynamic subtest eDP-1: SKIP (0.000s)
[72.054210] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[72.125984] [012/132] (945s left) kms_pm_lpsp (kms-lpsp)
[73.234788] Starting subtest: kms-lpsp
[73.237258] Starting dynamic subtest: pipe-A-eDP-1
[73.382197] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.151s)
[73.678825] Subtest kms-lpsp: SUCCESS (0.448s)
[74.576828] [013/132] (942s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[74.640996] Starting subtest: multi-wait-available-unsubmitted-submitted
[74.643416] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[74.786974] [014/132] (942s left) kms_atomic_interruptible (universal-setplane-primary)
[74.897627] Starting subtest: universal-setplane-primary
[74.899958] Starting dynamic subtest: pipe-A-eDP-1
[82.283731] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.390s)
[82.285950] Subtest universal-setplane-primary: SUCCESS (7.391s)
[83.119805] [015/132] (934s left) api_intel_allocator (two-level-inception-interruptible)
[83.177876] Starting subtest: two-level-inception-interruptible
[88.638760] Subtest two-level-inception-interruptible: SUCCESS (5.407s)
[88.736657] [016/132] (928s left) kms_joiner (basic-force-ultra-joiner)
[88.860192] Starting subtest: basic-force-ultra-joiner
[88.864155] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[88.951409] [017/132] (928s left) kms_getfb (getfb-handle-zero)
[89.056926] Starting subtest: getfb-handle-zero
[89.059032] Subtest getfb-handle-zero: SUCCESS (0.000s)
[89.190514] [018/132] (928s left) kms_fbcon_fbt (psr)
[89.257565] Starting subtest: psr
[96.518199] Subtest psr: SUCCESS (7.257s)
[96.589093] [019/132] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[96.689742] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[96.694250] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[96.816625] [020/132] (920s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[97.196606] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[98.043243] [021/132] (919s left) gem_exec_whisper (basic-sync-all)
[98.105954] Starting subtest: basic-sync-all
[104.079477] Subtest basic-sync-all: SUCCESS (5.975s)
[104.284720] [022/132] (913s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[104.391422] Starting subtest: x-tiled-32bpp-rotate-90
[104.411195] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[104.544946] [023/132] (913s left) kms_psr (fbc-pr-basic)
[104.657224] Starting subtest: fbc-pr-basic
[104.661741] Subtest fbc-pr-basic: SKIP (0.000s)
[104.753031] [024/132] (913s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[104.867633] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[104.871980] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[104.987754] [025/132] (912s left) perf_pmu (init-wait)
[105.027462] Starting subtest: init-wait
[105.029773] Starting dynamic subtest: rcs0
[105.031958] Dynamic subtest rcs0: SUCCESS (0.002s)
[105.039152] Starting dynamic subtest: bcs0
[105.040989] Dynamic subtest bcs0: SUCCESS (0.001s)
[105.047600] Starting dynamic subtest: vcs0
[105.049895] Dynamic subtest vcs0: SUCCESS (0.001s)
[105.056671] Starting dynamic subtest: vcs1
[105.058746] Dynamic subtest vcs1: SUCCESS (0.001s)
[105.067671] Starting dynamic subtest: vecs0
[105.069758] Dynamic subtest vecs0: SUCCESS (0.001s)
[105.076714] Starting dynamic subtest: ccs0
[105.078844] Dynamic subtest ccs0: SUCCESS (0.000s)
[105.081024] Subtest init-wait: SUCCESS (0.008s)
[105.143916] [026/132] (912s left) kms_legacy_colorkey (invalid-plane)
[105.241027] Starting subtest: invalid-plane
[105.243054] Starting dynamic subtest: zero-id
[105.244849] Dynamic subtest zero-id: SUCCESS (0.000s)
[105.253101] Starting dynamic subtest: outrange-id
[105.254900] Dynamic subtest outrange-id: SUCCESS (0.000s)
[105.256492] Subtest invalid-plane: SUCCESS (0.001s)
[105.325818] [027/132] (912s left) kms_vblank (wait-busy-hang)
[105.429442] Starting subtest: wait-busy-hang
[105.431064] Starting dynamic subtest: pipe-A-eDP-1
[131.670212] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.240s)
[131.684165] Starting dynamic subtest: pipe-D-eDP-1
[156.707442] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.031s)
[156.709395] Subtest wait-busy-hang: SUCCESS (51.274s)
[157.560627] [028/132] (860s left) syncobj_eventfd (binary-wait)
[157.619097] Starting subtest: binary-wait
[157.628066] Subtest binary-wait: SUCCESS (0.010s)
[157.725401] [029/132] (860s left) gem_mmap_gtt (basic-read-write)
[157.785405] Subtest basic-read-write: SKIP (0.000s)
[157.842573] [030/132] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[157.957359] Starting subtest: basic-busy-flip-before-cursor-varying-size
[157.961997] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[158.139560] [031/132] (860s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[158.255048] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[162.754424] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.504s)
[163.966588] [032/132] (854s left) gem_exec_fence (syncobj-repeat)
[164.421774] Starting subtest: syncobj-repeat
[164.601067] Subtest syncobj-repeat: SUCCESS (0.178s)
[166.012723] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[166.015724] [033/132] (852s left) gem_mmap_gtt (basic-wc)
[166.072487] Subtest basic-wc: SKIP (0.000s)
[166.144959] [034/132] (852s left) kms_atomic (test-only)
[166.236453] Starting subtest: test-only
[166.287059] Starting dynamic subtest: pipe-A-eDP-1
[168.757588] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.472s)
[168.759867] Subtest test-only: SUCCESS (2.521s)
[169.633099] [035/132] (848s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[169.748590] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[169.752661] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[169.866658] [036/132] (848s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[169.990944] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[171.491874] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.502s)
[172.410443] [037/132] (845s left) kms_vrr (seamless-rr-switch-drrs)
[172.498272] Starting subtest: seamless-rr-switch-drrs
[172.504896] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[172.601659] [038/132] (845s left) kms_content_protection (content-type-change)
[172.739488] Starting subtest: content-type-change
[172.743993] Subtest content-type-change: SKIP (0.000s)
[172.902048] [039/132] (845s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[172.999272] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[173.003640] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[173.079566] [040/132] (845s left) i915_pm_rpm (system-suspend-devices)
[175.106498] Starting subtest: system-suspend-devices
[185.586481] Subtest system-suspend-devices: SUCCESS (10.479s)
[192.997926] [041/132] (832s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[193.125258] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[194.260647] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.135s)
[194.453751] [042/132] (831s left) gem_mmap_gtt (basic-write-read-distinct)
[194.521319] Subtest basic-write-read-distinct: SKIP (0.000s)
[194.595290] [043/132] (831s left) gem_ctx_shared (q-in-order)
[194.664543] Starting subtest: Q-in-order
[194.666813] Starting dynamic subtest: rcs0
[194.763052] Dynamic subtest rcs0: SUCCESS (0.098s)
[194.779078] Starting dynamic subtest: vcs0
[194.845375] Dynamic subtest vcs0: SUCCESS (0.081s)
[194.861602] Starting dynamic subtest: vcs1
[194.919540] Dynamic subtest vcs1: SUCCESS (0.074s)
[194.935973] Starting dynamic subtest: vecs0
[194.990912] Dynamic subtest vecs0: SUCCESS (0.070s)
[195.007564] Starting dynamic subtest: ccs0
[195.060688] Dynamic subtest ccs0: SUCCESS (0.069s)
[195.063564] Subtest Q-in-order: SUCCESS (0.396s)
[196.057027] [044/132] (829s left) syncobj_timeline (wait-all-complex)
[196.112045] Starting subtest: wait-all-complex
[196.327446] Subtest wait-all-complex: SUCCESS (0.213s)
[196.413473] [045/132] (829s left) kms_async_flips (alternate-sync-async-flip-atomic)
[196.513218] Starting subtest: alternate-sync-async-flip-atomic
[196.884671] Starting dynamic subtest: pipe-A-eDP-1
[199.646788] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.763s)
[200.024428] Starting dynamic subtest: pipe-B-eDP-1
[202.777904] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.760s)
[203.145679] Starting dynamic subtest: pipe-C-eDP-1
[205.906129] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[206.299318] Starting dynamic subtest: pipe-D-eDP-1
[209.041821] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.749s)
[209.043904] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.531s)
[210.246908] [046/132] (815s left) gem_ctx_create (basic-files)
[210.331911] Starting subtest: basic-files
[212.341314] Subtest basic-files: SUCCESS (2.009s)
[213.967391] [047/132] (811s left) gem_tiling_max_stride
[214.096490] [048/132] (811s left) i915_drm_fdinfo (virtual-idle)
[214.140308] Starting subtest: virtual-idle
[217.231858] Subtest virtual-idle: SUCCESS (3.091s)
[217.319446] [049/132] (808s left) kms_chamelium_edid (dp-edid-read)
[217.707262] Subtest dp-edid-read: SKIP (0.000s)
[218.519056] [050/132] (807s left) gem_ctx_persistence (process)
[218.590687] Starting subtest: process
[218.809032] Subtest process: SUCCESS (0.218s)
[218.899985] [051/132] (807s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[218.997902] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[219.000214] Starting dynamic subtest: pipe-A-eDP-1
[219.009453] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[219.020964] Starting dynamic subtest: pipe-B-eDP-1
[219.029920] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[219.038726] Starting dynamic subtest: pipe-C-eDP-1
[219.047309] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[219.055707] Starting dynamic subtest: pipe-D-eDP-1
[219.064284] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[219.068614] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[221.339680] [052/132] (804s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[221.456840] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[221.459085] Starting dynamic subtest: A-eDP1
[225.064506] Dynamic subtest A-eDP1: SUCCESS (3.604s)
[225.075992] Starting dynamic subtest: B-eDP1
[228.259541] Dynamic subtest B-eDP1: SUCCESS (3.195s)
[228.268285] Starting dynamic subtest: C-eDP1
[231.352234] Dynamic subtest C-eDP1: SUCCESS (3.093s)
[231.361042] Starting dynamic subtest: D-eDP1
[234.470424] Dynamic subtest D-eDP1: SUCCESS (3.115s)
[234.472811] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.015s)
[235.276642] [053/132] (790s left) core_setmaster (master-drop-set-shared-fd)
[235.377776] Starting subtest: master-drop-set-shared-fd
[235.399278] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[235.438059] [054/132] (790s left) api_intel_bb (simple-bb)
[235.496767] Starting subtest: simple-bb
[235.499829] Subtest simple-bb: SUCCESS (0.006s)
[235.643756] [055/132] (790s left) gem_exec_suspend (basic-s3-devices)
[235.712399] Starting subtest: basic-S3-devices
[235.714829] Starting dynamic subtest: smem
[246.870073] Dynamic subtest smem: SUCCESS (11.154s)
[246.872822] Subtest basic-S3-devices: SUCCESS (11.156s)
[247.066127] [056/132] (779s left) gem_exec_reloc (basic-write-gtt-active)
[247.138800] Subtest basic-write-gtt-active: SKIP (0.000s)
[247.224815] [057/132] (779s left) syncobj_wait (single-wait-all-submitted)
[247.284446] Starting subtest: single-wait-all-submitted
[247.393830] Subtest single-wait-all-submitted: SUCCESS (0.107s)
[247.484371] [058/132] (778s left) gem_exec_schedule (submit-late-slice)
[247.549506] Starting subtest: submit-late-slice
[247.551817] Starting dynamic subtest: rcs0
[247.612438] Dynamic subtest rcs0: SUCCESS (0.068s)
[247.624991] Starting dynamic subtest: bcs0
[247.661588] Dynamic subtest bcs0: SUCCESS (0.048s)
[247.672861] Starting dynamic subtest: vcs0
[247.715082] Dynamic subtest vcs0: SUCCESS (0.053s)
[247.726108] Starting dynamic subtest: vcs1
[247.767591] Dynamic subtest vcs1: SUCCESS (0.052s)
[247.776267] Starting dynamic subtest: vecs0
[247.807067] Dynamic subtest vecs0: SUCCESS (0.039s)
[247.815782] Starting dynamic subtest: ccs0
[247.860295] Dynamic subtest ccs0: SUCCESS (0.052s)
[247.862636] Subtest submit-late-slice: SUCCESS (0.317s)
[249.047549] [059/132] (777s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[249.175733] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[249.190210] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.015s)
[249.316183] [060/132] (777s left) gem_pxp (create-valid-protected-context)
[249.435201] Starting subtest: create-valid-protected-context
[249.437520] Subtest create-valid-protected-context: SUCCESS (0.001s)
[249.550836] [061/132] (776s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[249.637756] Starting subtest: fbcpsr-tiling-linear
[256.329170] Subtest fbcpsr-tiling-linear: SUCCESS (6.694s)
[256.512462] [062/132] (770s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[256.621277] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[256.623449] Starting dynamic subtest: pipe-A-eDP-1
[256.694313] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[256.704180] Starting dynamic subtest: pipe-B-eDP-1
[257.818594] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[257.822925] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.200s)
[259.137346] [063/132] (767s left) gem_ctx_persistence (engines-mixed-process)
[259.204507] Starting subtest: engines-mixed-process
[259.207062] Starting dynamic subtest: rcs0
[260.867873] Dynamic subtest rcs0: SUCCESS (1.660s)
[260.877740] Starting dynamic subtest: bcs0
[262.866828] Dynamic subtest bcs0: SUCCESS (2.000s)
[262.877689] Starting dynamic subtest: vcs0
[264.943967] Dynamic subtest vcs0: SUCCESS (2.076s)
[264.955936] Starting dynamic subtest: vcs1
[266.913613] Dynamic subtest vcs1: SUCCESS (1.968s)
[266.924527] Starting dynamic subtest: vecs0
[268.906852] Dynamic subtest vecs0: SUCCESS (1.991s)
[268.918757] Starting dynamic subtest: ccs0
[270.903219] Dynamic subtest ccs0: SUCCESS (1.994s)
[270.905769] Subtest engines-mixed-process: SUCCESS (11.699s)
[270.992816] [064/132] (755s left) gem_ccs (block-copy-compressed)
[271.047265] Starting subtest: block-copy-compressed
[271.051746] Subtest block-copy-compressed: SKIP (0.000s)
[271.178759] [065/132] (755s left) gem_eio (unwedge-stress)
[271.421725] Starting subtest: unwedge-stress
[271.423550] Starting dynamic subtest: render
[276.606769] Dynamic subtest render: SUCCESS (5.183s)
[276.622858] Starting dynamic subtest: bsd1
[296.376218] Dynamic subtest bsd1: SUCCESS (19.767s)
[296.392814] Starting dynamic subtest: bsd2
[314.406394] Dynamic subtest bsd2: SUCCESS (18.028s)
[314.422317] Starting dynamic subtest: blt
[314.426539] Dynamic subtest blt: SKIP (0.000s)
[314.435574] Starting dynamic subtest: vebox
[332.490704] Dynamic subtest vebox: SUCCESS (18.082s)
[332.492903] Subtest unwedge-stress: SUCCESS (61.067s)
[333.972441] [066/132] (692s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[334.046546] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[334.103693] [067/132] (692s left) kms_flip (busy-flip)
[334.205582] Starting subtest: busy-flip
[334.207904] Starting dynamic subtest: A-eDP1
[335.917637] Dynamic subtest A-eDP1: SUCCESS (1.711s)
[335.930518] Starting dynamic subtest: B-eDP1
[337.561787] Dynamic subtest B-eDP1: SUCCESS (1.642s)
[337.572525] Starting dynamic subtest: C-eDP1
[339.280850] Dynamic subtest C-eDP1: SUCCESS (1.718s)
[339.291639] Starting dynamic subtest: D-eDP1
[340.917558] Dynamic subtest D-eDP1: SUCCESS (1.636s)
[340.922561] Subtest busy-flip: SUCCESS (6.716s)
[342.196324] [068/132] (684s left) i915_drm_fdinfo (virtual-busy-hang)
[342.241112] Starting subtest: virtual-busy-hang
[342.245214] Subtest virtual-busy-hang: SKIP (0.000s)
[342.331387] [069/132] (684s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[342.435717] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[342.439806] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[342.533075] [070/132] (684s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[342.637247] Starting subtest: invalidate-primary-flip-overlay
[353.480792] Subtest invalidate-primary-flip-overlay: SUCCESS (10.846s)
[353.608096] [071/132] (673s left) kms_pm_rpm (system-suspend-idle)
[355.129821] Starting subtest: system-suspend-idle
[375.055908] Subtest system-suspend-idle: SUCCESS (4.328s)
[375.455442] [072/132] (651s left) gem_ccs (suspend-resume)
[375.529645] Starting subtest: suspend-resume
[375.533904] Subtest suspend-resume: SKIP (0.000s)
[375.645892] [073/132] (651s left) kms_big_fb (linear-16bpp-rotate-180)
[375.752369] Starting subtest: linear-16bpp-rotate-180
[377.183853] Subtest linear-16bpp-rotate-180: SUCCESS (1.457s)
[377.337574] [074/132] (649s left) kms_plane_lowres (tiling-x)
[377.433552] Starting subtest: tiling-x
[377.435503] Starting dynamic subtest: pipe-A-eDP-1
[377.439193] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[377.728060] Starting dynamic subtest: pipe-B-eDP-1
[377.732585] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[377.743246] Starting dynamic subtest: pipe-C-eDP-1
[377.747837] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[377.756846] Starting dynamic subtest: pipe-D-eDP-1
[377.760867] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[377.764906] Subtest tiling-x: SKIP (0.295s)
[378.530301] [075/132] (648s left) gem_close_race (basic-threads)
[378.606445] Starting subtest: basic-threads
[379.940277] Subtest basic-threads: SUCCESS (1.351s)
[380.137016] [076/132] (646s left) kms_getfb (getfb-handle-protection)
[380.232309] Starting subtest: getfb-handle-protection
[380.255740] Subtest getfb-handle-protection: SUCCESS (0.025s)
[380.389859] [077/132] (646s left) kms_feature_discovery (display)
[380.480946] Starting subtest: display
[380.483100] Subtest display: SUCCESS (0.000s)
[380.566656] [078/132] (646s left) kms_chamelium_color (ctm-0-25)
[380.657067] Subtest ctm-0-25: SKIP (0.000s)
[380.703620] [079/132] (646s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[380.801134] Starting subtest: y-tiled-8bpp-rotate-180
[380.805283] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[380.926121] [080/132] (646s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[381.046919] Starting subtest: flip-vs-cursor-crc-atomic
[381.699587] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.657s)
[382.515696] [081/132] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[382.617560] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[390.021197] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.447s)
[390.156155] [082/132] (637s left) kms_frontbuffer_tracking (psr-1p-rte)
[390.271748] Starting subtest: psr-1p-rte
[395.750868] Subtest psr-1p-rte: SUCCESS (5.496s)
[395.919944] [083/132] (631s left) gem_wait (write-wait)
[395.980608] Starting subtest: write-wait
[395.982618] Starting dynamic subtest: all-engines
[397.077711] Dynamic subtest all-engines: SUCCESS (1.102s)
[397.097979] Starting dynamic subtest: rcs0
[398.135413] Dynamic subtest rcs0: SUCCESS (1.058s)
[398.151847] Starting dynamic subtest: bcs0
[399.192816] Dynamic subtest bcs0: SUCCESS (1.057s)
[399.210069] Starting dynamic subtest: vcs0
[400.248666] Dynamic subtest vcs0: SUCCESS (1.055s)
[400.263222] Starting dynamic subtest: vcs1
[401.301662] Dynamic subtest vcs1: SUCCESS (1.052s)
[401.318190] Starting dynamic subtest: vecs0
[402.354837] Dynamic subtest vecs0: SUCCESS (1.052s)
[402.369939] Starting dynamic subtest: ccs0
[403.415024] Dynamic subtest ccs0: SUCCESS (1.059s)
[403.417466] Subtest write-wait: SUCCESS (7.449s)
[403.630096] [084/132] (623s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[403.735620] Starting subtest: bad-pixel-format-y-tiled-ccs
[403.738028] Starting dynamic subtest: pipe-A-eDP-1
[403.761016] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[403.772389] Starting dynamic subtest: pipe-B-eDP-1
[403.793713] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[403.802498] Starting dynamic subtest: pipe-C-eDP-1
[403.823853] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[403.832434] Starting dynamic subtest: pipe-D-eDP-1
[403.854317] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[403.858714] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[406.090055] [085/132] (621s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[406.206223] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[406.210308] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[406.328268] [086/132] (621s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[406.419859] Starting subtest: fbc-shrfb-scaledprimary
[409.409989] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.990s)
[410.570310] [087/132] (617s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[410.675963] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[410.678251] Starting dynamic subtest: pipe-A-eDP-1
[410.701761] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[410.711507] Starting dynamic subtest: pipe-B-eDP-1
[410.733461] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[410.742216] Starting dynamic subtest: pipe-C-eDP-1
[410.763856] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[410.772322] Starting dynamic subtest: pipe-D-eDP-1
[410.794279] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[410.798365] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[412.853741] [088/132] (614s left) gen9_exec_parse (bb-large)
[412.905398] Subtest bb-large: SKIP (0.000s)
[412.988181] [089/132] (614s left) perf (i915-ref-count)
[413.082677] Starting subtest: i915-ref-count
[413.153422] Subtest i915-ref-count: SUCCESS (0.068s)
[413.223445] [090/132] (614s left) sw_sync (alloc_fence_invalid_timeline)
[413.261946] Starting subtest: alloc_fence_invalid_timeline
[413.263962] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[413.336039] [091/132] (614s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[413.436916] Starting subtest: psr-modesetfrombusy
[419.707862] Subtest psr-modesetfrombusy: SUCCESS (6.275s)
[419.879934] [092/132] (607s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[419.987976] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[419.991339] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[420.091965] [093/132] (607s left) gem_softpin (allocator-basic)
[420.153744] Starting subtest: allocator-basic
[420.220932] Subtest allocator-basic: SUCCESS (0.066s)
[420.388775] [094/132] (607s left) gem_render_copy (linear-to-vebox-y-tiled)
[420.437902] Starting subtest: linear-to-vebox-y-tiled
[420.441355] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[420.648813] [095/132] (607s left) gem_mmap_gtt (hang)
[420.708607] Subtest hang: SKIP (0.000s)
[420.778607] [096/132] (607s left) gem_exec_schedule (out-order)
[420.855721] Starting subtest: out-order
[420.857990] Starting dynamic subtest: rcs0
[420.949104] Dynamic subtest rcs0: SUCCESS (0.101s)
[420.961075] Starting dynamic subtest: vcs0
[421.028399] Dynamic subtest vcs0: SUCCESS (0.079s)
[421.040838] Starting dynamic subtest: vcs1
[421.104313] Dynamic subtest vcs1: SUCCESS (0.075s)
[421.117222] Starting dynamic subtest: vecs0
[421.181173] Dynamic subtest vecs0: SUCCESS (0.076s)
[421.191884] Starting dynamic subtest: ccs0
[421.260578] Dynamic subtest ccs0: SUCCESS (0.078s)
[421.263048] Subtest out-order: SUCCESS (0.413s)
[422.682488] [097/132] (605s left) gem_exec_reloc (basic-scanout)
[422.760040] Subtest basic-scanout: SKIP (0.000s)
[422.855958] [098/132] (605s left) kms_psr (fbc-psr-primary-render)
[422.945468] Starting subtest: fbc-psr-primary-render
[422.947744] Starting dynamic subtest: eDP-1
[422.951929] Dynamic subtest eDP-1: SKIP (0.000s)
[422.955962] Subtest fbc-psr-primary-render: SKIP (0.001s)
[423.029593] [099/132] (605s left) prime_mmap (test_correct_cpu_write)
[423.085311] Starting subtest: test_correct_cpu_write
[423.087182] Starting dynamic subtest: test_correct_cpu_write-smem
[423.089025] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[423.090898] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[423.203312] [100/132] (604s left) syncobj_timeline (invalid-signal-zero-handles)
[423.256756] Starting subtest: invalid-signal-zero-handles
[423.259018] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[423.374704] [101/132] (604s left) kms_cursor_legacy (torture-bo)
[423.496270] Starting subtest: torture-bo
[423.498149] Starting dynamic subtest: pipe-A
[429.530305] Dynamic subtest pipe-A: SUCCESS (6.031s)
[429.543221] Starting dynamic subtest: pipe-B
[436.074648] Dynamic subtest pipe-B: SUCCESS (6.544s)
[436.086622] Starting dynamic subtest: pipe-C
[442.374868] Dynamic subtest pipe-C: SUCCESS (6.300s)
[442.389089] Starting dynamic subtest: pipe-D
[449.936067] Dynamic subtest pipe-D: SUCCESS (7.560s)
[449.949541] Starting dynamic subtest: all-pipes
[457.667668] Dynamic subtest all-pipes: SUCCESS (7.733s)
[457.670091] Subtest torture-bo: SUCCESS (34.178s)
[457.833986] [102/132] (570s left) kms_cursor_crc (cursor-onscreen-32x10)
[457.999797] Starting subtest: cursor-onscreen-32x10
[458.050815] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[458.322610] [103/132] (569s left) gem_mmap_offset (partial-mmap)
[458.384293] Starting subtest: partial-mmap
[458.386469] Starting dynamic subtest: smem0
[458.388728] Dynamic subtest smem0: SUCCESS (0.004s)
[458.390542] Subtest partial-mmap: SUCCESS (0.004s)
[458.540308] [104/132] (569s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[458.634651] Starting subtest: plane-lut1d-ctm3x4-lut1d
[458.647908] Starting dynamic subtest: pipe-A-eDP-1
[459.304579] Dynamic subtest pipe-A-eDP-1: FAIL (0.332s)
[460.062868] Starting dynamic subtest: pipe-B-eDP-1
[460.928648] Dynamic subtest pipe-B-eDP-1: FAIL (0.323s)
[461.503402] Starting dynamic subtest: pipe-C-eDP-1
[462.308160] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[462.829364] Starting dynamic subtest: pipe-D-eDP-1
[463.634353] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[463.636295] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.723s)
[464.228111] [105/132] (564s left) gem_userptr_blits (unsync-overlap)
[464.305436] Subtest unsync-overlap: SKIP (0.000s)
[464.468804] [106/132] (563s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[464.572423] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[464.576710] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[464.702291] [107/132] (563s left) kms_selftest (drm_damage_helper)
[464.750538] Starting subtest: drm_damage_helper
[464.796283] Starting dynamic subtest: drm_test_damage_iter_no_damage
[464.933105] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.136s)
[464.943739] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[465.045778] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.112s)
[465.054887] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[465.165464] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.118s)
[465.176431] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[465.291704] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.126s)
[465.301874] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[465.422478] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.130s)
[465.431716] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[465.550708] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.127s)
[465.560270] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[465.685486] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.135s)
[465.695537] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[465.819652] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.133s)
[465.830271] Starting dynamic subtest: drm_test_damage_iter_single_damage
[465.964727] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.144s)
[465.975368] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[466.066744] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.101s)
[466.077771] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[466.172878] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.105s)
[466.184428] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[466.281714] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.109s)
[466.291001] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[466.374063] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.092s)
[466.385457] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[466.514841] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.138s)
[466.530286] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[466.612785] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.098s)
[466.622006] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[466.731071] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.117s)
[466.740627] Starting dynamic subtest: drm_test_damage_iter_damage
[466.821824] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.092s)
[466.830916] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[466.957877] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.134s)
[466.967332] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[467.042780] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.085s)
[467.052264] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[467.143642] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.100s)
[467.153259] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[467.279636] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.135s)
[467.281575] Subtest drm_damage_helper: SUCCESS (2.527s)
[467.460505] [108/132] (561s left) gem_exec_capture (capture-recoverable)
[467.521902] Starting subtest: capture-recoverable
[467.527233] Subtest capture-recoverable: SUCCESS (0.005s)
[467.687121] [109/132] (560s left) gem_tiled_swapping (non-threaded)
[467.737195] Subtest non-threaded: SKIP (0.000s)
[467.804778] [110/132] (560s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[467.927593] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[467.929786] Starting dynamic subtest: pipe-A-eDP-1
[468.760076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.823s)
[468.771388] Starting dynamic subtest: pipe-B-eDP-1
[470.348586] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.587s)
[470.360751] Starting dynamic subtest: pipe-C-eDP-1
[471.829208] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.475s)
[471.839354] Starting dynamic subtest: pipe-D-eDP-1
[473.357551] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.529s)
[473.359484] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.420s)
[474.551872] [111/132] (554s left) gem_exec_balancer (full-pulse)
[474.617401] Starting subtest: full-pulse
[479.481397] Subtest full-pulse: SUCCESS (4.861s)
[479.830157] [112/132] (548s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[479.934296] Starting subtest: fbc-rgb565-draw-render
[484.164761] Subtest fbc-rgb565-draw-render: SUCCESS (4.232s)
[485.349991] [113/132] (543s left) kms_flip (flip-vs-panning-vs-hang)
[485.468437] Starting subtest: flip-vs-panning-vs-hang
[485.470843] Starting dynamic subtest: A-eDP1
[525.019181] Dynamic subtest A-eDP1: SUCCESS (39.551s)
[525.031422] Starting dynamic subtest: D-eDP1
[573.014098] Dynamic subtest D-eDP1: SUCCESS (48.002s)
[573.018940] Subtest flip-vs-panning-vs-hang: SUCCESS (87.560s)
[574.205046] [114/132] (454s left) kms_addfb_basic (clobberred-modifier)
[574.263778] Starting subtest: clobberred-modifier
[574.268253] Subtest clobberred-modifier: SKIP (0.000s)
[574.440029] [115/132] (454s left) gem_lmem_swapping (smem-oom)
[574.484449] Subtest smem-oom: SKIP (0.000s)
[574.535054] [116/132] (454s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[574.626752] Starting subtest: coverage-vs-premult-vs-constant
[574.903389] Starting dynamic subtest: pipe-A-eDP-1
[575.487875] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[575.497928] Starting dynamic subtest: pipe-D-eDP-1
[576.812908] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[576.815421] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.187s)
[577.688472] [117/132] (451s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[577.796434] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[577.800381] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[577.912585] [118/132] (450s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[577.961686] Starting subtest: etime-single-wait-for-submit-submitted
[578.067533] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.105s)
[578.155960] [119/132] (450s left) gem_softpin (noreloc)
[578.218602] Starting subtest: noreloc
[583.683904] Subtest noreloc: SUCCESS (5.412s)
[583.802026] [120/132] (445s left) gem_render_tiled_blits (basic)
[583.864940] Subtest basic: SKIP (0.000s)
[583.935165] [121/132] (445s left) kms_psr (pr-suspend)
[584.032572] Starting subtest: pr-suspend
[584.037190] Subtest pr-suspend: SKIP (0.000s)
[584.129245] [122/132] (444s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[584.184077] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[584.291076] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[584.380323] [123/132] (444s left) kms_psr (psr-cursor-blt)
[584.477151] Starting subtest: psr-cursor-blt
[584.479476] Starting dynamic subtest: eDP-1
[586.163522] Dynamic subtest eDP-1: SUCCESS (1.686s)
[586.165936] Subtest psr-cursor-blt: SUCCESS (1.687s)
[587.053042] [124/132] (442s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[587.160618] Starting subtest: fbc-rgb565-draw-mmap-gtt
[587.165047] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[587.271391] [125/132] (441s left) gem_exec_params (sol-reset-not-gen7)
[587.338438] Starting subtest: sol-reset-not-gen7
[587.343921] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[587.484215] [126/132] (441s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[587.588335] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[587.592837] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[587.719900] [127/132] (441s left) kms_plane (planar-pixel-format-settings)
[587.811983] Starting subtest: planar-pixel-format-settings
[587.877151] Subtest planar-pixel-format-settings: SUCCESS (0.065s)
[588.011087] [128/132] (441s left) gem_exec_whisper (basic-fds-priority-all)
[588.071049] Starting subtest: basic-fds-priority-all
[610.557880] Subtest basic-fds-priority-all: SUCCESS (22.482s)
[610.755199] [129/132] (418s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[610.811687] Starting subtest: invalid-single-wait-all-unsubmitted
[610.814397] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[610.953246] [130/132] (418s left) kms_flip (2x-flip-vs-expired-vblank)
[611.050943] Starting subtest: 2x-flip-vs-expired-vblank
[611.059989] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[611.150377] [131/132] (418s left) gem_exec_flush (basic-batch-kernel-default-uc)
[611.211315] Starting subtest: basic-batch-kernel-default-uc
[618.453522] Subtest basic-batch-kernel-default-uc: SUCCESS (7.240s)
[618.679128] [132/132] (410s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[618.783022] Starting subtest: fbcpsr-modesetfrombusy
[625.036527] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.257s)
[625.221052] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: i915_query
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_pm_lpsp
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_atomic_interruptible
results: parsing output: 14/ for test: api_intel_allocator
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_getfb
results: parsing output: 17/ for test: kms_fbcon_fbt
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_chamelium_hpd
results: parsing output: 20/ for test: gem_exec_whisper
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_legacy_colorkey
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: syncobj_eventfd
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_atomic
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_vrr
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: i915_pm_rpm
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: gem_ctx_shared
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_async_flips
results: parsing output: 45/ for test: gem_ctx_create
results: parsing output: 46/ for test: gem_tiling_max_stride
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: kms_chamelium_edid
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: core_setmaster
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: gem_exec_suspend
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: gem_ctx_persistence
results: parsing output: 63/ for test: gem_ccs
results: parsing output: 64/ for test: gem_eio
results: parsing output: 65/ for test: kms_pipe_b_c_ivb
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: i915_drm_fdinfo
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_psr_stress_test
results: parsing output: 70/ for test: kms_pm_rpm
results: parsing output: 71/ for test: gem_ccs
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_plane_lowres
results: parsing output: 74/ for test: gem_close_race
results: parsing output: 75/ for test: kms_getfb
results: parsing output: 76/ for test: kms_feature_discovery
results: parsing output: 77/ for test: kms_chamelium_color
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_wait
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_softpin
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: prime_mmap
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_mmap_offset
results: parsing output: 103/ for test: kms_color_pipeline
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_selftest
results: parsing output: 107/ for test: gem_exec_capture
results: parsing output: 108/ for test: gem_tiled_swapping
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_addfb_basic
results: parsing output: 114/ for test: gem_lmem_swapping
results: parsing output: 115/ for test: kms_plane_alpha_blend
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: gem_softpin
results: parsing output: 119/ for test: gem_render_tiled_blits
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: gem_exec_flush
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.