[59.086451] Initializing watchdogs
[59.086499]   /dev/watchdog0
[59.100872] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.105184] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.108066] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.110016] [001/132] (960s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[59.219270] Starting subtest: 4-tiled-addfb-size-offset-overflow
[59.220287] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[59.339096] [002/132] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[59.433705] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[59.434606] Starting dynamic subtest: pipe-A-eDP-1
[59.558191] Dynamic subtest pipe-A-eDP-1: SKIP (0.124s)
[59.564373] Starting dynamic subtest: pipe-B-eDP-1
[60.708088] Dynamic subtest pipe-B-eDP-1: SKIP (1.148s)
[60.709898] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.274s)
[62.018317] [003/132] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[62.111702] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[62.113499] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[62.211624] [004/132] (957s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[62.449115] Starting subtest: cursor-rapid-movement-256x256
[62.452371] Starting dynamic subtest: pipe-A-eDP-1
[63.026431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[63.057349] Starting dynamic subtest: pipe-D-eDP-1
[64.241996] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.189s)
[64.242914] Subtest cursor-rapid-movement-256x256: SUCCESS (1.792s)
[65.094519] [005/132] (954s left) syncobj_wait (wait-delayed-signal)
[65.151065] Starting subtest: wait-delayed-signal
[65.253869] Subtest wait-delayed-signal: SUCCESS (0.102s)
[65.337225] [006/132] (954s left) gem_ctx_param (root-set)
[65.386276] Starting subtest: root-set
[65.387255] Subtest root-set: SUCCESS (0.001s)
[65.503370] [007/132] (954s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[65.562129] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[65.564025] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[65.763927] [008/132] (954s left) i915_query (query-regions-garbage-items)
[65.819186] Starting subtest: query-regions-garbage-items
[65.820133] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[65.929564] [009/132] (953s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[66.025208] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[66.026106] Starting dynamic subtest: pipe-A-default-mode
[68.716338] Dynamic subtest pipe-A-default-mode: SUCCESS (2.690s)
[68.717295] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.691s)
[69.587346] [010/132] (950s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[69.685809] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[69.687208] Starting dynamic subtest: pipe-A
[69.750458] Dynamic subtest pipe-A: SUCCESS (0.065s)
[69.760839] Starting dynamic subtest: pipe-B
[70.909651] Dynamic subtest pipe-B: SUCCESS (1.158s)
[70.917894] Starting dynamic subtest: pipe-C
[72.019116] Dynamic subtest pipe-C: SUCCESS (1.109s)
[72.026482] Starting dynamic subtest: pipe-D
[73.156550] Dynamic subtest pipe-D: SUCCESS (1.137s)
[73.157505] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.470s)
[74.333815] [011/132] (945s left) kms_psr (fbc-psr2-primary-blt)
[74.440207] Starting subtest: fbc-psr2-primary-blt
[74.441171] Starting dynamic subtest: eDP-1
[74.442928] Dynamic subtest eDP-1: SKIP (0.000s)
[74.444820] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[74.515269] [012/132] (945s left) kms_pm_lpsp (kms-lpsp)
[75.607063] Starting subtest: kms-lpsp
[75.608807] Starting dynamic subtest: pipe-A-eDP-1
[75.757255] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[76.050421] Subtest kms-lpsp: SUCCESS (0.443s)
[76.850569] [013/132] (943s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[76.910758] Starting subtest: multi-wait-available-unsubmitted-submitted
[76.911616] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[77.022180] [014/132] (942s left) kms_atomic_interruptible (universal-setplane-primary)
[77.122890] Starting subtest: universal-setplane-primary
[77.123748] Starting dynamic subtest: pipe-A-eDP-1
[84.598181] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.473s)
[84.598955] Subtest universal-setplane-primary: SUCCESS (7.474s)
[85.414309] [015/132] (934s left) api_intel_allocator (two-level-inception-interruptible)
[85.473055] Starting subtest: two-level-inception-interruptible
[90.931968] Subtest two-level-inception-interruptible: SUCCESS (5.412s)
[91.022788] [016/132] (929s left) kms_joiner (basic-force-ultra-joiner)
[91.123888] Starting subtest: basic-force-ultra-joiner
[91.125543] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[91.203152] [017/132] (928s left) kms_getfb (getfb-handle-zero)
[91.299426] Starting subtest: getfb-handle-zero
[91.300417] Subtest getfb-handle-zero: SUCCESS (0.000s)
[91.431587] [018/132] (928s left) kms_fbcon_fbt (psr)
[91.490185] Starting subtest: psr
[98.948437] Subtest psr: SUCCESS (7.447s)
[99.035506] [019/132] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[99.124823] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[99.126618] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[99.220582] [020/132] (920s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[99.598384] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[100.368800] [021/132] (919s left) gem_exec_whisper (basic-sync-all)
[100.424537] Starting subtest: basic-sync-all
[107.048313] Subtest basic-sync-all: SUCCESS (6.622s)
[107.235500] [022/132] (913s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[107.358229] Starting subtest: x-tiled-32bpp-rotate-90
[107.377156] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[107.539969] [023/132] (912s left) kms_psr (fbc-pr-basic)
[107.624905] Starting subtest: fbc-pr-basic
[107.626608] Subtest fbc-pr-basic: SKIP (0.000s)
[107.713623] [024/132] (912s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[107.817952] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[107.819740] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[107.940098] [025/132] (912s left) perf_pmu (init-wait)
[107.973578] Starting subtest: init-wait
[107.974809] Starting dynamic subtest: rcs0
[107.976041] Dynamic subtest rcs0: SUCCESS (0.002s)
[107.984698] Starting dynamic subtest: bcs0
[107.986684] Dynamic subtest bcs0: SUCCESS (0.000s)
[107.992704] Starting dynamic subtest: vcs0
[107.993525] Dynamic subtest vcs0: SUCCESS (0.001s)
[107.999303] Starting dynamic subtest: vcs1
[108.000123] Dynamic subtest vcs1: SUCCESS (0.001s)
[108.005693] Starting dynamic subtest: vecs0
[108.006602] Dynamic subtest vecs0: SUCCESS (0.001s)
[108.012305] Starting dynamic subtest: ccs0
[108.013253] Dynamic subtest ccs0: SUCCESS (0.000s)
[108.014062] Subtest init-wait: SUCCESS (0.006s)
[108.112219] [026/132] (912s left) kms_legacy_colorkey (invalid-plane)
[108.212248] Starting subtest: invalid-plane
[108.213095] Starting dynamic subtest: zero-id
[108.213884] Dynamic subtest zero-id: SUCCESS (0.000s)
[108.220672] Starting dynamic subtest: outrange-id
[108.221467] Dynamic subtest outrange-id: SUCCESS (0.000s)
[108.222235] Subtest invalid-plane: SUCCESS (0.000s)
[108.286935] [027/132] (912s left) kms_vblank (wait-busy-hang)
[108.380703] Starting subtest: wait-busy-hang
[108.382946] Starting dynamic subtest: pipe-A-eDP-1
[134.749939] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.366s)
[134.758127] Starting dynamic subtest: pipe-D-eDP-1
[159.715383] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.962s)
[159.716359] Subtest wait-busy-hang: SUCCESS (51.332s)
[160.584167] [028/132] (859s left) syncobj_eventfd (binary-wait)
[160.648833] Starting subtest: binary-wait
[160.659075] Subtest binary-wait: SUCCESS (0.010s)
[160.747106] [029/132] (859s left) gem_mmap_gtt (basic-read-write)
[160.796211] Subtest basic-read-write: SKIP (0.000s)
[160.855442] [030/132] (859s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[160.965432] Starting subtest: basic-busy-flip-before-cursor-varying-size
[160.967027] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[161.125202] [031/132] (859s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[161.216540] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[165.662997] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.447s)
[166.790853] [032/132] (853s left) gem_exec_fence (syncobj-repeat)
[167.330062] Starting subtest: syncobj-repeat
[167.522686] Subtest syncobj-repeat: SUCCESS (0.184s)
[168.933689] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[168.935243] [033/132] (851s left) gem_mmap_gtt (basic-wc)
[168.995767] Subtest basic-wc: SKIP (0.000s)
[169.066536] [034/132] (851s left) kms_atomic (test-only)
[169.148444] Starting subtest: test-only
[169.197249] Starting dynamic subtest: pipe-A-eDP-1
[171.694855] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[171.695731] Subtest test-only: SUCCESS (2.547s)
[172.564542] [035/132] (848s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[172.658245] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[172.659967] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[172.772249] [036/132] (847s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[172.879308] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[174.345058] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.466s)
[175.144996] [037/132] (845s left) kms_vrr (seamless-rr-switch-drrs)
[175.234407] Starting subtest: seamless-rr-switch-drrs
[175.236911] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[175.312873] [038/132] (845s left) kms_content_protection (content-type-change)
[175.457539] Starting subtest: content-type-change
[175.460196] Subtest content-type-change: SKIP (0.000s)
[175.607066] [039/132] (845s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[175.691449] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[175.693238] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[175.769192] [040/132] (845s left) i915_pm_rpm (system-suspend-devices)
[177.998563] Starting subtest: system-suspend-devices
[185.850800] Subtest system-suspend-devices: SUCCESS (7.852s)
[192.304284] [041/132] (834s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[192.435055] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[193.548270] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.113s)
[193.711656] [042/132] (833s left) gem_mmap_gtt (basic-write-read-distinct)
[193.763814] Subtest basic-write-read-distinct: SKIP (0.000s)
[193.836039] [043/132] (833s left) gem_ctx_shared (q-in-order)
[193.902014] Starting subtest: Q-in-order
[193.902961] Starting dynamic subtest: rcs0
[194.004772] Dynamic subtest rcs0: SUCCESS (0.102s)
[194.020846] Starting dynamic subtest: vcs0
[194.083608] Dynamic subtest vcs0: SUCCESS (0.079s)
[194.099729] Starting dynamic subtest: vcs1
[194.156712] Dynamic subtest vcs1: SUCCESS (0.072s)
[194.172097] Starting dynamic subtest: vecs0
[194.230871] Dynamic subtest vecs0: SUCCESS (0.073s)
[194.247080] Starting dynamic subtest: ccs0
[194.311052] Dynamic subtest ccs0: SUCCESS (0.080s)
[194.312413] Subtest Q-in-order: SUCCESS (0.409s)
[196.017659] [044/132] (831s left) syncobj_timeline (wait-all-complex)
[196.083340] Starting subtest: wait-all-complex
[196.296194] Subtest wait-all-complex: SUCCESS (0.212s)
[196.381485] [045/132] (830s left) kms_async_flips (alternate-sync-async-flip-atomic)
[196.470560] Starting subtest: alternate-sync-async-flip-atomic
[196.842043] Starting dynamic subtest: pipe-A-eDP-1
[199.611676] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.769s)
[199.989518] Starting dynamic subtest: pipe-B-eDP-1
[202.734282] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.751s)
[203.133033] Starting dynamic subtest: pipe-C-eDP-1
[205.878456] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.752s)
[206.241111] Starting dynamic subtest: pipe-D-eDP-1
[209.006688] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[209.007634] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.537s)
[210.195864] [046/132] (816s left) gem_ctx_create (basic-files)
[210.260387] Starting subtest: basic-files
[212.267733] Subtest basic-files: SUCCESS (2.007s)
[213.971073] [047/132] (813s left) gem_tiling_max_stride
[214.113863] [048/132] (813s left) i915_drm_fdinfo (virtual-idle)
[214.151691] Starting subtest: virtual-idle
[217.254376] Subtest virtual-idle: SUCCESS (3.092s)
[217.324125] [049/132] (809s left) kms_chamelium_edid (dp-edid-read)
[217.724378] Subtest dp-edid-read: SKIP (0.000s)
[218.484730] [050/132] (808s left) gem_ctx_persistence (process)
[218.541364] Starting subtest: process
[218.770730] Subtest process: SUCCESS (0.230s)
[218.868748] [051/132] (808s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[218.969142] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[218.970240] Starting dynamic subtest: pipe-A-eDP-1
[218.973882] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[218.990595] Starting dynamic subtest: pipe-B-eDP-1
[218.994566] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[219.003734] Starting dynamic subtest: pipe-C-eDP-1
[219.007271] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[219.014417] Starting dynamic subtest: pipe-D-eDP-1
[219.017912] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[219.019613] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[221.209207] [052/132] (806s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[221.301126] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[221.303403] Starting dynamic subtest: A-eDP1
[224.927479] Dynamic subtest A-eDP1: SUCCESS (3.617s)
[224.935849] Starting dynamic subtest: B-eDP1
[228.118925] Dynamic subtest B-eDP1: SUCCESS (3.198s)
[228.126355] Starting dynamic subtest: C-eDP1
[231.249253] Dynamic subtest C-eDP1: SUCCESS (3.129s)
[231.258137] Starting dynamic subtest: D-eDP1
[234.358606] Dynamic subtest D-eDP1: SUCCESS (3.108s)
[234.360674] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.059s)
[235.155363] [053/132] (792s left) core_setmaster (master-drop-set-shared-fd)
[235.245825] Starting subtest: master-drop-set-shared-fd
[235.267676] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[235.297940] [054/132] (792s left) api_intel_bb (simple-bb)
[235.355934] Starting subtest: simple-bb
[235.360950] Subtest simple-bb: SUCCESS (0.006s)
[235.533046] [055/132] (791s left) gem_exec_suspend (basic-s3-devices)
[235.590473] Starting subtest: basic-S3-devices
[235.591471] Starting dynamic subtest: smem
[246.942058] Dynamic subtest smem: SUCCESS (11.342s)
[246.943161] Subtest basic-S3-devices: SUCCESS (11.344s)
[252.190141] [056/132] (780s left) gem_exec_reloc (basic-write-gtt-active)
[252.251842] Subtest basic-write-gtt-active: SKIP (0.000s)
[252.344144] [057/132] (780s left) syncobj_wait (single-wait-all-submitted)
[252.393798] Starting subtest: single-wait-all-submitted
[252.497497] Subtest single-wait-all-submitted: SUCCESS (0.103s)
[252.583568] [058/132] (780s left) gem_exec_schedule (submit-late-slice)
[252.638977] Starting subtest: submit-late-slice
[252.639963] Starting dynamic subtest: rcs0
[252.702619] Dynamic subtest rcs0: SUCCESS (0.063s)
[252.712622] Starting dynamic subtest: bcs0
[252.749483] Dynamic subtest bcs0: SUCCESS (0.046s)
[252.759828] Starting dynamic subtest: vcs0
[252.802410] Dynamic subtest vcs0: SUCCESS (0.053s)
[252.812885] Starting dynamic subtest: vcs1
[252.851336] Dynamic subtest vcs1: SUCCESS (0.048s)
[252.860844] Starting dynamic subtest: vecs0
[252.893392] Dynamic subtest vecs0: SUCCESS (0.041s)
[252.901189] Starting dynamic subtest: ccs0
[252.939999] Dynamic subtest ccs0: SUCCESS (0.046s)
[252.940961] Subtest submit-late-slice: SUCCESS (0.301s)
[254.022957] [059/132] (778s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[254.125403] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[254.137357] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[254.219137] [060/132] (778s left) gem_pxp (create-valid-protected-context)
[254.348352] Starting subtest: create-valid-protected-context
[254.349688] Subtest create-valid-protected-context: SUCCESS (0.001s)
[254.477849] [061/132] (778s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[254.575037] Starting subtest: fbcpsr-tiling-linear
[261.278109] Subtest fbcpsr-tiling-linear: SUCCESS (6.703s)
[261.452702] [062/132] (771s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[261.564568] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[261.566217] Starting dynamic subtest: pipe-A-eDP-1
[261.645025] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[261.653712] Starting dynamic subtest: pipe-B-eDP-1
[262.726575] Dynamic subtest pipe-B-eDP-1: SKIP (1.080s)
[262.728660] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.162s)
[264.037060] [063/132] (768s left) gem_ctx_persistence (engines-mixed-process)
[264.102491] Starting subtest: engines-mixed-process
[264.103323] Starting dynamic subtest: rcs0
[265.882868] Dynamic subtest rcs0: SUCCESS (1.781s)
[265.892632] Starting dynamic subtest: bcs0
[267.896914] Dynamic subtest bcs0: SUCCESS (2.013s)
[267.907538] Starting dynamic subtest: vcs0
[269.924748] Dynamic subtest vcs0: SUCCESS (2.026s)
[269.935077] Starting dynamic subtest: vcs1
[271.908714] Dynamic subtest vcs1: SUCCESS (1.982s)
[271.919707] Starting dynamic subtest: vecs0
[273.971740] Dynamic subtest vecs0: SUCCESS (2.061s)
[273.983961] Starting dynamic subtest: ccs0
[275.894908] Dynamic subtest ccs0: SUCCESS (1.921s)
[275.896345] Subtest engines-mixed-process: SUCCESS (11.794s)
[275.984434] [064/132] (756s left) gem_ccs (block-copy-compressed)
[276.050297] Starting subtest: block-copy-compressed
[276.052086] Subtest block-copy-compressed: SKIP (0.000s)
[276.175389] [065/132] (756s left) gem_eio (unwedge-stress)
[276.407637] Starting subtest: unwedge-stress
[276.408808] Starting dynamic subtest: render
[281.759890] Dynamic subtest render: SUCCESS (5.351s)
[281.770284] Starting dynamic subtest: bsd1
[299.472378] Dynamic subtest bsd1: SUCCESS (17.711s)
[299.487714] Starting dynamic subtest: bsd2
[317.365849] Dynamic subtest bsd2: SUCCESS (17.892s)
[317.379545] Starting dynamic subtest: blt
[317.381161] Dynamic subtest blt: SKIP (0.000s)
[317.388284] Starting dynamic subtest: vebox
[335.484033] Dynamic subtest vebox: SUCCESS (18.116s)
[335.484892] Subtest unwedge-stress: SUCCESS (59.076s)
[336.963803] [066/132] (695s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[337.030410] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[337.094894] [067/132] (695s left) kms_flip (busy-flip)
[337.193599] Starting subtest: busy-flip
[337.195931] Starting dynamic subtest: A-eDP1
[338.921073] Dynamic subtest A-eDP1: SUCCESS (1.726s)
[338.930756] Starting dynamic subtest: B-eDP1
[340.648852] Dynamic subtest B-eDP1: SUCCESS (1.726s)
[340.664386] Starting dynamic subtest: C-eDP1
[342.374744] Dynamic subtest C-eDP1: SUCCESS (1.719s)
[342.392181] Starting dynamic subtest: D-eDP1
[344.007025] Dynamic subtest D-eDP1: SUCCESS (1.632s)
[344.009861] Subtest busy-flip: SUCCESS (6.817s)
[345.188188] [068/132] (687s left) i915_drm_fdinfo (virtual-busy-hang)
[345.227825] Starting subtest: virtual-busy-hang
[345.229814] Subtest virtual-busy-hang: SKIP (0.000s)
[345.305651] [069/132] (687s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[345.402595] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[345.404602] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[345.482322] [070/132] (687s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[345.573844] Starting subtest: invalidate-primary-flip-overlay
[356.333423] Subtest invalidate-primary-flip-overlay: SUCCESS (10.760s)
[356.469060] [071/132] (676s left) kms_pm_rpm (system-suspend-idle)
[358.086696] Starting subtest: system-suspend-idle
[378.036492] Subtest system-suspend-idle: SUCCESS (4.687s)
[382.475884] [072/132] (654s left) gem_ccs (suspend-resume)
[382.551707] Starting subtest: suspend-resume
[382.553609] Subtest suspend-resume: SKIP (0.000s)
[382.680574] [073/132] (654s left) kms_big_fb (linear-16bpp-rotate-180)
[382.798672] Starting subtest: linear-16bpp-rotate-180
[384.107265] Subtest linear-16bpp-rotate-180: SUCCESS (1.304s)
[384.268408] [074/132] (652s left) kms_plane_lowres (tiling-x)
[384.347801] Starting subtest: tiling-x
[384.348869] Starting dynamic subtest: pipe-A-eDP-1
[384.350544] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[384.642458] Starting dynamic subtest: pipe-B-eDP-1
[384.644402] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[384.653825] Starting dynamic subtest: pipe-C-eDP-1
[384.655614] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[384.663544] Starting dynamic subtest: pipe-D-eDP-1
[384.665900] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[384.668201] Subtest tiling-x: SKIP (0.292s)
[385.451545] [075/132] (651s left) gem_close_race (basic-threads)
[385.514039] Starting subtest: basic-threads
[386.944812] Subtest basic-threads: SUCCESS (1.426s)
[387.148002] [076/132] (650s left) kms_getfb (getfb-handle-protection)
[387.241289] Starting subtest: getfb-handle-protection
[387.268067] Subtest getfb-handle-protection: SUCCESS (0.027s)
[387.417103] [077/132] (649s left) kms_feature_discovery (display)
[387.511571] Starting subtest: display
[387.512488] Subtest display: SUCCESS (0.000s)
[387.594006] [078/132] (649s left) kms_chamelium_color (ctm-0-25)
[387.674974] Subtest ctm-0-25: SKIP (0.000s)
[387.715201] [079/132] (649s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[387.808583] Starting subtest: y-tiled-8bpp-rotate-180
[387.810376] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[387.913351] [080/132] (649s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[388.029723] Starting subtest: flip-vs-cursor-crc-atomic
[388.701447] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.669s)
[389.568837] [081/132] (647s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[389.659329] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[397.080891] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.411s)
[397.231164] [082/132] (640s left) kms_frontbuffer_tracking (psr-1p-rte)
[397.329331] Starting subtest: psr-1p-rte
[402.763583] Subtest psr-1p-rte: SUCCESS (5.432s)
[402.920323] [083/132] (634s left) gem_wait (write-wait)
[402.978599] Starting subtest: write-wait
[402.979568] Starting dynamic subtest: all-engines
[404.131449] Dynamic subtest all-engines: SUCCESS (1.151s)
[404.149723] Starting dynamic subtest: rcs0
[405.192463] Dynamic subtest rcs0: SUCCESS (1.057s)
[405.211980] Starting dynamic subtest: bcs0
[406.250671] Dynamic subtest bcs0: SUCCESS (1.056s)
[406.266451] Starting dynamic subtest: vcs0
[407.305102] Dynamic subtest vcs0: SUCCESS (1.051s)
[407.323095] Starting dynamic subtest: vcs1
[408.360074] Dynamic subtest vcs1: SUCCESS (1.052s)
[408.377878] Starting dynamic subtest: vecs0
[409.412816] Dynamic subtest vecs0: SUCCESS (1.050s)
[409.430152] Starting dynamic subtest: ccs0
[410.469499] Dynamic subtest ccs0: SUCCESS (1.054s)
[410.472428] Subtest write-wait: SUCCESS (7.487s)
[410.676300] [084/132] (626s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[410.766990] Starting subtest: bad-pixel-format-y-tiled-ccs
[410.767884] Starting dynamic subtest: pipe-A-eDP-1
[410.776212] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[410.784481] Starting dynamic subtest: pipe-B-eDP-1
[410.793062] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[410.800897] Starting dynamic subtest: pipe-C-eDP-1
[410.810082] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[410.817633] Starting dynamic subtest: pipe-D-eDP-1
[410.825908] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[410.827715] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[413.000876] [085/132] (624s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[413.110320] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[413.112121] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[413.252247] [086/132] (624s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[413.341723] Starting subtest: fbc-shrfb-scaledprimary
[416.346056] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.003s)
[417.581400] [087/132] (620s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[417.692256] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[417.693155] Starting dynamic subtest: pipe-A-eDP-1
[417.701703] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[417.710289] Starting dynamic subtest: pipe-B-eDP-1
[417.718320] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[417.726509] Starting dynamic subtest: pipe-C-eDP-1
[417.734162] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[417.741764] Starting dynamic subtest: pipe-D-eDP-1
[417.749820] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[417.751420] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[420.011198] [088/132] (617s left) gen9_exec_parse (bb-large)
[420.068519] Subtest bb-large: SKIP (0.000s)
[420.129983] [089/132] (617s left) perf (i915-ref-count)
[420.197771] Starting subtest: i915-ref-count
[420.268988] Subtest i915-ref-count: SUCCESS (0.070s)
[420.321519] [090/132] (617s left) sw_sync (alloc_fence_invalid_timeline)
[420.351629] Starting subtest: alloc_fence_invalid_timeline
[420.352704] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[420.408863] [091/132] (617s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[420.513264] Starting subtest: psr-modesetfrombusy
[426.649364] Subtest psr-modesetfrombusy: SUCCESS (6.134s)
[426.810350] [092/132] (611s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[426.917776] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[426.919260] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[427.056471] [093/132] (610s left) gem_softpin (allocator-basic)
[427.115407] Starting subtest: allocator-basic
[427.186706] Subtest allocator-basic: SUCCESS (0.071s)
[427.332780] [094/132] (610s left) gem_render_copy (linear-to-vebox-y-tiled)
[427.392782] Starting subtest: linear-to-vebox-y-tiled
[427.394593] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[427.600959] [095/132] (610s left) gem_mmap_gtt (hang)
[427.650919] Subtest hang: SKIP (0.000s)
[427.716540] [096/132] (610s left) gem_exec_schedule (out-order)
[427.783425] Starting subtest: out-order
[427.784445] Starting dynamic subtest: rcs0
[427.888835] Dynamic subtest rcs0: SUCCESS (0.104s)
[427.901596] Starting dynamic subtest: vcs0
[427.989546] Dynamic subtest vcs0: SUCCESS (0.099s)
[428.001758] Starting dynamic subtest: vcs1
[428.089915] Dynamic subtest vcs1: SUCCESS (0.098s)
[428.102455] Starting dynamic subtest: vecs0
[428.170507] Dynamic subtest vecs0: SUCCESS (0.078s)
[428.181545] Starting dynamic subtest: ccs0
[428.257524] Dynamic subtest ccs0: SUCCESS (0.086s)
[428.258865] Subtest out-order: SUCCESS (0.474s)
[429.294285] [097/132] (608s left) gem_exec_reloc (basic-scanout)
[429.351018] Subtest basic-scanout: SKIP (0.000s)
[429.434471] [098/132] (608s left) kms_psr (fbc-psr-primary-render)
[429.532144] Starting subtest: fbc-psr-primary-render
[429.532975] Starting dynamic subtest: eDP-1
[429.534716] Dynamic subtest eDP-1: SKIP (0.000s)
[429.536453] Subtest fbc-psr-primary-render: SKIP (0.001s)
[429.615388] [099/132] (608s left) prime_mmap (test_correct_cpu_write)
[429.663047] Starting subtest: test_correct_cpu_write
[429.664041] Starting dynamic subtest: test_correct_cpu_write-smem
[429.664938] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[429.665841] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[429.785208] [100/132] (608s left) syncobj_timeline (invalid-signal-zero-handles)
[429.838728] Starting subtest: invalid-signal-zero-handles
[429.839688] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[429.964782] [101/132] (608s left) kms_cursor_legacy (torture-bo)
[430.075066] Starting subtest: torture-bo
[430.075893] Starting dynamic subtest: pipe-A
[436.380885] Dynamic subtest pipe-A: SUCCESS (6.290s)
[436.391753] Starting dynamic subtest: pipe-B
[442.991150] Dynamic subtest pipe-B: SUCCESS (6.616s)
[443.001514] Starting dynamic subtest: pipe-C
[449.694082] Dynamic subtest pipe-C: SUCCESS (6.700s)
[449.703547] Starting dynamic subtest: pipe-D
[456.939180] Dynamic subtest pipe-D: SUCCESS (7.240s)
[456.948728] Starting dynamic subtest: all-pipes
[464.471669] Dynamic subtest all-pipes: SUCCESS (7.526s)
[464.472480] Subtest torture-bo: SUCCESS (34.380s)
[464.649856] [102/132] (573s left) kms_cursor_crc (cursor-onscreen-32x10)
[464.806069] Starting subtest: cursor-onscreen-32x10
[464.851982] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[465.147643] [103/132] (573s left) gem_mmap_offset (partial-mmap)
[465.213289] Starting subtest: partial-mmap
[465.214189] Starting dynamic subtest: smem0
[465.216758] Dynamic subtest smem0: SUCCESS (0.003s)
[465.217632] Subtest partial-mmap: SUCCESS (0.004s)
[465.354969] [104/132] (572s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[465.450118] Starting subtest: plane-lut1d-ctm3x4-lut1d
[465.465344] Starting dynamic subtest: pipe-A-eDP-1
[465.906823] Dynamic subtest pipe-A-eDP-1: FAIL (0.301s)
[466.832890] Starting dynamic subtest: pipe-B-eDP-1
[467.321984] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[468.258514] Starting dynamic subtest: pipe-C-eDP-1
[468.709038] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[469.596860] Starting dynamic subtest: pipe-D-eDP-1
[470.047816] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[470.128830] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.677s)
[470.985581] [105/132] (567s left) gem_userptr_blits (unsync-overlap)
[471.037292] Subtest unsync-overlap: SKIP (0.000s)
[471.189656] [106/132] (567s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[471.291314] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[471.293169] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[471.423185] [107/132] (566s left) kms_selftest (drm_damage_helper)
[471.457303] Starting subtest: drm_damage_helper
[471.505583] Starting dynamic subtest: drm_test_damage_iter_no_damage
[471.650710] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.136s)
[471.668691] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[471.800626] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.148s)
[471.811062] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[471.916413] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.126s)
[471.926166] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[472.021939] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.104s)
[472.029976] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[472.154794] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.124s)
[472.163293] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[472.311961] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.156s)
[472.320317] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[472.439933] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.136s)
[472.448937] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[472.582766] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.133s)
[472.591643] Starting dynamic subtest: drm_test_damage_iter_single_damage
[472.696066] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.121s)
[472.704309] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[472.833696] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.129s)
[472.842066] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[472.914112] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.086s)
[472.924189] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[473.061084] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.137s)
[473.069547] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[473.202224] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.140s)
[473.210974] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[473.339201] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.136s)
[473.348828] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[473.479038] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.139s)
[473.488884] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[473.619373] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.139s)
[473.629198] Starting dynamic subtest: drm_test_damage_iter_damage
[473.754171] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.134s)
[473.763146] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[473.886733] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.141s)
[473.895081] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[474.033166] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.135s)
[474.042130] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[474.169090] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.135s)
[474.179159] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[474.280797] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.120s)
[474.281908] Subtest drm_damage_helper: SUCCESS (2.822s)
[474.471850] [108/132] (563s left) gem_exec_capture (capture-recoverable)
[474.533912] Starting subtest: capture-recoverable
[474.538753] Subtest capture-recoverable: SUCCESS (0.005s)
[474.684879] [109/132] (563s left) gem_tiled_swapping (non-threaded)
[474.745198] Subtest non-threaded: SKIP (0.000s)
[474.814737] [110/132] (563s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[474.905276] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[474.906380] Starting dynamic subtest: pipe-A-eDP-1
[475.741312] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.832s)
[475.749646] Starting dynamic subtest: pipe-B-eDP-1
[477.303807] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.561s)
[477.311902] Starting dynamic subtest: pipe-C-eDP-1
[478.786175] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.482s)
[478.794369] Starting dynamic subtest: pipe-D-eDP-1
[480.331935] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.547s)
[480.332826] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.427s)
[481.526559] [111/132] (557s left) gem_exec_balancer (full-pulse)
[481.592605] Starting subtest: full-pulse
[486.114578] Subtest full-pulse: SUCCESS (4.527s)
[486.446042] [112/132] (552s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[486.559662] Starting subtest: fbc-rgb565-draw-render
[490.818986] Subtest fbc-rgb565-draw-render: SUCCESS (4.263s)
[492.007078] [113/132] (546s left) kms_flip (flip-vs-panning-vs-hang)
[492.096600] Starting subtest: flip-vs-panning-vs-hang
[492.099098] Starting dynamic subtest: A-eDP1
[531.681833] Dynamic subtest A-eDP1: SUCCESS (39.593s)
[531.691874] Starting dynamic subtest: D-eDP1
[579.685240] Dynamic subtest D-eDP1: SUCCESS (47.995s)
[579.687629] Subtest flip-vs-panning-vs-hang: SUCCESS (87.592s)
[580.884076] [114/132] (457s left) kms_addfb_basic (clobberred-modifier)
[580.934305] Starting subtest: clobberred-modifier
[580.936127] Subtest clobberred-modifier: SKIP (0.000s)
[581.066116] [115/132] (457s left) gem_lmem_swapping (smem-oom)
[581.104126] Subtest smem-oom: SKIP (0.000s)
[581.136128] [116/132] (457s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[581.220454] Starting subtest: coverage-vs-premult-vs-constant
[581.511105] Starting dynamic subtest: pipe-A-eDP-1
[582.075155] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[582.084763] Starting dynamic subtest: pipe-D-eDP-1
[583.380676] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.303s)
[583.381583] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.160s)
[584.235933] [117/132] (454s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[584.344044] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[584.345774] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[584.474081] [118/132] (454s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[584.529945] Starting subtest: etime-single-wait-for-submit-submitted
[584.634910] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.104s)
[584.720611] [119/132] (454s left) gem_softpin (noreloc)
[584.784571] Starting subtest: noreloc
[590.220599] Subtest noreloc: SUCCESS (5.388s)
[590.327498] [120/132] (448s left) gem_render_tiled_blits (basic)
[590.397114] Subtest basic: SKIP (0.000s)
[590.474125] [121/132] (448s left) kms_psr (pr-suspend)
[590.578397] Starting subtest: pr-suspend
[590.580052] Subtest pr-suspend: SKIP (0.000s)
[590.665822] [122/132] (448s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[590.721483] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[590.827074] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[590.908380] [123/132] (448s left) kms_psr (psr-cursor-blt)
[591.007370] Starting subtest: psr-cursor-blt
[591.008560] Starting dynamic subtest: eDP-1
[592.720470] Dynamic subtest eDP-1: SUCCESS (1.713s)
[592.721335] Subtest psr-cursor-blt: SUCCESS (1.714s)
[593.597941] [124/132] (445s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[593.690997] Starting subtest: fbc-rgb565-draw-mmap-gtt
[593.692837] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[593.804072] [125/132] (445s left) gem_exec_params (sol-reset-not-gen7)
[593.872665] Starting subtest: sol-reset-not-gen7
[593.876985] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[594.023327] [126/132] (445s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[594.115506] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[594.117258] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[594.232838] [127/132] (444s left) kms_plane (planar-pixel-format-settings)
[594.334735] Starting subtest: planar-pixel-format-settings
[594.401600] Subtest planar-pixel-format-settings: SUCCESS (0.068s)
[594.534596] [128/132] (444s left) gem_exec_whisper (basic-fds-priority-all)
[594.598277] Starting subtest: basic-fds-priority-all
[616.400085] Subtest basic-fds-priority-all: SUCCESS (21.792s)
[616.586894] [129/132] (422s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[616.643569] Starting subtest: invalid-single-wait-all-unsubmitted
[616.644462] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[616.769473] [130/132] (422s left) kms_flip (2x-flip-vs-expired-vblank)
[616.861505] Starting subtest: 2x-flip-vs-expired-vblank
[616.871917] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[617.004334] [131/132] (422s left) gem_exec_flush (basic-batch-kernel-default-uc)
[617.064249] Starting subtest: basic-batch-kernel-default-uc
[623.996923] Subtest basic-batch-kernel-default-uc: SUCCESS (6.934s)
[624.191451] [132/132] (415s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[624.298313] Starting subtest: fbcpsr-modesetfrombusy
[630.548517] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.250s)
[630.717108] 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.