[58.213346] Initializing watchdogs
[58.213389]   /dev/watchdog0
[58.227099] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.231229] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.233400] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.236698] [001/132] (960s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[58.361577] Starting subtest: 4-tiled-addfb-size-offset-overflow
[58.363536] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[58.480439] [002/132] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[58.579320] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[58.581653] Starting dynamic subtest: pipe-A-eDP-1
[58.701465] Dynamic subtest pipe-A-eDP-1: SKIP (0.124s)
[58.710714] Starting dynamic subtest: pipe-B-eDP-1
[59.868929] Dynamic subtest pipe-B-eDP-1: SKIP (1.167s)
[59.873596] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.293s)
[61.062675] [003/132] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[61.159790] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[61.164085] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[61.277574] [004/132] (957s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[61.498916] Starting subtest: cursor-rapid-movement-256x256
[61.501309] Starting dynamic subtest: pipe-A-eDP-1
[62.065541] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[62.093699] Starting dynamic subtest: pipe-D-eDP-1
[63.244053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.154s)
[63.246070] Subtest cursor-rapid-movement-256x256: SUCCESS (1.746s)
[64.109784] [005/132] (954s left) syncobj_wait (wait-delayed-signal)
[64.172400] Starting subtest: wait-delayed-signal
[64.277343] Subtest wait-delayed-signal: SUCCESS (0.103s)
[64.361334] [006/132] (954s left) gem_ctx_param (root-set)
[64.416634] Starting subtest: root-set
[64.418982] Subtest root-set: SUCCESS (0.001s)
[64.541185] [007/132] (954s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[64.615442] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[64.619713] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[64.820877] [008/132] (954s left) i915_query (query-regions-garbage-items)
[64.880388] Starting subtest: query-regions-garbage-items
[64.882919] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[64.995831] [009/132] (954s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[65.092058] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[65.094387] Starting dynamic subtest: pipe-A-default-mode
[67.826260] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[67.828751] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.737s)
[68.709333] [010/132] (950s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[68.817899] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[68.820271] Starting dynamic subtest: pipe-A
[68.880593] Dynamic subtest pipe-A: SUCCESS (0.064s)
[68.889353] Starting dynamic subtest: pipe-B
[70.023949] Dynamic subtest pipe-B: SUCCESS (1.143s)
[70.033048] Starting dynamic subtest: pipe-C
[71.157967] Dynamic subtest pipe-C: SUCCESS (1.134s)
[71.166664] Starting dynamic subtest: pipe-D
[72.279049] Dynamic subtest pipe-D: SUCCESS (1.120s)
[72.281436] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.464s)
[73.452461] [011/132] (945s left) kms_psr (fbc-psr2-primary-blt)
[73.539269] Starting subtest: fbc-psr2-primary-blt
[73.541421] Starting dynamic subtest: eDP-1
[73.546091] Dynamic subtest eDP-1: SKIP (0.000s)
[73.550174] Subtest fbc-psr2-primary-blt: SKIP (0.002s)
[73.635463] [012/132] (945s left) kms_pm_lpsp (kms-lpsp)
[74.734079] Starting subtest: kms-lpsp
[74.736447] Starting dynamic subtest: pipe-A-eDP-1
[74.881029] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[75.163866] Subtest kms-lpsp: SUCCESS (0.432s)
[75.984966] [013/132] (943s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[76.034777] Starting subtest: multi-wait-available-unsubmitted-submitted
[76.037111] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[76.160183] [014/132] (943s left) kms_atomic_interruptible (universal-setplane-primary)
[76.252322] Starting subtest: universal-setplane-primary
[76.254851] Starting dynamic subtest: pipe-A-eDP-1
[83.699372] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.445s)
[83.701753] Subtest universal-setplane-primary: SUCCESS (7.446s)
[84.539612] [015/132] (934s left) api_intel_allocator (two-level-inception-interruptible)
[84.603942] Starting subtest: two-level-inception-interruptible
[90.061260] Subtest two-level-inception-interruptible: SUCCESS (5.406s)
[90.157892] [016/132] (929s left) kms_joiner (basic-force-ultra-joiner)
[90.272169] Starting subtest: basic-force-ultra-joiner
[90.276414] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[90.349446] [017/132] (928s left) kms_getfb (getfb-handle-zero)
[90.467394] Starting subtest: getfb-handle-zero
[90.469789] Subtest getfb-handle-zero: SUCCESS (0.000s)
[90.612652] [018/132] (928s left) kms_fbcon_fbt (psr)
[90.689788] Starting subtest: psr
[97.942078] Subtest psr: SUCCESS (7.249s)
[98.050430] [019/132] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[98.163604] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[98.167832] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[98.280251] [020/132] (921s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[98.677934] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[99.464160] [021/132] (920s left) gem_exec_whisper (basic-sync-all)
[99.544874] Starting subtest: basic-sync-all
[106.380162] Subtest basic-sync-all: SUCCESS (6.833s)
[106.571223] [022/132] (913s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[106.670884] Starting subtest: x-tiled-32bpp-rotate-90
[106.690133] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[106.826048] [023/132] (912s left) kms_psr (fbc-pr-basic)
[106.928281] Starting subtest: fbc-pr-basic
[106.932707] Subtest fbc-pr-basic: SKIP (0.000s)
[107.021407] [024/132] (912s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[107.121040] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[107.125507] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[107.236564] [025/132] (912s left) perf_pmu (init-wait)
[107.280054] Starting subtest: init-wait
[107.282246] Starting dynamic subtest: rcs0
[107.284558] Dynamic subtest rcs0: SUCCESS (0.002s)
[107.291776] Starting dynamic subtest: bcs0
[107.293678] Dynamic subtest bcs0: SUCCESS (0.000s)
[107.300582] Starting dynamic subtest: vcs0
[107.302862] Dynamic subtest vcs0: SUCCESS (0.000s)
[107.310074] Starting dynamic subtest: vcs1
[107.312283] Dynamic subtest vcs1: SUCCESS (0.000s)
[107.319695] Starting dynamic subtest: vecs0
[107.321888] Dynamic subtest vecs0: SUCCESS (0.000s)
[107.328629] Starting dynamic subtest: ccs0
[107.330819] Dynamic subtest ccs0: SUCCESS (0.000s)
[107.333023] Subtest init-wait: SUCCESS (0.005s)
[107.405636] [026/132] (912s left) kms_legacy_colorkey (invalid-plane)
[107.499661] Starting subtest: invalid-plane
[107.501769] Starting dynamic subtest: zero-id
[107.503853] Dynamic subtest zero-id: SUCCESS (0.000s)
[107.511595] Starting dynamic subtest: outrange-id
[107.513137] Dynamic subtest outrange-id: SUCCESS (0.000s)
[107.514635] Subtest invalid-plane: SUCCESS (0.000s)
[107.576759] [027/132] (912s left) kms_vblank (wait-busy-hang)
[107.663393] Starting subtest: wait-busy-hang
[107.665026] Starting dynamic subtest: pipe-A-eDP-1
[133.650562] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.986s)
[133.663890] Starting dynamic subtest: pipe-D-eDP-1
[158.683258] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.029s)
[158.685297] Subtest wait-busy-hang: SUCCESS (51.018s)
[159.571821] [028/132] (860s left) syncobj_eventfd (binary-wait)
[159.634447] Starting subtest: binary-wait
[159.643163] Subtest binary-wait: SUCCESS (0.011s)
[159.723108] [029/132] (860s left) gem_mmap_gtt (basic-read-write)
[159.793197] Subtest basic-read-write: SKIP (0.000s)
[159.851350] [030/132] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[159.969966] Starting subtest: basic-busy-flip-before-cursor-varying-size
[159.974482] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[160.122450] [031/132] (859s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[160.228355] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[164.694458] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.470s)
[165.855949] [032/132] (854s left) gem_exec_fence (syncobj-repeat)
[166.287506] Starting subtest: syncobj-repeat
[166.458584] Subtest syncobj-repeat: SUCCESS (0.170s)
[167.960690] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[167.964098] [033/132] (852s left) gem_mmap_gtt (basic-wc)
[168.017430] Subtest basic-wc: SKIP (0.000s)
[168.074267] [034/132] (851s left) kms_atomic (test-only)
[168.158108] Starting subtest: test-only
[168.207181] Starting dynamic subtest: pipe-A-eDP-1
[170.758126] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.552s)
[170.760333] Subtest test-only: SUCCESS (2.601s)
[171.637255] [035/132] (848s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[171.739370] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[171.743422] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[171.835123] [036/132] (848s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[171.969881] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[173.391592] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.420s)
[174.216426] [037/132] (845s left) kms_vrr (seamless-rr-switch-drrs)
[174.313079] Starting subtest: seamless-rr-switch-drrs
[174.319505] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[174.410277] [038/132] (845s left) kms_content_protection (content-type-change)
[174.565331] Starting subtest: content-type-change
[174.569944] Subtest content-type-change: SKIP (0.000s)
[174.735462] [039/132] (845s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[174.817960] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[174.822069] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[174.898647] [040/132] (845s left) i915_pm_rpm (system-suspend-devices)
[177.027950] Starting subtest: system-suspend-devices
[184.826030] Subtest system-suspend-devices: SUCCESS (7.797s)
[185.233796] [041/132] (835s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[185.354764] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[186.366588] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.012s)
[186.514721] [042/132] (833s left) gem_mmap_gtt (basic-write-read-distinct)
[186.575240] Subtest basic-write-read-distinct: SKIP (0.000s)
[186.641245] [043/132] (833s left) gem_ctx_shared (q-in-order)
[186.711954] Starting subtest: Q-in-order
[186.714482] Starting dynamic subtest: rcs0
[186.809949] Dynamic subtest rcs0: SUCCESS (0.098s)
[186.825591] Starting dynamic subtest: vcs0
[186.886655] Dynamic subtest vcs0: SUCCESS (0.076s)
[186.902962] Starting dynamic subtest: vcs1
[186.960914] Dynamic subtest vcs1: SUCCESS (0.074s)
[186.976669] Starting dynamic subtest: vecs0
[187.033911] Dynamic subtest vecs0: SUCCESS (0.072s)
[187.050374] Starting dynamic subtest: ccs0
[187.115555] Dynamic subtest ccs0: SUCCESS (0.080s)
[187.117865] Subtest Q-in-order: SUCCESS (0.403s)
[188.032606] [044/132] (832s left) syncobj_timeline (wait-all-complex)
[188.094283] Starting subtest: wait-all-complex
[188.308783] Subtest wait-all-complex: SUCCESS (0.212s)
[188.397073] [045/132] (832s left) kms_async_flips (alternate-sync-async-flip-atomic)
[188.493111] Starting subtest: alternate-sync-async-flip-atomic
[188.876853] Starting dynamic subtest: pipe-A-eDP-1
[191.687696] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.811s)
[192.075885] Starting dynamic subtest: pipe-B-eDP-1
[194.821572] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.753s)
[195.189669] Starting dynamic subtest: pipe-C-eDP-1
[197.954951] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.772s)
[198.324823] Starting dynamic subtest: pipe-D-eDP-1
[201.074129] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s)
[201.076089] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.583s)
[202.244792] [046/132] (818s left) gem_ctx_create (basic-files)
[202.317581] Starting subtest: basic-files
[204.324918] Subtest basic-files: SUCCESS (2.007s)
[205.900117] [047/132] (814s left) gem_tiling_max_stride
[206.039847] [048/132] (814s left) i915_drm_fdinfo (virtual-idle)
[206.080170] Starting subtest: virtual-idle
[209.156259] Subtest virtual-idle: SUCCESS (3.075s)
[209.240000] [049/132] (811s left) kms_chamelium_edid (dp-edid-read)
[209.631925] Subtest dp-edid-read: SKIP (0.000s)
[210.437472] [050/132] (810s left) gem_ctx_persistence (process)
[210.508735] Starting subtest: process
[210.743348] Subtest process: SUCCESS (0.237s)
[210.844619] [051/132] (809s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[210.939987] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[210.942247] Starting dynamic subtest: pipe-A-eDP-1
[210.951293] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.960662] Starting dynamic subtest: pipe-B-eDP-1
[210.969874] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.977797] Starting dynamic subtest: pipe-C-eDP-1
[210.986299] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.993948] Starting dynamic subtest: pipe-D-eDP-1
[211.002241] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[211.006206] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[213.137533] [052/132] (807s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[213.235857] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[213.238270] Starting dynamic subtest: A-eDP1
[216.853637] Dynamic subtest A-eDP1: SUCCESS (3.614s)
[216.863236] Starting dynamic subtest: B-eDP1
[220.043750] Dynamic subtest B-eDP1: SUCCESS (3.192s)
[220.052212] Starting dynamic subtest: C-eDP1
[223.154423] Dynamic subtest C-eDP1: SUCCESS (3.110s)
[223.164279] Starting dynamic subtest: D-eDP1
[226.266402] Dynamic subtest D-eDP1: SUCCESS (3.110s)
[226.268665] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.032s)
[227.089494] [053/132] (793s left) core_setmaster (master-drop-set-shared-fd)
[227.176925] Starting subtest: master-drop-set-shared-fd
[227.198255] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[227.238072] [054/132] (793s left) api_intel_bb (simple-bb)
[227.295519] Starting subtest: simple-bb
[227.298467] Subtest simple-bb: SUCCESS (0.006s)
[227.443332] [055/132] (793s left) gem_exec_suspend (basic-s3-devices)
[227.505920] Starting subtest: basic-S3-devices
[227.508245] Starting dynamic subtest: smem
[238.932624] Dynamic subtest smem: SUCCESS (11.424s)
[238.935403] Subtest basic-S3-devices: SUCCESS (11.426s)
[239.126742] [056/132] (781s left) gem_exec_reloc (basic-write-gtt-active)
[239.204068] Subtest basic-write-gtt-active: SKIP (0.000s)
[239.301831] [057/132] (781s left) syncobj_wait (single-wait-all-submitted)
[239.368572] Starting subtest: single-wait-all-submitted
[239.472602] Subtest single-wait-all-submitted: SUCCESS (0.103s)
[239.559997] [058/132] (781s left) gem_exec_schedule (submit-late-slice)
[239.638519] Starting subtest: submit-late-slice
[239.640874] Starting dynamic subtest: rcs0
[239.665986] Dynamic subtest rcs0: SUCCESS (0.037s)
[239.676963] Starting dynamic subtest: bcs0
[239.699679] Dynamic subtest bcs0: SUCCESS (0.033s)
[239.709208] Starting dynamic subtest: vcs0
[239.733091] Dynamic subtest vcs0: SUCCESS (0.033s)
[239.745057] Starting dynamic subtest: vcs1
[239.765764] Dynamic subtest vcs1: SUCCESS (0.032s)
[239.774729] Starting dynamic subtest: vecs0
[239.793850] Dynamic subtest vecs0: SUCCESS (0.027s)
[239.801992] Starting dynamic subtest: ccs0
[239.831994] Dynamic subtest ccs0: SUCCESS (0.037s)
[239.834280] Subtest submit-late-slice: SUCCESS (0.204s)
[241.053377] [059/132] (779s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[241.157313] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[241.168179] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[241.291290] [060/132] (779s left) gem_pxp (create-valid-protected-context)
[241.425023] Starting subtest: create-valid-protected-context
[241.427643] Subtest create-valid-protected-context: SUCCESS (0.002s)
[241.571315] [061/132] (779s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[241.675371] Starting subtest: fbcpsr-tiling-linear
[248.253815] Subtest fbcpsr-tiling-linear: SUCCESS (6.579s)
[248.426381] [062/132] (772s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[248.537583] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[248.539724] Starting dynamic subtest: pipe-A-eDP-1
[248.619324] Dynamic subtest pipe-A-eDP-1: SKIP (0.084s)
[248.628387] Starting dynamic subtest: pipe-B-eDP-1
[249.770385] Dynamic subtest pipe-B-eDP-1: SKIP (1.149s)
[249.774818] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.237s)
[251.068477] [063/132] (770s left) gem_ctx_persistence (engines-mixed-process)
[251.128100] Starting subtest: engines-mixed-process
[251.130264] Starting dynamic subtest: rcs0
[252.908806] Dynamic subtest rcs0: SUCCESS (1.780s)
[252.919241] Starting dynamic subtest: bcs0
[254.959733] Dynamic subtest bcs0: SUCCESS (2.049s)
[254.970703] Starting dynamic subtest: vcs0
[256.927817] Dynamic subtest vcs0: SUCCESS (1.966s)
[256.938501] Starting dynamic subtest: vcs1
[258.926906] Dynamic subtest vcs1: SUCCESS (1.997s)
[258.938322] Starting dynamic subtest: vecs0
[260.914872] Dynamic subtest vecs0: SUCCESS (1.985s)
[260.929265] Starting dynamic subtest: ccs0
[262.897995] Dynamic subtest ccs0: SUCCESS (1.980s)
[262.900817] Subtest engines-mixed-process: SUCCESS (11.770s)
[262.991181] [064/132] (758s left) gem_ccs (block-copy-compressed)
[263.050312] Starting subtest: block-copy-compressed
[263.055029] Subtest block-copy-compressed: SKIP (0.000s)
[263.182019] [065/132] (758s left) gem_eio (unwedge-stress)
[263.413641] Starting subtest: unwedge-stress
[263.415568] Starting dynamic subtest: render
[268.538030] Dynamic subtest render: SUCCESS (5.122s)
[268.555402] Starting dynamic subtest: bsd1
[286.387642] Dynamic subtest bsd1: SUCCESS (17.849s)
[286.403671] Starting dynamic subtest: bsd2
[308.391301] Dynamic subtest bsd2: SUCCESS (22.002s)
[308.406764] Starting dynamic subtest: blt
[308.410750] Dynamic subtest blt: SKIP (0.000s)
[308.419207] Starting dynamic subtest: vebox
[326.455598] Dynamic subtest vebox: SUCCESS (18.062s)
[326.457988] Subtest unwedge-stress: SUCCESS (63.039s)
[327.939928] [066/132] (693s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[328.013051] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[328.091314] [067/132] (693s left) kms_flip (busy-flip)
[328.190153] Starting subtest: busy-flip
[328.192456] Starting dynamic subtest: A-eDP1
[329.849397] Dynamic subtest A-eDP1: SUCCESS (1.661s)
[329.859611] Starting dynamic subtest: B-eDP1
[331.480792] Dynamic subtest B-eDP1: SUCCESS (1.629s)
[331.491658] Starting dynamic subtest: C-eDP1
[333.103119] Dynamic subtest C-eDP1: SUCCESS (1.620s)
[333.115714] Starting dynamic subtest: D-eDP1
[334.741333] Dynamic subtest D-eDP1: SUCCESS (1.636s)
[334.743676] Subtest busy-flip: SUCCESS (6.557s)
[336.024848] [068/132] (685s left) i915_drm_fdinfo (virtual-busy-hang)
[336.057754] Starting subtest: virtual-busy-hang
[336.062257] Subtest virtual-busy-hang: SKIP (0.001s)
[336.137498] [069/132] (685s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[336.241103] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[336.245575] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[336.336087] [070/132] (685s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[336.422441] Starting subtest: invalidate-primary-flip-overlay
[347.177755] Subtest invalidate-primary-flip-overlay: SUCCESS (10.757s)
[347.334763] [071/132] (674s left) kms_pm_rpm (system-suspend-idle)
[349.061553] Starting subtest: system-suspend-idle
[368.523119] Subtest system-suspend-idle: SUCCESS (4.606s)
[368.945354] [072/132] (652s left) gem_ccs (suspend-resume)
[369.004475] Starting subtest: suspend-resume
[369.008951] Subtest suspend-resume: SKIP (0.000s)
[369.129925] [073/132] (652s left) kms_big_fb (linear-16bpp-rotate-180)
[369.239189] Starting subtest: linear-16bpp-rotate-180
[370.523858] Subtest linear-16bpp-rotate-180: SUCCESS (1.290s)
[370.677935] [074/132] (650s left) kms_plane_lowres (tiling-x)
[370.776382] Starting subtest: tiling-x
[370.778273] Starting dynamic subtest: pipe-A-eDP-1
[370.782058] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[371.070077] Starting dynamic subtest: pipe-B-eDP-1
[371.075071] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[371.086306] Starting dynamic subtest: pipe-C-eDP-1
[371.090727] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[371.099836] Starting dynamic subtest: pipe-D-eDP-1
[371.104037] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[371.108285] Subtest tiling-x: SKIP (0.294s)
[371.916121] [075/132] (649s left) gem_close_race (basic-threads)
[371.977702] Starting subtest: basic-threads
[373.372230] Subtest basic-threads: SUCCESS (1.399s)
[373.565431] [076/132] (648s left) kms_getfb (getfb-handle-protection)
[373.661466] Starting subtest: getfb-handle-protection
[373.694649] Subtest getfb-handle-protection: SUCCESS (0.034s)
[373.860708] [077/132] (647s left) kms_feature_discovery (display)
[373.964941] Starting subtest: display
[373.966726] Subtest display: SUCCESS (0.000s)
[374.064499] [078/132] (647s left) kms_chamelium_color (ctm-0-25)
[374.161404] Subtest ctm-0-25: SKIP (0.000s)
[374.209277] [079/132] (647s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[374.304342] Starting subtest: y-tiled-8bpp-rotate-180
[374.308723] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[374.447988] [080/132] (647s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[374.569187] Starting subtest: flip-vs-cursor-crc-atomic
[375.282676] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.713s)
[376.158174] [081/132] (645s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[376.258201] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[383.537471] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.293s)
[383.695078] [082/132] (638s left) kms_frontbuffer_tracking (psr-1p-rte)
[383.791892] Starting subtest: psr-1p-rte
[389.134280] Subtest psr-1p-rte: SUCCESS (5.350s)
[389.289564] [083/132] (632s left) gem_wait (write-wait)
[389.359327] Starting subtest: write-wait
[389.361726] Starting dynamic subtest: all-engines
[390.486538] Dynamic subtest all-engines: SUCCESS (1.128s)
[390.504499] Starting dynamic subtest: rcs0
[391.545250] Dynamic subtest rcs0: SUCCESS (1.057s)
[391.562461] Starting dynamic subtest: bcs0
[392.604802] Dynamic subtest bcs0: SUCCESS (1.058s)
[392.621463] Starting dynamic subtest: vcs0
[393.656714] Dynamic subtest vcs0: SUCCESS (1.051s)
[393.673379] Starting dynamic subtest: vcs1
[394.711002] Dynamic subtest vcs1: SUCCESS (1.053s)
[394.727052] Starting dynamic subtest: vecs0
[395.763988] Dynamic subtest vecs0: SUCCESS (1.051s)
[395.780033] Starting dynamic subtest: ccs0
[396.820808] Dynamic subtest ccs0: SUCCESS (1.055s)
[396.823319] Subtest write-wait: SUCCESS (7.468s)
[397.044674] [084/132] (625s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[397.146726] Starting subtest: bad-pixel-format-y-tiled-ccs
[397.148924] Starting dynamic subtest: pipe-A-eDP-1
[397.171149] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[397.185826] Starting dynamic subtest: pipe-B-eDP-1
[397.207914] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[397.217725] Starting dynamic subtest: pipe-C-eDP-1
[397.238882] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[397.246987] Starting dynamic subtest: pipe-D-eDP-1
[397.268818] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[397.273137] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[399.436985] [085/132] (622s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[399.540794] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[399.544729] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[399.652844] [086/132] (622s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[399.740975] Starting subtest: fbc-shrfb-scaledprimary
[402.778708] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.039s)
[403.957876] [087/132] (618s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[404.047702] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[404.050004] Starting dynamic subtest: pipe-A-eDP-1
[404.072031] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[404.083531] Starting dynamic subtest: pipe-B-eDP-1
[404.104399] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[404.112850] Starting dynamic subtest: pipe-C-eDP-1
[404.133498] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[404.141903] Starting dynamic subtest: pipe-D-eDP-1
[404.163437] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[404.167784] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[406.317089] [088/132] (615s left) gen9_exec_parse (bb-large)
[406.373158] Subtest bb-large: SKIP (0.000s)
[406.467782] [089/132] (615s left) perf (i915-ref-count)
[406.551662] Starting subtest: i915-ref-count
[406.608837] Subtest i915-ref-count: SUCCESS (0.058s)
[406.664706] [090/132] (615s left) sw_sync (alloc_fence_invalid_timeline)
[406.702774] Starting subtest: alloc_fence_invalid_timeline
[406.704949] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[406.776894] [091/132] (615s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[406.870623] Starting subtest: psr-modesetfrombusy
[413.062693] Subtest psr-modesetfrombusy: SUCCESS (6.196s)
[413.223668] [092/132] (609s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[413.326923] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[413.330261] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[413.450902] [093/132] (609s left) gem_softpin (allocator-basic)
[413.509229] Starting subtest: allocator-basic
[413.575241] Subtest allocator-basic: SUCCESS (0.066s)
[413.697085] [094/132] (608s left) gem_render_copy (linear-to-vebox-y-tiled)
[413.753390] Starting subtest: linear-to-vebox-y-tiled
[413.757007] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[413.960595] [095/132] (608s left) gem_mmap_gtt (hang)
[414.016962] Subtest hang: SKIP (0.000s)
[414.074720] [096/132] (608s left) gem_exec_schedule (out-order)
[414.139742] Starting subtest: out-order
[414.141677] Starting dynamic subtest: rcs0
[414.232748] Dynamic subtest rcs0: SUCCESS (0.097s)
[414.244623] Starting dynamic subtest: vcs0
[414.310448] Dynamic subtest vcs0: SUCCESS (0.076s)
[414.321043] Starting dynamic subtest: vcs1
[414.384353] Dynamic subtest vcs1: SUCCESS (0.074s)
[414.396050] Starting dynamic subtest: vecs0
[414.457852] Dynamic subtest vecs0: SUCCESS (0.073s)
[414.470562] Starting dynamic subtest: ccs0
[414.535560] Dynamic subtest ccs0: SUCCESS (0.077s)
[414.538013] Subtest out-order: SUCCESS (0.401s)
[415.904740] [097/132] (606s left) gem_exec_reloc (basic-scanout)
[415.976336] Subtest basic-scanout: SKIP (0.000s)
[416.070734] [098/132] (606s left) kms_psr (fbc-psr-primary-render)
[416.177512] Starting subtest: fbc-psr-primary-render
[416.179696] Starting dynamic subtest: eDP-1
[416.183682] Dynamic subtest eDP-1: SKIP (0.000s)
[416.187712] Subtest fbc-psr-primary-render: SKIP (0.001s)
[416.263070] [099/132] (606s left) prime_mmap (test_correct_cpu_write)
[416.319791] Starting subtest: test_correct_cpu_write
[416.322117] Starting dynamic subtest: test_correct_cpu_write-smem
[416.324310] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[416.326524] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[416.443715] [100/132] (606s left) syncobj_timeline (invalid-signal-zero-handles)
[416.500180] Starting subtest: invalid-signal-zero-handles
[416.502153] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[416.620602] [101/132] (606s left) kms_cursor_legacy (torture-bo)
[416.739591] Starting subtest: torture-bo
[416.741508] Starting dynamic subtest: pipe-A
[422.661731] Dynamic subtest pipe-A: SUCCESS (5.920s)
[422.677191] Starting dynamic subtest: pipe-B
[429.794126] Dynamic subtest pipe-B: SUCCESS (7.132s)
[429.806216] Starting dynamic subtest: pipe-C
[438.229558] Dynamic subtest pipe-C: SUCCESS (8.435s)
[438.242502] Starting dynamic subtest: pipe-D
[447.272016] Dynamic subtest pipe-D: SUCCESS (9.044s)
[447.283278] Starting dynamic subtest: all-pipes
[453.835306] Dynamic subtest all-pipes: SUCCESS (6.563s)
[453.837850] Subtest torture-bo: SUCCESS (37.104s)
[454.011626] [102/132] (568s left) kms_cursor_crc (cursor-onscreen-32x10)
[454.219107] Starting subtest: cursor-onscreen-32x10
[454.311511] Subtest cursor-onscreen-32x10: SKIP (0.090s)
[454.644023] [103/132] (568s left) gem_mmap_offset (partial-mmap)
[454.709985] Starting subtest: partial-mmap
[454.712404] Starting dynamic subtest: smem0
[454.714384] Dynamic subtest smem0: SUCCESS (0.003s)
[454.716350] Subtest partial-mmap: SUCCESS (0.004s)
[454.852994] [104/132] (568s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[454.936235] Starting subtest: plane-lut1d-ctm3x4-lut1d
[454.948920] Starting dynamic subtest: pipe-A-eDP-1
[455.589810] Dynamic subtest pipe-A-eDP-1: FAIL (0.309s)
[456.339107] Starting dynamic subtest: pipe-B-eDP-1
[457.215450] Dynamic subtest pipe-B-eDP-1: FAIL (0.346s)
[457.780667] Starting dynamic subtest: pipe-C-eDP-1
[458.605334] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[459.119818] Starting dynamic subtest: pipe-D-eDP-1
[459.978226] Dynamic subtest pipe-D-eDP-1: FAIL (0.279s)
[459.980579] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.761s)
[460.504956] [105/132] (562s left) gem_userptr_blits (unsync-overlap)
[460.585380] Subtest unsync-overlap: SKIP (0.000s)
[460.740377] [106/132] (562s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[460.847741] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[460.852229] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[460.966549] [107/132] (562s left) kms_selftest (drm_damage_helper)
[461.010121] Starting subtest: drm_damage_helper
[461.050766] Starting dynamic subtest: drm_test_damage_iter_no_damage
[461.224827] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.178s)
[461.235339] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[461.352887] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.127s)
[461.363750] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[461.492853] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.140s)
[461.503586] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[461.618559] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.122s)
[461.627864] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[461.767726] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.148s)
[461.782944] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[461.906713] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.140s)
[461.916923] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[462.037062] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.128s)
[462.047875] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[462.161449] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.124s)
[462.172160] Starting dynamic subtest: drm_test_damage_iter_single_damage
[462.308713] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.146s)
[462.318058] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[462.428640] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.119s)
[462.437644] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[462.585955] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.151s)
[462.596619] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[462.681973] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.099s)
[462.696834] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[462.837347] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.126s)
[462.848600] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[462.947946] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.139s)
[462.958371] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[463.099400] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.149s)
[463.108293] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[463.197733] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.098s)
[463.206460] Starting dynamic subtest: drm_test_damage_iter_damage
[463.316693] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.118s)
[463.326953] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[463.448664] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.130s)
[463.457318] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[463.568890] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.118s)
[463.578990] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[463.702391] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.131s)
[463.710869] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[463.817929] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.114s)
[463.819955] Subtest drm_damage_helper: SUCCESS (2.806s)
[464.028527] [108/132] (559s left) gem_exec_capture (capture-recoverable)
[464.082299] Starting subtest: capture-recoverable
[464.084698] Subtest capture-recoverable: SUCCESS (0.004s)
[464.233068] [109/132] (558s left) gem_tiled_swapping (non-threaded)
[464.292191] Subtest non-threaded: SKIP (0.000s)
[464.357580] [110/132] (558s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[464.454866] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[464.457095] Starting dynamic subtest: pipe-A-eDP-1
[465.293415] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.831s)
[465.302972] Starting dynamic subtest: pipe-B-eDP-1
[466.787070] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.489s)
[466.797212] Starting dynamic subtest: pipe-C-eDP-1
[468.292086] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.503s)
[468.302670] Starting dynamic subtest: pipe-D-eDP-1
[469.820414] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.528s)
[469.822615] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.356s)
[471.032601] [111/132] (552s left) gem_exec_balancer (full-pulse)
[471.100594] Starting subtest: full-pulse
[475.685872] Subtest full-pulse: SUCCESS (4.587s)
[476.022570] [112/132] (547s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[476.144891] Starting subtest: fbc-rgb565-draw-render
[480.271520] Subtest fbc-rgb565-draw-render: SUCCESS (4.129s)
[481.431388] [113/132] (541s left) kms_flip (flip-vs-panning-vs-hang)
[481.536224] Starting subtest: flip-vs-panning-vs-hang
[481.538446] Starting dynamic subtest: A-eDP1
[521.240435] Dynamic subtest A-eDP1: SUCCESS (39.705s)
[521.251487] Starting dynamic subtest: D-eDP1
[561.299032] Dynamic subtest D-eDP1: SUCCESS (40.065s)
[561.301170] Subtest flip-vs-panning-vs-hang: SUCCESS (79.774s)
[562.491505] [114/132] (460s left) kms_addfb_basic (clobberred-modifier)
[562.553037] Starting subtest: clobberred-modifier
[562.557648] Subtest clobberred-modifier: SKIP (0.000s)
[562.727086] [115/132] (460s left) gem_lmem_swapping (smem-oom)
[562.770824] Subtest smem-oom: SKIP (0.000s)
[562.812460] [116/132] (460s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[562.917040] Starting subtest: coverage-vs-premult-vs-constant
[563.188278] Starting dynamic subtest: pipe-A-eDP-1
[563.741859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[563.752188] Starting dynamic subtest: pipe-D-eDP-1
[565.090634] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.347s)
[565.093070] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.176s)
[565.961358] [117/132] (457s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[566.078892] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[566.082936] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[566.206636] [118/132] (457s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[566.263974] Starting subtest: etime-single-wait-for-submit-submitted
[566.369067] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.104s)
[566.474979] [119/132] (457s left) gem_softpin (noreloc)
[566.537381] Starting subtest: noreloc
[571.997864] Subtest noreloc: SUCCESS (5.408s)
[572.095001] [120/132] (451s left) gem_render_tiled_blits (basic)
[572.151409] Subtest basic: SKIP (0.000s)
[572.235681] [121/132] (451s left) kms_psr (pr-suspend)
[572.326740] Starting subtest: pr-suspend
[572.330892] Subtest pr-suspend: SKIP (0.000s)
[572.431788] [122/132] (451s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[572.486586] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[572.593153] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[572.680805] [123/132] (451s left) kms_psr (psr-cursor-blt)
[572.783898] Starting subtest: psr-cursor-blt
[572.786215] Starting dynamic subtest: eDP-1
[574.549268] Dynamic subtest eDP-1: SUCCESS (1.765s)
[574.551575] Subtest psr-cursor-blt: SUCCESS (1.766s)
[575.418037] [124/132] (448s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[575.528489] Starting subtest: fbc-rgb565-draw-mmap-gtt
[575.532778] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[575.636168] [125/132] (448s left) gem_exec_params (sol-reset-not-gen7)
[575.689846] Starting subtest: sol-reset-not-gen7
[575.694833] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[575.815737] [126/132] (448s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[575.911342] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[575.915577] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[576.043661] [127/132] (447s left) kms_plane (planar-pixel-format-settings)
[576.132076] Starting subtest: planar-pixel-format-settings
[576.197305] Subtest planar-pixel-format-settings: SUCCESS (0.065s)
[576.369301] [128/132] (447s left) gem_exec_whisper (basic-fds-priority-all)
[576.440606] Starting subtest: basic-fds-priority-all
[598.440802] Subtest basic-fds-priority-all: SUCCESS (21.997s)
[598.650295] [129/132] (425s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[598.712376] Starting subtest: invalid-single-wait-all-unsubmitted
[598.714540] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[598.833803] [130/132] (425s left) kms_flip (2x-flip-vs-expired-vblank)
[598.923210] Starting subtest: 2x-flip-vs-expired-vblank
[598.934256] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[599.082431] [131/132] (424s left) gem_exec_flush (basic-batch-kernel-default-uc)
[599.144171] Starting subtest: basic-batch-kernel-default-uc
[606.269249] Subtest basic-batch-kernel-default-uc: SUCCESS (7.123s)
[606.481903] [132/132] (417s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[606.588807] Starting subtest: fbcpsr-modesetfrombusy
[612.790382] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.205s)
[612.962080] 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.