[57.445389] Initializing watchdogs
[57.445441]   /dev/watchdog0
[57.458517] [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]
[57.462734] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.464867] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.468211] [001/132] (960s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[57.600530] Starting subtest: 4-tiled-addfb-size-offset-overflow
[57.602565] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[57.718991] [002/132] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[57.806827] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[57.809222] Starting dynamic subtest: pipe-A-eDP-1
[57.926435] Dynamic subtest pipe-A-eDP-1: SKIP (0.124s)
[57.935183] Starting dynamic subtest: pipe-B-eDP-1
[59.062843] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[59.068784] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.261s)
[60.273331] [003/132] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[60.375819] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[60.380443] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[60.494598] [004/132] (957s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[60.743537] Starting subtest: cursor-rapid-movement-256x256
[60.745941] Starting dynamic subtest: pipe-A-eDP-1
[61.297680] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[61.328568] Starting dynamic subtest: pipe-D-eDP-1
[62.566999] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[62.569438] Subtest cursor-rapid-movement-256x256: SUCCESS (1.824s)
[63.415123] [005/132] (954s left) syncobj_wait (wait-delayed-signal)
[63.471720] Starting subtest: wait-delayed-signal
[63.577106] Subtest wait-delayed-signal: SUCCESS (0.103s)
[63.660097] [006/132] (954s left) gem_ctx_param (root-set)
[63.718737] Starting subtest: root-set
[63.721141] Subtest root-set: SUCCESS (0.001s)
[63.846546] [007/132] (954s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[63.903031] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[63.907527] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[64.095215] [008/132] (954s left) i915_query (query-regions-garbage-items)
[64.154089] Starting subtest: query-regions-garbage-items
[64.156118] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[64.263459] [009/132] (953s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[64.360248] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[64.362488] Starting dynamic subtest: pipe-A-default-mode
[67.129339] Dynamic subtest pipe-A-default-mode: SUCCESS (2.766s)
[67.131839] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.767s)
[68.005505] [010/132] (950s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[68.157964] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[68.160355] Starting dynamic subtest: pipe-A
[68.231242] Dynamic subtest pipe-A: SUCCESS (0.075s)
[68.240124] Starting dynamic subtest: pipe-B
[69.415925] Dynamic subtest pipe-B: SUCCESS (1.184s)
[69.425084] Starting dynamic subtest: pipe-C
[70.531422] Dynamic subtest pipe-C: SUCCESS (1.114s)
[70.540828] Starting dynamic subtest: pipe-D
[71.670385] Dynamic subtest pipe-D: SUCCESS (1.139s)
[71.672807] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.515s)
[72.835248] [011/132] (945s left) kms_psr (fbc-psr2-primary-blt)
[72.926884] Starting subtest: fbc-psr2-primary-blt
[72.929199] Starting dynamic subtest: eDP-1
[72.933536] Dynamic subtest eDP-1: SKIP (0.000s)
[72.937883] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[73.010349] [012/132] (945s left) kms_pm_lpsp (kms-lpsp)
[74.122589] Starting subtest: kms-lpsp
[74.124609] Starting dynamic subtest: pipe-A-eDP-1
[74.292884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[74.585660] Subtest kms-lpsp: SUCCESS (0.467s)
[75.464810] [013/132] (942s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[75.531047] Starting subtest: multi-wait-available-unsubmitted-submitted
[75.533482] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[75.660678] [014/132] (942s left) kms_atomic_interruptible (universal-setplane-primary)
[75.758153] Starting subtest: universal-setplane-primary
[75.760523] Starting dynamic subtest: pipe-A-eDP-1
[83.192913] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.434s)
[83.195223] Subtest universal-setplane-primary: SUCCESS (7.435s)
[84.021594] [015/132] (934s left) api_intel_allocator (two-level-inception-interruptible)
[84.074475] Starting subtest: two-level-inception-interruptible
[89.479810] Subtest two-level-inception-interruptible: SUCCESS (5.407s)
[89.626133] [016/132] (928s left) kms_joiner (basic-force-ultra-joiner)
[89.760316] Starting subtest: basic-force-ultra-joiner
[89.764406] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[89.851702] [017/132] (928s left) kms_getfb (getfb-handle-zero)
[89.952801] Starting subtest: getfb-handle-zero
[89.955164] Subtest getfb-handle-zero: SUCCESS (0.000s)
[90.101987] [018/132] (928s left) kms_fbcon_fbt (psr)
[90.182648] Starting subtest: psr
[97.538093] Subtest psr: SUCCESS (7.353s)
[97.616890] [019/132] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[97.717256] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[97.721251] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[97.844499] [020/132] (920s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[98.232060] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[99.066806] [021/132] (919s left) gem_exec_whisper (basic-sync-all)
[99.144848] Starting subtest: basic-sync-all
[105.339094] Subtest basic-sync-all: SUCCESS (6.196s)
[105.535589] [022/132] (913s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[105.650258] Starting subtest: x-tiled-32bpp-rotate-90
[105.673072] Subtest x-tiled-32bpp-rotate-90: SKIP (0.025s)
[105.816349] [023/132] (913s left) kms_psr (fbc-pr-basic)
[105.909325] Starting subtest: fbc-pr-basic
[105.913871] Subtest fbc-pr-basic: SKIP (0.000s)
[105.990658] [024/132] (912s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[106.109377] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[106.113650] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[106.221955] [025/132] (912s left) perf_pmu (init-wait)
[106.259824] Starting subtest: init-wait
[106.262074] Starting dynamic subtest: rcs0
[106.264358] Dynamic subtest rcs0: SUCCESS (0.003s)
[106.273914] Starting dynamic subtest: bcs0
[106.276113] Dynamic subtest bcs0: SUCCESS (0.001s)
[106.282933] Starting dynamic subtest: vcs0
[106.284797] Dynamic subtest vcs0: SUCCESS (0.001s)
[106.292112] Starting dynamic subtest: vcs1
[106.293873] Dynamic subtest vcs1: SUCCESS (0.000s)
[106.299822] Starting dynamic subtest: vecs0
[106.301639] Dynamic subtest vecs0: SUCCESS (0.000s)
[106.307585] Starting dynamic subtest: ccs0
[106.309842] Dynamic subtest ccs0: SUCCESS (0.000s)
[106.311874] Subtest init-wait: SUCCESS (0.007s)
[106.374219] [026/132] (912s left) kms_legacy_colorkey (invalid-plane)
[106.461850] Starting subtest: invalid-plane
[106.463892] Starting dynamic subtest: zero-id
[106.465881] Dynamic subtest zero-id: SUCCESS (0.000s)
[106.472472] Starting dynamic subtest: outrange-id
[106.474309] Dynamic subtest outrange-id: SUCCESS (0.000s)
[106.476100] Subtest invalid-plane: SUCCESS (0.001s)
[106.542161] [027/132] (912s left) kms_vblank (wait-busy-hang)
[106.634421] Starting subtest: wait-busy-hang
[106.636288] Starting dynamic subtest: pipe-A-eDP-1
[132.691329] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.055s)
[132.704725] Starting dynamic subtest: pipe-D-eDP-1
[157.652587] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.962s)
[157.654960] Subtest wait-busy-hang: SUCCESS (51.020s)
[158.464115] [028/132] (860s left) syncobj_eventfd (binary-wait)
[158.535576] Starting subtest: binary-wait
[158.546345] Subtest binary-wait: SUCCESS (0.010s)
[158.670247] [029/132] (860s left) gem_mmap_gtt (basic-read-write)
[158.719744] Subtest basic-read-write: SKIP (0.000s)
[158.786473] [030/132] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[158.899229] Starting subtest: basic-busy-flip-before-cursor-varying-size
[158.903822] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[159.050869] [031/132] (860s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[159.164696] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[163.632052] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.472s)
[164.767665] [032/132] (854s left) gem_exec_fence (syncobj-repeat)
[165.193834] Starting subtest: syncobj-repeat
[165.369667] Subtest syncobj-repeat: SUCCESS (0.175s)
[167.056633] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[167.059766] [033/132] (852s left) gem_mmap_gtt (basic-wc)
[167.130538] Subtest basic-wc: SKIP (0.000s)
[167.190810] [034/132] (852s left) kms_atomic (test-only)
[167.287618] Starting subtest: test-only
[167.360901] Starting dynamic subtest: pipe-A-eDP-1
[169.856628] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[169.859050] Subtest test-only: SUCCESS (2.571s)
[170.736166] [035/132] (848s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[170.848160] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[170.852585] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[170.979546] [036/132] (848s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[171.091832] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[172.499848] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.408s)
[173.305222] [037/132] (846s left) kms_vrr (seamless-rr-switch-drrs)
[173.395797] Starting subtest: seamless-rr-switch-drrs
[173.401811] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[173.476709] [038/132] (845s left) kms_content_protection (content-type-change)
[173.623000] Starting subtest: content-type-change
[173.627607] Subtest content-type-change: SKIP (0.000s)
[173.772307] [039/132] (845s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[173.869263] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[173.873610] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[173.949809] [040/132] (845s left) i915_pm_rpm (system-suspend-devices)
[176.074950] Starting subtest: system-suspend-devices
[183.929212] Subtest system-suspend-devices: SUCCESS (7.858s)
[184.348111] [041/132] (835s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[184.479484] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[185.469877] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.990s)
[185.636267] [042/132] (833s left) gem_mmap_gtt (basic-write-read-distinct)
[185.692637] Subtest basic-write-read-distinct: SKIP (0.000s)
[185.759104] [043/132] (833s left) gem_ctx_shared (q-in-order)
[185.826058] Starting subtest: Q-in-order
[185.827968] Starting dynamic subtest: rcs0
[185.927345] Dynamic subtest rcs0: SUCCESS (0.100s)
[185.942230] Starting dynamic subtest: vcs0
[186.004958] Dynamic subtest vcs0: SUCCESS (0.077s)
[186.020783] Starting dynamic subtest: vcs1
[186.079061] Dynamic subtest vcs1: SUCCESS (0.074s)
[186.094259] Starting dynamic subtest: vecs0
[186.148365] Dynamic subtest vecs0: SUCCESS (0.069s)
[186.163819] Starting dynamic subtest: ccs0
[186.224891] Dynamic subtest ccs0: SUCCESS (0.076s)
[186.227179] Subtest Q-in-order: SUCCESS (0.399s)
[188.062877] [044/132] (831s left) syncobj_timeline (wait-all-complex)
[188.134249] Starting subtest: wait-all-complex
[188.347332] Subtest wait-all-complex: SUCCESS (0.213s)
[188.435679] [045/132] (831s left) kms_async_flips (alternate-sync-async-flip-atomic)
[188.539898] Starting subtest: alternate-sync-async-flip-atomic
[188.923886] Starting dynamic subtest: pipe-A-eDP-1
[191.706063] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.783s)
[192.084535] Starting dynamic subtest: pipe-B-eDP-1
[194.832556] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s)
[195.210957] Starting dynamic subtest: pipe-C-eDP-1
[197.955377] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.754s)
[198.321054] Starting dynamic subtest: pipe-D-eDP-1
[201.083152] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s)
[201.085322] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.545s)
[202.261140] [046/132] (817s left) gem_ctx_create (basic-files)
[202.342266] Starting subtest: basic-files
[204.352332] Subtest basic-files: SUCCESS (2.009s)
[205.980412] [047/132] (813s left) gem_tiling_max_stride
[206.123094] [048/132] (813s left) i915_drm_fdinfo (virtual-idle)
[206.159880] Starting subtest: virtual-idle
[209.209082] Subtest virtual-idle: SUCCESS (3.048s)
[209.295034] [049/132] (810s left) kms_chamelium_edid (dp-edid-read)
[209.691816] Subtest dp-edid-read: SKIP (0.000s)
[210.493822] [050/132] (809s left) gem_ctx_persistence (process)
[210.568569] Starting subtest: process
[210.780076] Subtest process: SUCCESS (0.211s)
[210.876317] [051/132] (809s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[210.967172] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[210.969434] Starting dynamic subtest: pipe-A-eDP-1
[210.978709] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.988370] Starting dynamic subtest: pipe-B-eDP-1
[210.997440] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[211.005683] Starting dynamic subtest: pipe-C-eDP-1
[211.014614] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[211.024268] Starting dynamic subtest: pipe-D-eDP-1
[211.032688] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[211.036944] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[213.168063] [052/132] (806s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[213.267807] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[213.270151] Starting dynamic subtest: A-eDP1
[216.879563] Dynamic subtest A-eDP1: SUCCESS (3.609s)
[216.887655] Starting dynamic subtest: B-eDP1
[220.093198] Dynamic subtest B-eDP1: SUCCESS (3.213s)
[220.101602] Starting dynamic subtest: C-eDP1
[223.187932] Dynamic subtest C-eDP1: SUCCESS (3.092s)
[223.197058] Starting dynamic subtest: D-eDP1
[226.323818] Dynamic subtest D-eDP1: SUCCESS (3.134s)
[226.328747] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.061s)
[227.128170] [053/132] (792s left) core_setmaster (master-drop-set-shared-fd)
[227.238791] Starting subtest: master-drop-set-shared-fd
[227.257126] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[227.292899] [054/132] (792s left) api_intel_bb (simple-bb)
[227.349985] Starting subtest: simple-bb
[227.357714] Subtest simple-bb: SUCCESS (0.009s)
[227.511520] [055/132] (792s left) gem_exec_suspend (basic-s3-devices)
[227.575677] Starting subtest: basic-S3-devices
[227.578069] Starting dynamic subtest: smem
[238.934792] Dynamic subtest smem: SUCCESS (11.356s)
[238.937991] Subtest basic-S3-devices: SUCCESS (11.359s)
[239.140997] [056/132] (780s left) gem_exec_reloc (basic-write-gtt-active)
[239.213068] Subtest basic-write-gtt-active: SKIP (0.000s)
[239.298221] [057/132] (780s left) syncobj_wait (single-wait-all-submitted)
[239.360437] Starting subtest: single-wait-all-submitted
[239.466467] Subtest single-wait-all-submitted: SUCCESS (0.106s)
[239.552695] [058/132] (780s left) gem_exec_schedule (submit-late-slice)
[239.626470] Starting subtest: submit-late-slice
[239.628531] Starting dynamic subtest: rcs0
[239.687817] Dynamic subtest rcs0: SUCCESS (0.069s)
[239.700089] Starting dynamic subtest: bcs0
[239.732994] Dynamic subtest bcs0: SUCCESS (0.045s)
[239.741657] Starting dynamic subtest: vcs0
[239.784778] Dynamic subtest vcs0: SUCCESS (0.051s)
[239.795566] Starting dynamic subtest: vcs1
[239.842593] Dynamic subtest vcs1: SUCCESS (0.057s)
[239.853243] Starting dynamic subtest: vecs0
[239.883129] Dynamic subtest vecs0: SUCCESS (0.040s)
[239.892874] Starting dynamic subtest: ccs0
[239.938821] Dynamic subtest ccs0: SUCCESS (0.055s)
[239.941182] Subtest submit-late-slice: SUCCESS (0.322s)
[241.037650] [059/132] (779s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[241.135042] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[241.145927] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[241.272677] [060/132] (779s left) gem_pxp (create-valid-protected-context)
[241.407472] Starting subtest: create-valid-protected-context
[241.410114] Subtest create-valid-protected-context: SUCCESS (0.002s)
[241.546051] [061/132] (778s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[241.651811] Starting subtest: fbcpsr-tiling-linear
[248.238495] Subtest fbcpsr-tiling-linear: SUCCESS (6.589s)
[248.394935] [062/132] (771s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[248.506053] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[248.508257] Starting dynamic subtest: pipe-A-eDP-1
[248.580393] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[248.590431] Starting dynamic subtest: pipe-B-eDP-1
[249.720998] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[249.725323] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.218s)
[250.942964] [063/132] (769s left) gem_ctx_persistence (engines-mixed-process)
[251.010782] Starting subtest: engines-mixed-process
[251.013219] Starting dynamic subtest: rcs0
[252.919331] Dynamic subtest rcs0: SUCCESS (1.908s)
[252.930753] Starting dynamic subtest: bcs0
[254.876081] Dynamic subtest bcs0: SUCCESS (1.955s)
[254.886829] Starting dynamic subtest: vcs0
[256.899670] Dynamic subtest vcs0: SUCCESS (2.021s)
[256.916171] Starting dynamic subtest: vcs1
[258.906717] Dynamic subtest vcs1: SUCCESS (2.007s)
[258.917394] Starting dynamic subtest: vecs0
[260.886538] Dynamic subtest vecs0: SUCCESS (1.978s)
[260.895538] Starting dynamic subtest: ccs0
[262.891759] Dynamic subtest ccs0: SUCCESS (2.003s)
[262.894255] Subtest engines-mixed-process: SUCCESS (11.882s)
[262.986700] [064/132] (757s left) gem_ccs (block-copy-compressed)
[263.046388] Starting subtest: block-copy-compressed
[263.051122] Subtest block-copy-compressed: SKIP (0.000s)
[263.175999] [065/132] (757s left) gem_eio (unwedge-stress)
[263.415210] Starting subtest: unwedge-stress
[263.417913] Starting dynamic subtest: render
[268.606277] Dynamic subtest render: SUCCESS (5.188s)
[268.621635] Starting dynamic subtest: bsd1
[286.401498] Dynamic subtest bsd1: SUCCESS (17.794s)
[286.417082] Starting dynamic subtest: bsd2
[304.388033] Dynamic subtest bsd2: SUCCESS (17.986s)
[304.403692] Starting dynamic subtest: blt
[304.407849] Dynamic subtest blt: SKIP (0.000s)
[304.416746] Starting dynamic subtest: vebox
[322.427110] Dynamic subtest vebox: SUCCESS (18.038s)
[322.429045] Subtest unwedge-stress: SUCCESS (59.011s)
[323.981265] [066/132] (696s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[324.041277] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[324.100062] [067/132] (696s left) kms_flip (busy-flip)
[324.186289] Starting subtest: busy-flip
[324.188538] Starting dynamic subtest: A-eDP1
[325.935084] Dynamic subtest A-eDP1: SUCCESS (1.748s)
[325.944604] Starting dynamic subtest: B-eDP1
[327.576957] Dynamic subtest B-eDP1: SUCCESS (1.640s)
[327.588235] Starting dynamic subtest: C-eDP1
[329.214431] Dynamic subtest C-eDP1: SUCCESS (1.636s)
[329.224298] Starting dynamic subtest: D-eDP1
[330.851886] Dynamic subtest D-eDP1: SUCCESS (1.631s)
[330.854238] Subtest busy-flip: SUCCESS (6.667s)
[332.118014] [068/132] (688s left) i915_drm_fdinfo (virtual-busy-hang)
[332.172225] Starting subtest: virtual-busy-hang
[332.176526] Subtest virtual-busy-hang: SKIP (0.000s)
[332.253600] [069/132] (688s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[332.351881] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[332.356080] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[332.434354] [070/132] (688s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[332.530152] Starting subtest: invalidate-primary-flip-overlay
[343.324844] Subtest invalidate-primary-flip-overlay: SUCCESS (10.797s)
[343.476816] [071/132] (677s left) kms_pm_rpm (system-suspend-idle)
[345.106425] Starting subtest: system-suspend-idle
[364.584789] Subtest system-suspend-idle: SUCCESS (4.599s)
[364.974950] [072/132] (655s left) gem_ccs (suspend-resume)
[365.048230] Starting subtest: suspend-resume
[365.052964] Subtest suspend-resume: SKIP (0.000s)
[365.162087] [073/132] (655s left) kms_big_fb (linear-16bpp-rotate-180)
[365.265636] Starting subtest: linear-16bpp-rotate-180
[366.665662] Subtest linear-16bpp-rotate-180: SUCCESS (1.400s)
[366.788767] [074/132] (654s left) kms_plane_lowres (tiling-x)
[366.884564] Starting subtest: tiling-x
[366.886514] Starting dynamic subtest: pipe-A-eDP-1
[366.890301] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.186040] Starting dynamic subtest: pipe-B-eDP-1
[367.190650] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.199399] Starting dynamic subtest: pipe-C-eDP-1
[367.204026] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.212803] Starting dynamic subtest: pipe-D-eDP-1
[367.217558] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.221970] Subtest tiling-x: SKIP (0.300s)
[367.990680] [075/132] (652s left) gem_close_race (basic-threads)
[368.053332] Starting subtest: basic-threads
[369.463722] Subtest basic-threads: SUCCESS (1.409s)
[369.662741] [076/132] (651s left) kms_getfb (getfb-handle-protection)
[369.767356] Starting subtest: getfb-handle-protection
[369.799233] Subtest getfb-handle-protection: SUCCESS (0.032s)
[369.946863] [077/132] (651s left) kms_feature_discovery (display)
[370.038164] Starting subtest: display
[370.040383] Subtest display: SUCCESS (0.000s)
[370.125129] [078/132] (650s left) kms_chamelium_color (ctm-0-25)
[370.223641] Subtest ctm-0-25: SKIP (0.000s)
[370.270407] [079/132] (650s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[370.376488] Starting subtest: y-tiled-8bpp-rotate-180
[370.380567] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[370.502567] [080/132] (650s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[370.620380] Starting subtest: flip-vs-cursor-crc-atomic
[371.255881] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.635s)
[372.141808] [081/132] (648s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[372.254034] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[379.436464] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.182s)
[379.580875] [082/132] (641s left) kms_frontbuffer_tracking (psr-1p-rte)
[379.681875] Starting subtest: psr-1p-rte
[385.010630] Subtest psr-1p-rte: SUCCESS (5.331s)
[385.169869] [083/132] (636s left) gem_wait (write-wait)
[385.241876] Starting subtest: write-wait
[385.244153] Starting dynamic subtest: all-engines
[386.375941] Dynamic subtest all-engines: SUCCESS (1.133s)
[386.392613] Starting dynamic subtest: rcs0
[387.435657] Dynamic subtest rcs0: SUCCESS (1.057s)
[387.452013] Starting dynamic subtest: bcs0
[388.492261] Dynamic subtest bcs0: SUCCESS (1.054s)
[388.508400] Starting dynamic subtest: vcs0
[389.547483] Dynamic subtest vcs0: SUCCESS (1.053s)
[389.564352] Starting dynamic subtest: vcs1
[390.602367] Dynamic subtest vcs1: SUCCESS (1.052s)
[390.617089] Starting dynamic subtest: vecs0
[391.653277] Dynamic subtest vecs0: SUCCESS (1.050s)
[391.670144] Starting dynamic subtest: ccs0
[392.710879] Dynamic subtest ccs0: SUCCESS (1.055s)
[392.713765] Subtest write-wait: SUCCESS (7.468s)
[392.921293] [084/132] (628s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[393.020290] Starting subtest: bad-pixel-format-y-tiled-ccs
[393.022537] Starting dynamic subtest: pipe-A-eDP-1
[393.045940] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[393.056707] Starting dynamic subtest: pipe-B-eDP-1
[393.078527] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[393.087472] Starting dynamic subtest: pipe-C-eDP-1
[393.109446] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[393.119367] Starting dynamic subtest: pipe-D-eDP-1
[393.141765] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[393.145941] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[395.345704] [085/132] (625s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[395.449490] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[395.453835] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[395.553387] [086/132] (625s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[395.644901] Starting subtest: fbc-shrfb-scaledprimary
[398.698234] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.057s)
[399.848541] [087/132] (621s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[399.945664] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[399.947995] Starting dynamic subtest: pipe-A-eDP-1
[399.971297] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[399.984498] Starting dynamic subtest: pipe-B-eDP-1
[400.005299] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[400.013825] Starting dynamic subtest: pipe-C-eDP-1
[400.034613] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[400.044128] Starting dynamic subtest: pipe-D-eDP-1
[400.065364] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[400.069423] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[402.301648] [088/132] (619s left) gen9_exec_parse (bb-large)
[402.374698] Subtest bb-large: SKIP (0.000s)
[402.439286] [089/132] (619s left) perf (i915-ref-count)
[402.519482] Starting subtest: i915-ref-count
[402.580186] Subtest i915-ref-count: SUCCESS (0.059s)
[402.637327] [090/132] (618s left) sw_sync (alloc_fence_invalid_timeline)
[402.679779] Starting subtest: alloc_fence_invalid_timeline
[402.682071] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[402.750454] [091/132] (618s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[402.842706] Starting subtest: psr-modesetfrombusy
[409.059344] Subtest psr-modesetfrombusy: SUCCESS (6.221s)
[409.229825] [092/132] (612s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[409.333610] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[409.337169] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[409.461065] [093/132] (612s left) gem_softpin (allocator-basic)
[409.529578] Starting subtest: allocator-basic
[409.594832] Subtest allocator-basic: SUCCESS (0.064s)
[409.725234] [094/132] (611s left) gem_render_copy (linear-to-vebox-y-tiled)
[409.783216] Starting subtest: linear-to-vebox-y-tiled
[409.786899] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[409.980157] [095/132] (611s left) gem_mmap_gtt (hang)
[410.050329] Subtest hang: SKIP (0.000s)
[410.111040] [096/132] (611s left) gem_exec_schedule (out-order)
[410.184761] Starting subtest: out-order
[410.186743] Starting dynamic subtest: rcs0
[410.276222] Dynamic subtest rcs0: SUCCESS (0.099s)
[410.287841] Starting dynamic subtest: vcs0
[410.369305] Dynamic subtest vcs0: SUCCESS (0.092s)
[410.381699] Starting dynamic subtest: vcs1
[410.448296] Dynamic subtest vcs1: SUCCESS (0.078s)
[410.459282] Starting dynamic subtest: vecs0
[410.525215] Dynamic subtest vecs0: SUCCESS (0.076s)
[410.537035] Starting dynamic subtest: ccs0
[410.603515] Dynamic subtest ccs0: SUCCESS (0.077s)
[410.605966] Subtest out-order: SUCCESS (0.427s)
[411.883579] [097/132] (609s left) gem_exec_reloc (basic-scanout)
[411.953091] Subtest basic-scanout: SKIP (0.000s)
[412.017776] [098/132] (609s left) kms_psr (fbc-psr-primary-render)
[412.109281] Starting subtest: fbc-psr-primary-render
[412.111573] Starting dynamic subtest: eDP-1
[412.116003] Dynamic subtest eDP-1: SKIP (0.000s)
[412.120090] Subtest fbc-psr-primary-render: SKIP (0.003s)
[412.207709] [099/132] (609s left) prime_mmap (test_correct_cpu_write)
[412.259704] Starting subtest: test_correct_cpu_write
[412.262017] Starting dynamic subtest: test_correct_cpu_write-smem
[412.263973] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[412.265956] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[412.372775] [100/132] (609s left) syncobj_timeline (invalid-signal-zero-handles)
[412.443823] Starting subtest: invalid-signal-zero-handles
[412.445751] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[412.555271] [101/132] (609s left) kms_cursor_legacy (torture-bo)
[412.669542] Starting subtest: torture-bo
[412.671699] Starting dynamic subtest: pipe-A
[418.609473] Dynamic subtest pipe-A: SUCCESS (5.936s)
[418.621121] Starting dynamic subtest: pipe-B
[426.412331] Dynamic subtest pipe-B: SUCCESS (7.801s)
[426.423256] Starting dynamic subtest: pipe-C
[433.409510] Dynamic subtest pipe-C: SUCCESS (6.993s)
[433.420411] Starting dynamic subtest: pipe-D
[440.060542] Dynamic subtest pipe-D: SUCCESS (6.650s)
[440.071542] Starting dynamic subtest: all-pipes
[447.537243] Dynamic subtest all-pipes: SUCCESS (7.473s)
[447.539829] Subtest torture-bo: SUCCESS (34.864s)
[447.705756] [102/132] (574s left) kms_cursor_crc (cursor-onscreen-32x10)
[447.870220] Starting subtest: cursor-onscreen-32x10
[447.919975] Subtest cursor-onscreen-32x10: SKIP (0.040s)
[448.198491] [103/132] (573s left) gem_mmap_offset (partial-mmap)
[448.260759] Starting subtest: partial-mmap
[448.263109] Starting dynamic subtest: smem0
[448.265526] Dynamic subtest smem0: SUCCESS (0.003s)
[448.267782] Subtest partial-mmap: SUCCESS (0.004s)
[448.410312] [104/132] (573s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[448.512112] Starting subtest: plane-lut1d-ctm3x4-lut1d
[448.524874] Starting dynamic subtest: pipe-A-eDP-1
[449.201673] Dynamic subtest pipe-A-eDP-1: FAIL (0.342s)
[449.928148] Starting dynamic subtest: pipe-B-eDP-1
[450.749553] Dynamic subtest pipe-B-eDP-1: FAIL (0.279s)
[451.255374] Starting dynamic subtest: pipe-C-eDP-1
[452.062203] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[452.584082] Starting dynamic subtest: pipe-D-eDP-1
[453.434861] Dynamic subtest pipe-D-eDP-1: FAIL (0.268s)
[453.437209] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.611s)
[454.000912] [105/132] (568s left) gem_userptr_blits (unsync-overlap)
[454.079329] Subtest unsync-overlap: SKIP (0.000s)
[454.228797] [106/132] (567s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[454.328786] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[454.333175] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[454.419569] [107/132] (567s left) kms_selftest (drm_damage_helper)
[454.458915] Starting subtest: drm_damage_helper
[454.495939] Starting dynamic subtest: drm_test_damage_iter_no_damage
[454.647395] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.149s)
[454.657975] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[454.776380] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.128s)
[454.786481] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[454.936080] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.157s)
[454.945896] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[455.105120] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.168s)
[455.114256] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[455.252183] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.146s)
[455.261499] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[455.395122] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.142s)
[455.404100] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[455.542058] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.145s)
[455.551213] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[455.670230] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.127s)
[455.679272] Starting dynamic subtest: drm_test_damage_iter_single_damage
[455.830939] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.160s)
[455.839660] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[455.979575] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.148s)
[455.988344] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[456.138018] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.157s)
[456.147491] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[456.297979] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.159s)
[456.308007] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[456.459958] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.161s)
[456.470283] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[456.602442] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.141s)
[456.612954] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[456.742680] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.138s)
[456.753023] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[456.908044] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.166s)
[456.918362] Starting dynamic subtest: drm_test_damage_iter_damage
[457.045329] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.134s)
[457.055099] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[457.197868] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.151s)
[457.207747] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[457.334298] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.135s)
[457.343677] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[457.487243] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.152s)
[457.496696] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[457.671305] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.184s)
[457.673323] Subtest drm_damage_helper: SUCCESS (3.210s)
[457.880724] [108/132] (564s left) gem_exec_capture (capture-recoverable)
[457.944347] Starting subtest: capture-recoverable
[457.949513] Subtest capture-recoverable: SUCCESS (0.005s)
[458.101483] [109/132] (564s left) gem_tiled_swapping (non-threaded)
[458.158764] Subtest non-threaded: SKIP (0.000s)
[458.228941] [110/132] (564s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[458.328872] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[458.331097] Starting dynamic subtest: pipe-A-eDP-1
[459.121426] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.785s)
[459.131353] Starting dynamic subtest: pipe-B-eDP-1
[460.676506] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.553s)
[460.686254] Starting dynamic subtest: pipe-C-eDP-1
[462.188591] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.511s)
[462.199043] Starting dynamic subtest: pipe-D-eDP-1
[463.714303] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.523s)
[463.716242] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.376s)
[464.903607] [111/132] (557s left) gem_exec_balancer (full-pulse)
[464.972580] Starting subtest: full-pulse
[469.646940] Subtest full-pulse: SUCCESS (4.674s)
[470.000237] [112/132] (552s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[470.100162] Starting subtest: fbc-rgb565-draw-render
[474.316756] Subtest fbc-rgb565-draw-render: SUCCESS (4.222s)
[475.515118] [113/132] (546s left) kms_flip (flip-vs-panning-vs-hang)
[475.617492] Starting subtest: flip-vs-panning-vs-hang
[475.619673] Starting dynamic subtest: A-eDP1
[515.293328] Dynamic subtest A-eDP1: SUCCESS (39.675s)
[515.304128] Starting dynamic subtest: D-eDP1
[565.279896] Dynamic subtest D-eDP1: SUCCESS (49.982s)
[565.282301] Subtest flip-vs-panning-vs-hang: SUCCESS (89.662s)
[566.484495] [114/132] (455s left) kms_addfb_basic (clobberred-modifier)
[566.545150] Starting subtest: clobberred-modifier
[566.549585] Subtest clobberred-modifier: SKIP (0.000s)
[566.693533] [115/132] (455s left) gem_lmem_swapping (smem-oom)
[566.739963] Subtest smem-oom: SKIP (0.000s)
[566.790084] [116/132] (455s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[566.889608] Starting subtest: coverage-vs-premult-vs-constant
[567.189945] Starting dynamic subtest: pipe-A-eDP-1
[567.789024] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[567.798756] Starting dynamic subtest: pipe-D-eDP-1
[569.084721] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s)
[569.086974] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.195s)
[569.945557] [117/132] (452s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[570.053571] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[570.057616] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[570.173639] [118/132] (452s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[570.223244] Starting subtest: etime-single-wait-for-submit-submitted
[570.330206] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s)
[570.414607] [119/132] (452s left) gem_softpin (noreloc)
[570.469662] Starting subtest: noreloc
[575.865811] Subtest noreloc: SUCCESS (5.394s)
[576.018773] [120/132] (446s left) gem_render_tiled_blits (basic)
[576.087859] Subtest basic: SKIP (0.000s)
[576.175497] [121/132] (446s left) kms_psr (pr-suspend)
[576.284892] Starting subtest: pr-suspend
[576.289651] Subtest pr-suspend: SKIP (0.000s)
[576.366973] [122/132] (446s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[576.425958] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[576.530640] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[576.618656] [123/132] (446s left) kms_psr (psr-cursor-blt)
[576.710330] Starting subtest: psr-cursor-blt
[576.712715] Starting dynamic subtest: eDP-1
[578.437945] Dynamic subtest eDP-1: SUCCESS (1.728s)
[578.440316] Subtest psr-cursor-blt: SUCCESS (1.729s)
[579.322743] [124/132] (443s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[579.417897] Starting subtest: fbc-rgb565-draw-mmap-gtt
[579.422406] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[579.535379] [125/132] (443s left) gem_exec_params (sol-reset-not-gen7)
[579.601924] Starting subtest: sol-reset-not-gen7
[579.607434] Subtest sol-reset-not-gen7: SUCCESS (0.004s)
[579.754378] [126/132] (443s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[579.859741] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[579.863849] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[579.984877] [127/132] (443s left) kms_plane (planar-pixel-format-settings)
[580.068283] Starting subtest: planar-pixel-format-settings
[580.128255] Subtest planar-pixel-format-settings: SUCCESS (0.063s)
[580.274132] [128/132] (442s left) gem_exec_whisper (basic-fds-priority-all)
[580.340080] Starting subtest: basic-fds-priority-all
[602.558814] Subtest basic-fds-priority-all: SUCCESS (22.213s)
[602.752995] [129/132] (420s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[602.810819] Starting subtest: invalid-single-wait-all-unsubmitted
[602.812959] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[602.914787] [130/132] (420s left) kms_flip (2x-flip-vs-expired-vblank)
[603.019739] Starting subtest: 2x-flip-vs-expired-vblank
[603.030517] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[603.120754] [131/132] (420s left) gem_exec_flush (basic-batch-kernel-default-uc)
[603.190680] Starting subtest: basic-batch-kernel-default-uc
[610.388761] Subtest basic-batch-kernel-default-uc: SUCCESS (7.198s)
[610.586832] [132/132] (412s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[610.680862] Starting subtest: fbcpsr-modesetfrombusy
[616.963924] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.287s)
[617.137233] 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.