[60.453759] Initializing watchdogs
[60.453808]   /dev/watchdog0
[60.468832] [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]
[60.473369] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.475912] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.479230] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[60.598488] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[60.602642] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[60.684967] [002/131] (960s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[60.780729] Starting subtest: 2x-absolute-wf_vblank-interruptible
[60.792396] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[60.898221] [003/131] (960s left) kms_plane (plane-position-hole)
[61.001715] Starting subtest: plane-position-hole
[61.529030] Starting dynamic subtest: pipe-A-plane-1
[62.786479] Dynamic subtest pipe-A-plane-1: SUCCESS (1.255s)
[62.793074] Starting dynamic subtest: pipe-A-plane-2
[64.010528] Dynamic subtest pipe-A-plane-2: SUCCESS (1.226s)
[64.019338] Starting dynamic subtest: pipe-A-plane-3
[65.247615] Dynamic subtest pipe-A-plane-3: SUCCESS (1.235s)
[65.255804] Starting dynamic subtest: pipe-A-plane-4
[66.479400] Dynamic subtest pipe-A-plane-4: SUCCESS (1.232s)
[66.488948] Starting dynamic subtest: pipe-A-plane-5
[66.505053] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[67.629454] Starting dynamic subtest: pipe-B-plane-1
[68.860088] Dynamic subtest pipe-B-plane-1: SUCCESS (1.235s)
[68.868626] Starting dynamic subtest: pipe-B-plane-2
[70.097861] Dynamic subtest pipe-B-plane-2: SUCCESS (1.238s)
[70.106033] Starting dynamic subtest: pipe-B-plane-3
[71.323864] Dynamic subtest pipe-B-plane-3: SUCCESS (1.226s)
[71.333324] Starting dynamic subtest: pipe-B-plane-4
[72.553837] Dynamic subtest pipe-B-plane-4: SUCCESS (1.230s)
[72.563046] Starting dynamic subtest: pipe-B-plane-5
[72.579360] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[72.581534] Subtest plane-position-hole: SUCCESS (11.575s)
[73.363769] [004/131] (947s left) kms_flip (nonblocking-read)
[73.471197] Starting subtest: nonblocking-read
[73.473233] Subtest nonblocking-read: SUCCESS (0.000s)
[73.578122] [005/131] (947s left) gem_tiled_pread_basic
[73.692831] [006/131] (947s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[73.798999] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[74.809238] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.010s)
[74.927454] [007/131] (946s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[75.029167] Starting subtest: fbc-psr-cursor-mmap-cpu
[75.030729] Starting dynamic subtest: eDP-1
[75.034041] Dynamic subtest eDP-1: SKIP (0.000s)
[75.037409] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[75.095199] [008/131] (946s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[75.186619] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[75.188680] Starting dynamic subtest: pipe-A-eDP-1
[75.207993] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[75.216250] Starting dynamic subtest: pipe-B-eDP-1
[75.233431] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[75.239622] Starting dynamic subtest: pipe-C-eDP-1
[75.257550] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[75.263711] Starting dynamic subtest: pipe-D-eDP-1
[75.282345] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[75.285904] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.002s)
[77.339891] [009/131] (943s left) kms_getfb (getfb2-accept-nv12)
[77.426069] Starting subtest: getfb2-accept-nv12
[77.428307] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[77.536608] [010/131] (943s left) kms_pm_rpm (cursor-dpms)
[79.067130] Starting subtest: cursor-dpms
[79.072477] Subtest cursor-dpms: SKIP (0.000s)
[79.784903] [011/131] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[79.892976] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[79.896833] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[80.000952] [012/131] (941s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[80.380920] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[81.200403] [013/131] (940s left) gem_pread (self)
[81.262171] Subtest self: SKIP (0.000s)
[81.326831] [014/131] (940s left) gem_bad_reloc (negative-reloc-lut)
[81.391811] Subtest negative-reloc-lut: SKIP (0.000s)
[81.449434] [015/131] (940s left) sriov_basic (enable-vfs-autoprobe-on)
[81.491738] Starting subtest: enable-vfs-autoprobe-on
[81.494221] Starting dynamic subtest: numvfs-1
[81.576937] Dynamic subtest numvfs-1: FAIL (0.031s)
[81.583185] Starting dynamic subtest: numvfs-2
[81.657509] Dynamic subtest numvfs-2: FAIL (0.004s)
[81.665817] Starting dynamic subtest: numvfs-3
[81.739897] Dynamic subtest numvfs-3: FAIL (0.004s)
[81.747915] Starting dynamic subtest: numvfs-4
[81.821050] Dynamic subtest numvfs-4: FAIL (0.004s)
[81.828926] Starting dynamic subtest: numvfs-5
[81.900513] Dynamic subtest numvfs-5: FAIL (0.004s)
[81.907973] Starting dynamic subtest: numvfs-6
[81.981200] Dynamic subtest numvfs-6: FAIL (0.004s)
[81.989741] Starting dynamic subtest: numvfs-7
[82.062953] Dynamic subtest numvfs-7: FAIL (0.004s)
[82.071394] Starting dynamic subtest: numvfs-random
[82.142173] Dynamic subtest numvfs-random: FAIL (0.004s)
[82.150488] Starting dynamic subtest: numvfs-all
[82.212270] Dynamic subtest numvfs-all: FAIL (0.500s)
[82.213996] Subtest enable-vfs-autoprobe-on: FAIL (0.561s)
[82.246213] [016/131] (939s left) gem_ctx_param (invalid-get-ringsize)
[82.287310] Starting subtest: invalid-get-ringsize
[82.289409] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[82.393178] [017/131] (939s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[82.440463] Starting subtest: multi-wait-all-for-submit-submitted
[82.544648] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[82.617522] [018/131] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[82.727730] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[82.732162] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[82.834090] [019/131] (938s left) kms_flip (modeset-vs-vblank-race-interruptible)
[82.929596] Starting subtest: modeset-vs-vblank-race-interruptible
[82.931875] Starting dynamic subtest: A-eDP1
[87.640488] Dynamic subtest A-eDP1: SUCCESS (4.709s)
[87.650049] Starting dynamic subtest: B-eDP1
[92.271459] Dynamic subtest B-eDP1: SUCCESS (4.630s)
[92.280522] Starting dynamic subtest: C-eDP1
[96.884619] Dynamic subtest C-eDP1: SUCCESS (4.612s)
[96.891512] Starting dynamic subtest: D-eDP1
[101.441955] Dynamic subtest D-eDP1: SUCCESS (4.556s)
[101.447343] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.516s)
[102.593953] [020/131] (919s left) kms_psr (fbc-psr-sprite-render)
[102.692362] Starting subtest: fbc-psr-sprite-render
[102.694733] Starting dynamic subtest: eDP-1
[102.699216] Dynamic subtest eDP-1: SKIP (0.000s)
[102.703648] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[102.765242] [021/131] (918s left) gem_softpin (allocator-basic-reserve)
[102.823318] Starting subtest: allocator-basic-reserve
[102.899657] Subtest allocator-basic-reserve: SUCCESS (0.076s)
[103.041074] [022/131] (918s left) drm_read (invalid-buffer)
[103.179085] Starting subtest: invalid-buffer
[103.181498] Subtest invalid-buffer: SUCCESS (0.000s)
[103.317539] [023/131] (918s left) i915_drm_fdinfo (memory-info-shared)
[103.356858] Starting subtest: memory-info-shared
[103.359247] Starting dynamic subtest: smem0
[103.434339] Dynamic subtest smem0: SUCCESS (0.079s)
[103.436808] Subtest memory-info-shared: SUCCESS (0.079s)
[103.504519] [024/131] (918s left) i915_drm_fdinfo (busy-idle)
[103.539360] Starting subtest: busy-idle
[103.541467] Starting dynamic subtest: rcs0
[103.563310] Dynamic subtest rcs0: SKIP (0.022s)
[103.571568] Starting dynamic subtest: bcs0
[103.579058] Dynamic subtest bcs0: SKIP (0.016s)
[103.585355] Starting dynamic subtest: vcs0
[103.588788] Dynamic subtest vcs0: SKIP (0.000s)
[103.595141] Starting dynamic subtest: vcs1
[103.599105] Dynamic subtest vcs1: SKIP (0.000s)
[103.605773] Starting dynamic subtest: vecs0
[103.609068] Dynamic subtest vecs0: SKIP (0.000s)
[103.615444] Starting dynamic subtest: ccs0
[103.619045] Dynamic subtest ccs0: SKIP (0.000s)
[103.622520] Subtest busy-idle: SKIP (0.040s)
[103.658735] [025/131] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[103.761642] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[103.765077] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[103.855808] [026/131] (918s left) kms_psr (psr2-sprite-plane-onoff)
[103.953926] Starting subtest: psr2-sprite-plane-onoff
[103.955797] Starting dynamic subtest: eDP-1
[105.730870] Dynamic subtest eDP-1: SUCCESS (1.775s)
[105.733231] Subtest psr2-sprite-plane-onoff: SUCCESS (1.776s)
[106.558279] [027/131] (915s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[106.653976] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[106.656265] Starting dynamic subtest: pipe-A-eDP-1
[106.679052] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[106.687843] Starting dynamic subtest: pipe-B-eDP-1
[106.709043] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[106.716056] Starting dynamic subtest: pipe-C-eDP-1
[106.737121] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[106.743882] Starting dynamic subtest: pipe-D-eDP-1
[106.765125] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[106.769145] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.003s)
[108.816421] [028/131] (913s left) kms_dp_link_training (uhbr-sst)
[108.918848] Starting subtest: uhbr-sst
[108.927849] Subtest uhbr-sst: SKIP (0.000s)
[108.987376] [029/131] (913s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[114.013796] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[114.016289] Starting dynamic subtest: pipe-A-eDP-1
[114.812773] Dynamic subtest pipe-A-eDP-1: SKIP (0.795s)
[114.820445] Starting dynamic subtest: pipe-B-eDP-1
[115.952943] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s)
[115.957668] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.936s)
[117.127455] [030/131] (904s left) perf (blocking-parameterized)
[117.238568] Starting subtest: blocking-parameterized
[137.258360] Subtest blocking-parameterized: SUCCESS (20.020s)
[137.301644] [031/131] (884s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[137.433028] Starting subtest: cursorA-vs-flipB-legacy
[137.437356] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[137.576503] [032/131] (884s left) kms_color (deep-color)
[137.669028] Starting subtest: deep-color
[138.708216] Starting dynamic subtest: pipe-A-eDP-1-gamma
[139.442615] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.734s)
[139.450687] Starting dynamic subtest: pipe-A-eDP-1-degamma
[140.921650] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.477s)
[140.930102] Starting dynamic subtest: pipe-A-eDP-1-ctm
[142.337815] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.417s)
[143.112056] Starting dynamic subtest: pipe-B-eDP-1-gamma
[143.824822] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.718s)
[143.832655] Starting dynamic subtest: pipe-B-eDP-1-degamma
[145.303597] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.478s)
[145.311202] Starting dynamic subtest: pipe-B-eDP-1-ctm
[146.704657] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.399s)
[147.522090] Starting dynamic subtest: pipe-C-eDP-1-gamma
[148.218310] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.700s)
[148.226951] Starting dynamic subtest: pipe-C-eDP-1-degamma
[149.566482] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.349s)
[149.574928] Starting dynamic subtest: pipe-C-eDP-1-ctm
[151.001554] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.433s)
[151.753175] Starting dynamic subtest: pipe-D-eDP-1-gamma
[152.395534] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.647s)
[152.402647] Starting dynamic subtest: pipe-D-eDP-1-degamma
[153.796310] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.398s)
[153.803603] Starting dynamic subtest: pipe-D-eDP-1-ctm
[155.198819] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.405s)
[155.201244] Subtest deep-color: SUCCESS (17.530s)
[156.003344] [033/131] (866s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[156.071533] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[156.127847] [034/131] (866s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[156.218303] Starting subtest: async-flip-with-page-flip-events-linear
[156.601940] Starting dynamic subtest: pipe-A-eDP-1
[159.395053] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.793s)
[159.760090] Starting dynamic subtest: pipe-B-eDP-1
[162.523304] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s)
[162.897290] Starting dynamic subtest: pipe-C-eDP-1
[165.661363] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[166.020543] Starting dynamic subtest: pipe-D-eDP-1
[168.790246] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s)
[168.792945] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.571s)
[169.969257] [035/131] (852s left) kms_lease (lessee-list)
[170.070285] Starting subtest: lessee-list
[170.072691] Starting dynamic subtest: pipe-A-eDP-1
[170.075171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[170.088067] Starting dynamic subtest: pipe-B-eDP-1
[170.090047] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[170.098707] Starting dynamic subtest: pipe-C-eDP-1
[170.100563] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[170.107035] Starting dynamic subtest: pipe-D-eDP-1
[170.108871] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[170.110749] Subtest lessee-list: SUCCESS (0.010s)
[170.189910] [036/131] (852s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[170.290682] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[176.926542] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.639s)
[177.066632] [037/131] (845s left) sysfs_timeslice_duration (timeout)
[177.127755] Starting subtest: timeout
[177.130072] Starting dynamic subtest: vecs0
[186.916959] Dynamic subtest vecs0: SUCCESS (9.785s)
[186.926881] Starting dynamic subtest: ccs0
[188.336857] Dynamic subtest ccs0: SUCCESS (1.419s)
[188.346568] Starting dynamic subtest: vcs0
[197.923214] Dynamic subtest vcs0: SUCCESS (9.584s)
[197.933243] Starting dynamic subtest: bcs0
[198.617806] Dynamic subtest bcs0: SUCCESS (0.695s)
[198.624940] Starting dynamic subtest: rcs0
[199.982575] Dynamic subtest rcs0: SUCCESS (1.362s)
[199.994392] Starting dynamic subtest: vcs1
[209.880411] Dynamic subtest vcs1: SUCCESS (9.895s)
[209.882995] Subtest timeout: SUCCESS (32.750s)
[209.953869] [038/131] (812s left) gem_userptr_blits (create-destroy-unsync)
[210.019400] Subtest create-destroy-unsync: SKIP (0.000s)
[210.152446] [039/131] (812s left) gem_mmap_gtt (ptrace)
[210.216592] Subtest ptrace: SKIP (0.000s)
[210.283439] [040/131] (812s left) syncobj_wait (wait-all-for-submit-complex)
[210.329679] Starting subtest: wait-all-for-submit-complex
[210.543232] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[210.620796] [041/131] (811s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[210.727420] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[217.984358] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.261s)
[218.120972] [042/131] (804s left) gem_exec_fence (syncobj-timeline-wait)
[218.669681] Starting subtest: syncobj-timeline-wait
[219.914422] Subtest syncobj-timeline-wait: SUCCESS (1.244s)
[220.168231] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[220.171969] [043/131] (802s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[220.274584] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[220.278646] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[220.380647] [044/131] (802s left) syncobj_timeline (transfer-timeline-point)
[220.432951] Starting subtest: transfer-timeline-point
[220.434965] Subtest transfer-timeline-point: SUCCESS (0.000s)
[220.539249] [045/131] (802s left) gem_spin_batch (legacy)
[220.602084] Starting subtest: legacy
[220.604564] Starting dynamic subtest: default
[223.843724] Dynamic subtest default: SUCCESS (3.236s)
[223.851287] Starting dynamic subtest: render
[227.076967] Dynamic subtest render: SUCCESS (3.231s)
[227.083987] Starting dynamic subtest: bsd
[230.312497] Dynamic subtest bsd: SUCCESS (3.233s)
[230.320929] Starting dynamic subtest: bsd1
[233.549945] Dynamic subtest bsd1: SUCCESS (3.236s)
[233.557472] Starting dynamic subtest: bsd2
[236.787226] Dynamic subtest bsd2: SUCCESS (3.234s)
[236.796264] Starting dynamic subtest: blt
[240.023238] Dynamic subtest blt: SUCCESS (3.234s)
[240.031469] Starting dynamic subtest: vebox
[243.259946] Dynamic subtest vebox: SUCCESS (3.234s)
[243.262026] Subtest legacy: SUCCESS (22.655s)
[243.956179] [046/131] (778s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[244.065117] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[244.069662] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[244.162416] [047/131] (778s left) api_intel_allocator (gem-pool)
[244.220628] Starting subtest: gem-pool
[244.229902] Subtest gem-pool: SUCCESS (0.010s)
[244.378491] [048/131] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[244.470299] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[244.474198] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[244.553400] [049/131] (778s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[244.655302] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[245.522872] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.867s)
[245.666613] [050/131] (777s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt)
[245.761445] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt
[249.951824] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (4.194s)
[251.136558] [051/131] (771s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[251.234853] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[251.239088] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[251.351610] [052/131] (771s left) kms_cursor_crc (cursor-sliding-512x512)
[251.602402] Starting subtest: cursor-sliding-512x512
[251.606895] Subtest cursor-sliding-512x512: SKIP (0.001s)
[251.774444] [053/131] (771s left) gem_request_retire (retire-vma-not-inactive)
[251.832624] Starting subtest: retire-vma-not-inactive
[251.891283] Subtest retire-vma-not-inactive: SUCCESS (0.056s)
[252.025964] [054/131] (770s left) gem_exec_schedule (noreorder)
[252.200068] Starting subtest: noreorder
[252.202706] Starting dynamic subtest: rcs0
[252.272607] Dynamic subtest rcs0: SUCCESS (0.073s)
[252.283344] Starting dynamic subtest: vcs0
[253.922375] Dynamic subtest vcs0: SUCCESS (1.646s)
[253.932732] Starting dynamic subtest: vcs1
[255.922467] Dynamic subtest vcs1: SUCCESS (1.998s)
[255.937948] Starting dynamic subtest: vecs0
[257.897399] Dynamic subtest vecs0: SUCCESS (1.973s)
[257.907103] Starting dynamic subtest: ccs0
[257.983418] Dynamic subtest ccs0: SUCCESS (0.085s)
[257.986316] Subtest noreorder: SUCCESS (5.785s)
[258.168173] [055/131] (764s left) gem_userptr_blits (coherency-sync)
[258.231334] Starting subtest: coherency-sync
[258.511545] Subtest coherency-sync: SKIP (0.243s)
[258.626279] [056/131] (764s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[258.773045] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[258.775298] Starting dynamic subtest: pipe-A-eDP-1
[258.795336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[258.804990] Starting dynamic subtest: pipe-B-eDP-1
[258.823778] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[258.830802] Starting dynamic subtest: pipe-C-eDP-1
[258.850030] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[258.857867] Starting dynamic subtest: pipe-D-eDP-1
[258.877235] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[258.879135] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[260.996871] [057/131] (762s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[265.982793] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[265.985173] Starting dynamic subtest: pipe-A-eDP-1
[277.409061] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.423s)
[277.422656] Starting dynamic subtest: pipe-B-eDP-1
[288.856255] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.447s)
[288.858605] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.874s)
[289.706307] [058/131] (733s left) kms_selftest (drm_dp_mst_helper)
[289.756711] Starting subtest: drm_dp_mst_helper
[289.775518] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[289.911546] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.135s)
[289.919148] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[290.041776] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.127s)
[290.048873] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[290.171062] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.128s)
[290.173217] Subtest drm_dp_mst_helper: SUCCESS (0.413s)
[290.365133] [059/131] (732s left) kms_vblank (query-idle-hang)
[290.465222] Starting subtest: query-idle-hang
[290.467567] Starting dynamic subtest: pipe-A-eDP-1
[316.686113] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.218s)
[316.699442] Starting dynamic subtest: pipe-D-eDP-1
[341.719508] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.033s)
[341.721748] Subtest query-idle-hang: SUCCESS (51.255s)
[342.566896] [060/131] (680s left) kms_hdr (invalid-metadata-sizes)
[342.676259] Starting subtest: invalid-metadata-sizes
[342.683059] Subtest invalid-metadata-sizes: SKIP (0.000s)
[342.747529] [061/131] (680s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[342.847409] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[342.851649] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[342.956531] [062/131] (680s left) gem_exec_schedule (preempt-other)
[343.039314] Starting subtest: preempt-other
[343.041531] Starting dynamic subtest: rcs0
[343.107462] Dynamic subtest rcs0: SUCCESS (0.071s)
[343.120692] Starting dynamic subtest: bcs0
[343.172339] Dynamic subtest bcs0: SUCCESS (0.065s)
[343.181833] Starting dynamic subtest: vcs0
[343.239203] Dynamic subtest vcs0: SUCCESS (0.067s)
[343.250061] Starting dynamic subtest: vcs1
[343.308187] Dynamic subtest vcs1: SUCCESS (0.068s)
[343.319989] Starting dynamic subtest: vecs0
[343.370789] Dynamic subtest vecs0: SUCCESS (0.061s)
[343.380821] Starting dynamic subtest: ccs0
[343.436056] Dynamic subtest ccs0: SUCCESS (0.066s)
[343.438455] Subtest preempt-other: SUCCESS (0.401s)
[345.028726] [063/131] (678s left) tools_test (sysfs_l3_parity)
[345.075618] Starting subtest: sysfs_l3_parity
[345.124673] Subtest sysfs_l3_parity: SKIP (0.063s)
[345.183247] [064/131] (678s left) gem_tiled_partial_pwrite_pread (writes)
[345.238189] Subtest writes: SKIP (0.000s)
[345.308103] [065/131] (678s left) gem_userptr_blits (process-exit-busy)
[345.379665] Starting subtest: process-exit-busy
[345.394616] Subtest process-exit-busy: SUCCESS (0.019s)
[345.539398] [066/131] (677s left) gem_create (create-clear)
[345.595538] Starting subtest: create-clear
[345.597921] Starting dynamic subtest: smem0
[378.361112] Dynamic subtest smem0: SUCCESS (32.759s)
[378.363554] Subtest create-clear: SUCCESS (32.761s)
[378.544594] [067/131] (644s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[378.654192] Starting subtest: y-tiled-16bpp-rotate-270
[378.658647] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[378.746439] [068/131] (644s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[378.835389] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[383.417656] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.586s)
[384.571771] [069/131] (638s left) gem_exec_params (dr4-dirt)
[384.633866] Starting subtest: DR4-dirt
[384.636276] Subtest DR4-dirt: SUCCESS (0.000s)
[384.734580] [070/131] (638s left) gem_exec_fence (keep-in-fence)
[384.917836] Starting subtest: keep-in-fence
[384.919960] Starting dynamic subtest: rcs0
[384.990686] Dynamic subtest rcs0: SUCCESS (0.072s)
[385.000856] Starting dynamic subtest: bcs0
[385.044500] Dynamic subtest bcs0: SUCCESS (0.052s)
[385.054613] Starting dynamic subtest: vcs0
[386.900808] Dynamic subtest vcs0: SUCCESS (1.851s)
[386.911793] Starting dynamic subtest: vcs1
[388.884076] Dynamic subtest vcs1: SUCCESS (1.982s)
[388.895117] Starting dynamic subtest: vecs0
[390.932527] Dynamic subtest vecs0: SUCCESS (2.046s)
[390.941646] Starting dynamic subtest: ccs0
[391.171095] Dynamic subtest ccs0: SUCCESS (0.238s)
[391.174079] Subtest keep-in-fence: SUCCESS (6.253s)
[393.029805] [071/131] (630s left) gem_eio (in-flight-10ms)
[393.247092] Starting subtest: in-flight-10ms
[401.713617] Subtest in-flight-10ms: SUCCESS (8.466s)
[401.880879] [072/131] (621s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[401.979595] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[401.982055] Starting dynamic subtest: pipe-A-default-mode
[402.270037] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[402.274487] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.291s)
[403.094370] [073/131] (620s left) kms_content_protection (content-type-change)
[403.240980] Starting subtest: content-type-change
[406.644884] Subtest content-type-change: SKIP (3.402s)
[407.821605] [074/131] (615s left) kms_fbcon_fbt (psr-suspend)
[407.880313] Starting subtest: psr-suspend
[458.324030] Subtest psr-suspend: SUCCESS (20.513s)
[461.421373] [075/131] (565s left) gem_exec_reloc (basic-wc-active)
[461.490995] Subtest basic-wc-active: SKIP (0.000s)
[461.579577] [076/131] (565s left) syncobj_wait (invalid-single-wait-unsubmitted)
[461.637004] Starting subtest: invalid-single-wait-unsubmitted
[461.639346] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[461.742932] [077/131] (565s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[461.841880] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[461.846414] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[461.946635] [078/131] (564s left) gem_ctx_persistence (legacy-engines-mixed)
[462.000751] Starting subtest: legacy-engines-mixed
[462.003189] Starting dynamic subtest: render
[462.117787] Dynamic subtest render: SUCCESS (0.116s)
[462.130488] Starting dynamic subtest: bsd1
[462.156859] Dynamic subtest bsd1: SUCCESS (0.037s)
[462.165971] Starting dynamic subtest: bsd2
[462.285213] Dynamic subtest bsd2: SUCCESS (0.126s)
[462.296912] Starting dynamic subtest: blt
[462.361212] Dynamic subtest blt: SUCCESS (0.074s)
[462.372634] Starting dynamic subtest: vebox
[462.443921] Dynamic subtest vebox: SUCCESS (0.081s)
[462.446378] Subtest legacy-engines-mixed: SUCCESS (0.444s)
[462.521838] [079/131] (564s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[462.915272] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[463.688625] [080/131] (563s left) gem_userptr_blits (readonly-pwrite-unsync)
[463.758425] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[463.908657] [081/131] (563s left) kms_flip (plain-flip-fb-recreate)
[464.020335] Starting subtest: plain-flip-fb-recreate
[464.022539] Starting dynamic subtest: A-eDP1
[472.906613] Dynamic subtest A-eDP1: SUCCESS (8.883s)
[472.917207] Starting dynamic subtest: B-eDP1
[481.743507] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[481.753542] Starting dynamic subtest: C-eDP1
[490.555153] Dynamic subtest C-eDP1: SUCCESS (8.809s)
[490.564043] Starting dynamic subtest: D-eDP1
[499.390513] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[499.394576] Subtest plain-flip-fb-recreate: SUCCESS (35.366s)
[500.568749] [082/131] (526s left) gem_pipe_control_store_loop (fresh-buffer)
[500.633404] Starting subtest: fresh-buffer
[502.786928] Subtest fresh-buffer: SUCCESS (2.152s)
[502.929119] [083/131] (524s left) gem_exec_alignment (pi)
[502.991648] Starting subtest: pi
[554.670763] Subtest pi: SUCCESS (51.666s)
[555.596821] [084/131] (471s left) kms_plane (pixel-format)
[555.752336] Starting subtest: pixel-format
[555.782983] Starting dynamic subtest: pipe-A-plane-0
[560.560851] Dynamic subtest pipe-A-plane-0: SUCCESS (4.777s)
[560.570388] Starting dynamic subtest: pipe-A-plane-3
[562.828012] Dynamic subtest pipe-A-plane-3: SUCCESS (2.266s)
[562.839020] Starting dynamic subtest: pipe-A-plane-5
[563.028042] Dynamic subtest pipe-A-plane-5: SUCCESS (0.200s)
[564.160442] Starting dynamic subtest: pipe-B-plane-0
[568.885405] Dynamic subtest pipe-B-plane-0: SUCCESS (4.733s)
[568.894321] Starting dynamic subtest: pipe-B-plane-3
[571.163805] Dynamic subtest pipe-B-plane-3: SUCCESS (2.277s)
[571.179978] Starting dynamic subtest: pipe-B-plane-5
[571.363780] Dynamic subtest pipe-B-plane-5: SUCCESS (0.199s)
[571.686515] Subtest pixel-format: SUCCESS (15.927s)
[572.541941] [085/131] (454s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[572.612999] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[572.615344] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[572.728326] [086/131] (454s left) kms_flip (flip-vs-dpms-on-nop)
[572.832966] Starting subtest: flip-vs-dpms-on-nop
[572.834875] Starting dynamic subtest: A-eDP1
[574.734108] Dynamic subtest A-eDP1: SUCCESS (1.903s)
[574.743697] Starting dynamic subtest: B-eDP1
[576.563413] Dynamic subtest B-eDP1: SUCCESS (1.827s)
[576.574332] Starting dynamic subtest: C-eDP1
[578.382486] Dynamic subtest C-eDP1: SUCCESS (1.818s)
[578.391505] Starting dynamic subtest: D-eDP1
[580.216420] Dynamic subtest D-eDP1: SUCCESS (1.832s)
[580.218714] Subtest flip-vs-dpms-on-nop: SUCCESS (7.389s)
[581.399271] [087/131] (445s left) kms_vblank (ts-continuation-modeset-rpm)
[581.497636] Starting subtest: ts-continuation-modeset-rpm
[581.500167] Starting dynamic subtest: pipe-A-eDP-1
[583.999926] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.500s)
[584.016718] Starting dynamic subtest: pipe-D-eDP-1
[586.241855] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.237s)
[586.244028] Subtest ts-continuation-modeset-rpm: SUCCESS (4.740s)
[587.028455] [088/131] (440s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[587.089979] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[587.192885] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[587.273028] [089/131] (440s left) kms_pm_rpm (universal-planes-dpms)
[589.003327] Starting subtest: universal-planes-dpms
[589.006043] Starting dynamic subtest: plane-33
[597.279063] Dynamic subtest plane-33: SUCCESS (8.277s)
[597.293870] Starting dynamic subtest: plane-43
[605.680903] Dynamic subtest plane-43: SUCCESS (8.398s)
[605.692253] Starting dynamic subtest: plane-53
[614.348869] Dynamic subtest plane-53: SUCCESS (8.665s)
[614.361348] Starting dynamic subtest: plane-63
[622.960962] Dynamic subtest plane-63: SUCCESS (8.608s)
[622.972385] Starting dynamic subtest: plane-73
[631.588737] Dynamic subtest plane-73: SUCCESS (8.623s)
[631.601329] Starting dynamic subtest: plane-83
[640.227620] Dynamic subtest plane-83: SUCCESS (8.635s)
[640.230480] Subtest universal-planes-dpms: SUCCESS (51.220s)
[640.595572] [090/131] (386s left) kms_atomic_transition (modeset-transition-nonblocking)
[640.697119] Starting subtest: modeset-transition-nonblocking
[640.698978] Starting dynamic subtest: 1x-outputs
[651.530125] Dynamic subtest 1x-outputs: SUCCESS (10.831s)
[651.794410] Subtest modeset-transition-nonblocking: SUCCESS (11.096s)
[652.659833] [091/131] (374s left) kms_cursor_crc (cursor-offscreen-max-size)
[652.956164] Starting subtest: cursor-offscreen-max-size
[652.963016] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[653.097842] [092/131] (374s left) gem_exec_balancer (smoke)
[653.164958] Starting subtest: smoke
[675.774931] Subtest smoke: SUCCESS (22.605s)
[676.707780] [093/131] (350s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[676.779258] Starting subtest: map-fixed-invalidate-overlap
[676.783799] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[676.917580] [094/131] (350s left) i915_pm_rpm (sysfs-read)
[679.044159] Starting subtest: sysfs-read
[680.201362] Subtest sysfs-read: SUCCESS (1.156s)
[680.579380] [095/131] (347s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[680.637083] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[680.745135] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[680.823623] [096/131] (346s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[680.884315] Starting subtest: multi-wait-for-submit-available-signaled
[680.886601] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[680.976819] [097/131] (346s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[681.070347] Starting subtest: addfb25-y-tiled-small-legacy
[681.074774] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[681.177981] [098/131] (346s left) gem_exec_whisper (basic-forked)
[681.242968] Starting subtest: basic-forked
[688.254894] Subtest basic-forked: SUCCESS (7.014s)
[688.440650] [099/131] (339s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[688.558349] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[688.560619] Starting dynamic subtest: pipe-A-eDP-1
[688.581235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[688.593806] Starting dynamic subtest: pipe-B-eDP-1
[688.613938] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[688.624793] Starting dynamic subtest: pipe-C-eDP-1
[688.644244] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[688.653744] Starting dynamic subtest: pipe-D-eDP-1
[688.673239] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[688.675478] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[690.753559] [100/131] (337s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[690.842375] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[690.844610] Starting dynamic subtest: pipe-A-eDP-1
[690.866590] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[690.876795] Starting dynamic subtest: pipe-B-eDP-1
[690.898046] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[690.907447] Starting dynamic subtest: pipe-C-eDP-1
[690.928813] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[690.937459] Starting dynamic subtest: pipe-D-eDP-1
[690.958231] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[690.962113] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[693.045162] [101/131] (334s left) device_reset (unbind-reset-rebind)
[693.103089] Starting subtest: unbind-reset-rebind
[697.762615] Subtest unbind-reset-rebind: SUCCESS (4.661s)
[697.824397] [102/131] (330s left) gem_sync (basic-many-each)
[697.906221] Starting subtest: basic-many-each
[700.193038] Subtest basic-many-each: SUCCESS (2.299s)
[700.381631] [103/131] (327s left) kms_frontbuffer_tracking (fbc-1p-rte)
[700.481954] Starting subtest: fbc-1p-rte
[705.987955] Subtest fbc-1p-rte: SUCCESS (5.511s)
[707.201524] [104/131] (320s left) i915_pm_rpm (debugfs-forcewake-user)
[708.921306] Starting subtest: debugfs-forcewake-user
[720.314238] Subtest debugfs-forcewake-user: SUCCESS (11.394s)
[720.684864] [105/131] (307s left) perf (sysctl-defaults)
[720.768135] Starting subtest: sysctl-defaults
[720.770683] Subtest sysctl-defaults: SUCCESS (0.000s)
[720.864298] [106/131] (307s left) gem_create (hog-create)
[720.925320] Starting subtest: hog-create
[720.927588] Starting dynamic subtest: smem0
[754.822605] Dynamic subtest smem0: SUCCESS (33.898s)
[754.825277] Subtest hog-create: SUCCESS (33.899s)
[755.006282] [107/131] (273s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[755.113663] Starting subtest: yf-tiled-64bpp-rotate-0
[755.118050] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[755.224576] [108/131] (272s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[755.320493] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[759.403979] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.086s)
[760.552016] [109/131] (267s left) gem_pwrite_snooped
[760.701191] [110/131] (267s left) gem_mmap_gtt (fault-concurrent)
[760.755239] Subtest fault-concurrent: SKIP (0.000s)
[760.822750] [111/131] (267s left) gem_softpin (noreloc-s3)
[760.876011] Starting subtest: noreloc-S3
[781.021222] Subtest noreloc-S3: SUCCESS (5.399s)
[783.154447] [112/131] (247s left) api_intel_bb (lot-of-buffers)
[783.227793] Starting subtest: lot-of-buffers
[784.268023] Subtest lot-of-buffers: SUCCESS (1.043s)
[784.723856] [113/131] (245s left) gen7_exec_parse (load-register-reg)
[784.787164] Subtest load-register-reg: SKIP (0.000s)
[784.871594] [114/131] (245s left) kms_plane_scaling (planes-scaler-unity-scaling)
[784.984238] Starting subtest: planes-scaler-unity-scaling
[784.990811] Starting dynamic subtest: pipe-A
[785.052134] Dynamic subtest pipe-A: SUCCESS (0.070s)
[785.062306] Starting dynamic subtest: pipe-B
[786.177465] Dynamic subtest pipe-B: SUCCESS (1.126s)
[786.190133] Starting dynamic subtest: pipe-C
[787.289739] Dynamic subtest pipe-C: SUCCESS (1.113s)
[787.307294] Starting dynamic subtest: pipe-D
[788.421977] Dynamic subtest pipe-D: SUCCESS (1.133s)
[788.424843] Subtest planes-scaler-unity-scaling: SUCCESS (3.448s)
[789.577408] [115/131] (240s left) gem_lmem_swapping (verify-random-ccs)
[789.626787] Subtest verify-random-ccs: SKIP (0.000s)
[789.670193] [116/131] (240s left) kms_big_fb (4-tiled-addfb-size-overflow)
[789.772247] Starting subtest: 4-tiled-addfb-size-overflow
[789.774379] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[789.888428] [117/131] (240s left) kms_properties (get_properties-sanity-atomic)
[789.984044] Starting subtest: get_properties-sanity-atomic
[789.989496] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[790.067335] [118/131] (240s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[790.153288] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[790.155603] Starting dynamic subtest: pipe-A-default-mode
[792.917764] Dynamic subtest pipe-A-default-mode: SUCCESS (2.766s)
[792.920167] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.767s)
[793.775329] [119/131] (236s left) kms_psr (psr2-cursor-mmap-gtt)
[793.886047] Starting subtest: psr2-cursor-mmap-gtt
[793.888302] Starting dynamic subtest: eDP-1
[795.534822] Dynamic subtest eDP-1: SUCCESS (1.652s)
[795.537115] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.653s)
[796.335101] [120/131] (234s left) kms_psr (fbc-pr-sprite-blt)
[796.437194] Starting subtest: fbc-pr-sprite-blt
[796.441166] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[796.511516] [121/131] (234s left) syncobj_wait (single-wait-submitted)
[796.560994] Starting subtest: single-wait-submitted
[796.666027] Subtest single-wait-submitted: SUCCESS (0.105s)
[796.740487] [122/131] (233s left) gem_close (basic)
[796.792343] Starting subtest: basic
[796.794637] Subtest basic: SUCCESS (0.000s)
[796.903044] [123/131] (233s left) prime_mmap (test_forked_cpu_write)
[796.970919] Starting subtest: test_forked_cpu_write
[796.973062] Starting dynamic subtest: test_forked_cpu_write-smem
[796.977727] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[796.979619] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[797.097940] [124/131] (233s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[797.214335] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[804.490606] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.282s)
[804.629165] [125/131] (226s left) perf_pmu (busy-no-semaphores)
[804.672119] Starting subtest: busy-no-semaphores
[804.674339] Starting dynamic subtest: rcs0
[805.245473] Dynamic subtest rcs0: SUCCESS (0.571s)
[805.258225] Starting dynamic subtest: bcs0
[805.793777] Dynamic subtest bcs0: SUCCESS (0.547s)
[805.806186] Starting dynamic subtest: vcs0
[806.344609] Dynamic subtest vcs0: SUCCESS (0.548s)
[806.357311] Starting dynamic subtest: vcs1
[808.081989] Dynamic subtest vcs1: SUCCESS (1.735s)
[808.094714] Starting dynamic subtest: vecs0
[810.064713] Dynamic subtest vecs0: SUCCESS (1.980s)
[810.076180] Starting dynamic subtest: ccs0
[812.115635] Dynamic subtest ccs0: SUCCESS (2.046s)
[812.118488] Subtest busy-no-semaphores: SUCCESS (7.441s)
[812.233485] [126/131] (218s left) kms_cursor_edge_walk (128x128-left-edge)
[812.336884] Starting subtest: 128x128-left-edge
[812.339257] Starting dynamic subtest: pipe-A-eDP-1
[815.836199] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s)
[815.846560] Starting dynamic subtest: pipe-D-eDP-1
[818.956432] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[818.958910] Subtest 128x128-left-edge: SUCCESS (6.613s)
[819.775865] [127/131] (211s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[819.876910] Starting subtest: stress-xrgb8888-yftiled
[819.881421] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[819.943854] [128/131] (211s left) gem_exec_schedule (wide)
[820.129740] Starting subtest: wide
[820.132244] Starting dynamic subtest: rcs0
[829.705723] Dynamic subtest rcs0: SUCCESS (9.570s)
[829.724980] Starting dynamic subtest: vcs0
[839.872893] Dynamic subtest vcs0: SUCCESS (10.162s)
[839.884725] Starting dynamic subtest: vcs1
[849.795068] Dynamic subtest vcs1: SUCCESS (9.920s)
[849.807946] Starting dynamic subtest: vecs0
[861.298376] Dynamic subtest vecs0: SUCCESS (11.501s)
[861.310566] Starting dynamic subtest: ccs0
[874.156778] Dynamic subtest ccs0: SUCCESS (12.857s)
[874.159011] Subtest wide: SUCCESS (54.015s)
[875.827317] [129/131] (155s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[875.898297] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[875.902750] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[876.080983] [130/131] (154s left) syncobj_timeline (invalid-query-one-illegal-handle)
[876.134153] Starting subtest: invalid-query-one-illegal-handle
[876.136608] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[876.265732] [131/131] (154s left) gem_mmap_offset (pf-nonblock)
[876.325560] Starting subtest: pf-nonblock
[876.332776] Subtest pf-nonblock: SUCCESS (0.010s)
[876.470741] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: gem_tiled_pread_basic
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_getfb
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: gem_pread
results: parsing output: 13/ for test: gem_bad_reloc
results: parsing output: 14/ for test: sriov_basic
results: parsing output: 15/ for test: gem_ctx_param
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_softpin
results: parsing output: 21/ for test: drm_read
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: i915_drm_fdinfo
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_dp_link_training
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: kms_pipe_b_c_ivb
results: parsing output: 33/ for test: kms_async_flips
results: parsing output: 34/ for test: kms_lease
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: sysfs_timeslice_duration
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: api_intel_allocator
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: gem_request_retire
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: kms_selftest
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: kms_hdr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: tools_test
results: parsing output: 63/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: gem_create
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_content_protection
results: parsing output: 73/ for test: kms_fbcon_fbt
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: kms_chamelium_edid
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: gem_pipe_control_store_loop
results: parsing output: 82/ for test: gem_exec_alignment
results: parsing output: 83/ for test: kms_plane
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_atomic_transition
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: i915_pm_rpm
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: device_reset
results: parsing output: 101/ for test: gem_sync
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: i915_pm_rpm
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: gem_create
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_pwrite_snooped
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: api_intel_bb
results: parsing output: 112/ for test: gen7_exec_parse
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: gem_lmem_swapping
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_properties
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: gem_close
results: parsing output: 122/ for test: prime_mmap
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_cursor_edge_walk
results: parsing output: 126/ for test: kms_pipe_stress
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_mmap_offset
Done.