[58.860493] Initializing watchdogs
[58.860541]   /dev/watchdog0
[58.873824] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.877974] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.879928] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.882013] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[58.996509] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[58.998611] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[59.114167] [002/131] (960s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[59.206128] Starting subtest: 2x-absolute-wf_vblank-interruptible
[59.217921] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[59.283108] [003/131] (960s left) kms_plane (plane-position-hole)
[59.377837] Starting subtest: plane-position-hole
[59.952253] Starting dynamic subtest: pipe-A-plane-1
[61.219903] Dynamic subtest pipe-A-plane-1: SUCCESS (1.279s)
[61.225783] Starting dynamic subtest: pipe-A-plane-2
[62.486882] Dynamic subtest pipe-A-plane-2: SUCCESS (1.265s)
[62.493019] Starting dynamic subtest: pipe-A-plane-3
[63.715697] Dynamic subtest pipe-A-plane-3: SUCCESS (1.227s)
[63.721780] Starting dynamic subtest: pipe-A-plane-4
[64.973214] Dynamic subtest pipe-A-plane-4: SUCCESS (1.256s)
[64.980532] Starting dynamic subtest: pipe-A-plane-5
[65.002078] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s)
[66.114851] Starting dynamic subtest: pipe-B-plane-1
[67.330825] Dynamic subtest pipe-B-plane-1: SUCCESS (1.222s)
[67.337235] Starting dynamic subtest: pipe-B-plane-2
[68.553166] Dynamic subtest pipe-B-plane-2: SUCCESS (1.221s)
[68.559931] Starting dynamic subtest: pipe-B-plane-3
[69.795088] Dynamic subtest pipe-B-plane-3: SUCCESS (1.242s)
[69.801377] Starting dynamic subtest: pipe-B-plane-4
[71.045387] Dynamic subtest pipe-B-plane-4: SUCCESS (1.249s)
[71.051089] Starting dynamic subtest: pipe-B-plane-5
[71.076590] Dynamic subtest pipe-B-plane-5: SUCCESS (0.029s)
[71.078424] Subtest plane-position-hole: SUCCESS (11.686s)
[71.846872] [004/131] (947s left) kms_flip (nonblocking-read)
[71.951062] Starting subtest: nonblocking-read
[71.952072] Subtest nonblocking-read: SUCCESS (0.000s)
[72.122600] [005/131] (947s left) gem_tiled_pread_basic
[72.280124] [006/131] (947s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[72.381958] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[73.381664] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.000s)
[73.493657] [007/131] (946s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[73.593159] Starting subtest: fbc-psr-cursor-mmap-cpu
[73.594654] Starting dynamic subtest: eDP-1
[73.597412] Dynamic subtest eDP-1: SKIP (0.000s)
[73.599709] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[73.658331] [008/131] (945s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[73.758617] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[73.759726] Starting dynamic subtest: pipe-A-eDP-1
[73.768799] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[73.774378] Starting dynamic subtest: pipe-B-eDP-1
[73.782902] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[73.788029] Starting dynamic subtest: pipe-C-eDP-1
[73.796443] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[73.801475] Starting dynamic subtest: pipe-D-eDP-1
[73.809866] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[73.811521] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s)
[75.909890] [009/131] (943s left) kms_getfb (getfb2-accept-nv12)
[75.999966] Starting subtest: getfb2-accept-nv12
[76.001057] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[76.096210] [010/131] (943s left) kms_pm_rpm (cursor-dpms)
[78.023588] Starting subtest: cursor-dpms
[78.025829] Subtest cursor-dpms: SKIP (0.000s)
[78.385705] [011/131] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[78.477927] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[78.479657] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[78.593550] [012/131] (941s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[78.964874] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[79.779836] [013/131] (939s left) gem_pread (self)
[79.835197] Subtest self: SKIP (0.000s)
[79.874264] [014/131] (939s left) gem_bad_reloc (negative-reloc-lut)
[79.934117] Subtest negative-reloc-lut: SKIP (0.000s)
[80.017829] [015/131] (939s left) sriov_basic (enable-vfs-autoprobe-on)
[80.071348] Starting subtest: enable-vfs-autoprobe-on
[80.072433] Starting dynamic subtest: numvfs-1
[80.108932] Dynamic subtest numvfs-1: FAIL (0.017s)
[80.115467] Starting dynamic subtest: numvfs-2
[80.145459] Dynamic subtest numvfs-2: FAIL (0.004s)
[80.150673] Starting dynamic subtest: numvfs-3
[80.180342] Dynamic subtest numvfs-3: FAIL (0.003s)
[80.185556] Starting dynamic subtest: numvfs-4
[80.218120] Dynamic subtest numvfs-4: FAIL (0.003s)
[80.223441] Starting dynamic subtest: numvfs-5
[80.250154] Dynamic subtest numvfs-5: FAIL (0.003s)
[80.254949] Starting dynamic subtest: numvfs-6
[80.283606] Dynamic subtest numvfs-6: FAIL (0.004s)
[80.288470] Starting dynamic subtest: numvfs-7
[80.315086] Dynamic subtest numvfs-7: FAIL (0.003s)
[80.319748] Starting dynamic subtest: numvfs-random
[80.346276] Dynamic subtest numvfs-random: FAIL (0.003s)
[80.350969] Starting dynamic subtest: numvfs-all
[80.377854] Dynamic subtest numvfs-all: FAIL (0.003s)
[80.378740] Subtest enable-vfs-autoprobe-on: FAIL (0.047s)
[80.401459] [016/131] (939s left) gem_ctx_param (invalid-get-ringsize)
[80.455247] Starting subtest: invalid-get-ringsize
[80.457424] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[80.554850] [017/131] (939s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[80.599709] Starting subtest: multi-wait-all-for-submit-submitted
[80.707353] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[80.773490] [018/131] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[80.875551] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[80.877276] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[80.980224] [019/131] (938s left) kms_flip (modeset-vs-vblank-race-interruptible)
[81.068749] Starting subtest: modeset-vs-vblank-race-interruptible
[81.071740] Starting dynamic subtest: A-eDP1
[85.737943] Dynamic subtest A-eDP1: SUCCESS (4.666s)
[85.745668] Starting dynamic subtest: B-eDP1
[90.380409] Dynamic subtest B-eDP1: SUCCESS (4.641s)
[90.388519] Starting dynamic subtest: C-eDP1
[94.984021] Dynamic subtest C-eDP1: SUCCESS (4.602s)
[94.991829] Starting dynamic subtest: D-eDP1
[99.531211] Dynamic subtest D-eDP1: SUCCESS (4.547s)
[99.533503] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.463s)
[100.692637] [020/131] (919s left) kms_psr (fbc-psr-sprite-render)
[100.786063] Starting subtest: fbc-psr-sprite-render
[100.787097] Starting dynamic subtest: eDP-1
[100.788944] Dynamic subtest eDP-1: SKIP (0.000s)
[100.790836] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[100.849199] [021/131] (919s left) gem_softpin (allocator-basic-reserve)
[100.896832] Starting subtest: allocator-basic-reserve
[100.970647] Subtest allocator-basic-reserve: SUCCESS (0.073s)
[101.113177] [022/131] (918s left) drm_read (invalid-buffer)
[101.256438] Starting subtest: invalid-buffer
[101.257584] Subtest invalid-buffer: SUCCESS (0.000s)
[101.383218] [023/131] (918s left) i915_drm_fdinfo (memory-info-shared)
[101.416976] Starting subtest: memory-info-shared
[101.418172] Starting dynamic subtest: smem0
[101.480522] Dynamic subtest smem0: SUCCESS (0.063s)
[101.482225] Subtest memory-info-shared: SUCCESS (0.064s)
[101.549328] [024/131] (918s left) i915_drm_fdinfo (busy-idle)
[101.580152] Starting subtest: busy-idle
[101.581126] Starting dynamic subtest: rcs0
[101.613342] Dynamic subtest rcs0: SKIP (0.032s)
[101.621208] Starting dynamic subtest: bcs0
[101.622877] Dynamic subtest bcs0: SKIP (0.000s)
[101.628402] Starting dynamic subtest: vcs0
[101.630386] Dynamic subtest vcs0: SKIP (0.000s)
[101.637419] Starting dynamic subtest: vcs1
[101.639154] Dynamic subtest vcs1: SKIP (0.000s)
[101.644352] Starting dynamic subtest: vecs0
[101.646135] Dynamic subtest vecs0: SKIP (0.000s)
[101.651740] Starting dynamic subtest: ccs0
[101.653611] Dynamic subtest ccs0: SKIP (0.000s)
[101.655449] Subtest busy-idle: SKIP (0.035s)
[101.688695] [025/131] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[101.794056] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[101.795868] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[101.880618] [026/131] (918s left) kms_psr (psr2-sprite-plane-onoff)
[101.969062] Starting subtest: psr2-sprite-plane-onoff
[101.974269] Starting dynamic subtest: eDP-1
[103.703468] Dynamic subtest eDP-1: SUCCESS (1.733s)
[103.704383] Subtest psr2-sprite-plane-onoff: SUCCESS (1.734s)
[104.559251] [027/131] (915s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[104.650688] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[104.651729] Starting dynamic subtest: pipe-A-eDP-1
[104.660607] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[104.666779] Starting dynamic subtest: pipe-B-eDP-1
[104.676425] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[104.682007] Starting dynamic subtest: pipe-C-eDP-1
[104.689995] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[104.695273] Starting dynamic subtest: pipe-D-eDP-1
[104.703445] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[104.705055] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.003s)
[106.825449] [028/131] (913s left) kms_dp_link_training (uhbr-sst)
[106.917756] Starting subtest: uhbr-sst
[106.921417] Subtest uhbr-sst: SKIP (0.000s)
[106.982642] [029/131] (913s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[111.937565] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[111.938536] Starting dynamic subtest: pipe-A-eDP-1
[112.721860] Dynamic subtest pipe-A-eDP-1: SKIP (0.783s)
[112.727943] Starting dynamic subtest: pipe-B-eDP-1
[113.857160] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[113.858976] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.919s)
[115.037454] [030/131] (905s left) perf (blocking-parameterized)
[115.141783] Starting subtest: blocking-parameterized
[135.164328] Subtest blocking-parameterized: SUCCESS (20.021s)
[135.201988] [031/131] (885s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[135.317859] Starting subtest: cursorA-vs-flipB-legacy
[135.319624] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[135.453752] [032/131] (884s left) kms_color (deep-color)
[135.541053] Starting subtest: deep-color
[136.608195] Starting dynamic subtest: pipe-A-eDP-1-gamma
[137.289370] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.681s)
[137.296437] Starting dynamic subtest: pipe-A-eDP-1-degamma
[138.673187] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.383s)
[138.680427] Starting dynamic subtest: pipe-A-eDP-1-ctm
[140.088044] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.414s)
[140.912141] Starting dynamic subtest: pipe-B-eDP-1-gamma
[141.605044] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.698s)
[141.610946] Starting dynamic subtest: pipe-B-eDP-1-degamma
[142.979183] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.373s)
[142.985028] Starting dynamic subtest: pipe-B-eDP-1-ctm
[144.420959] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.442s)
[145.224386] Starting dynamic subtest: pipe-C-eDP-1-gamma
[145.889250] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.670s)
[145.896199] Starting dynamic subtest: pipe-C-eDP-1-degamma
[147.260534] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.371s)
[147.266583] Starting dynamic subtest: pipe-C-eDP-1-ctm
[148.565697] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.304s)
[149.337677] Starting dynamic subtest: pipe-D-eDP-1-gamma
[149.997362] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.665s)
[150.005637] Starting dynamic subtest: pipe-D-eDP-1-degamma
[151.368303] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.371s)
[151.374056] Starting dynamic subtest: pipe-D-eDP-1-ctm
[152.717387] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.348s)
[152.718326] Subtest deep-color: SUCCESS (17.176s)
[153.511741] [033/131] (866s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[153.571682] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[153.621388] [034/131] (866s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[153.704014] Starting subtest: async-flip-with-page-flip-events-linear
[154.082861] Starting dynamic subtest: pipe-A-eDP-1
[156.897878] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.812s)
[157.265233] Starting dynamic subtest: pipe-B-eDP-1
[160.026803] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[160.382109] Starting dynamic subtest: pipe-C-eDP-1
[163.161961] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.782s)
[163.528767] Starting dynamic subtest: pipe-D-eDP-1
[166.284682] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.761s)
[166.286074] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.579s)
[167.461338] [035/131] (852s left) kms_lease (lessee-list)
[167.548393] Starting subtest: lessee-list
[167.549355] Starting dynamic subtest: pipe-A-eDP-1
[167.550286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[167.556191] Starting dynamic subtest: pipe-B-eDP-1
[167.557163] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[167.564769] Starting dynamic subtest: pipe-C-eDP-1
[167.565709] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[167.571463] Starting dynamic subtest: pipe-D-eDP-1
[167.572325] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[167.573169] Subtest lessee-list: SUCCESS (0.008s)
[167.655880] [036/131] (852s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[167.748323] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[174.429102] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.683s)
[174.544363] [037/131] (845s left) sysfs_timeslice_duration (timeout)
[174.598325] Starting subtest: timeout
[174.599320] Starting dynamic subtest: vecs0
[183.911621] Dynamic subtest vecs0: SUCCESS (9.309s)
[183.922335] Starting dynamic subtest: ccs0
[185.326879] Dynamic subtest ccs0: SUCCESS (1.415s)
[185.338227] Starting dynamic subtest: vcs0
[194.931296] Dynamic subtest vcs0: SUCCESS (9.599s)
[194.961518] Starting dynamic subtest: bcs0
[195.643685] Dynamic subtest bcs0: SUCCESS (0.713s)
[195.651229] Starting dynamic subtest: rcs0
[196.987170] Dynamic subtest rcs0: SUCCESS (1.343s)
[196.994481] Starting dynamic subtest: vcs1
[206.942344] Dynamic subtest vcs1: SUCCESS (9.950s)
[206.944063] Subtest timeout: SUCCESS (32.341s)
[207.005426] [038/131] (813s left) gem_userptr_blits (create-destroy-unsync)
[207.061323] Subtest create-destroy-unsync: SKIP (0.000s)
[207.191175] [039/131] (813s left) gem_mmap_gtt (ptrace)
[207.240056] Subtest ptrace: SKIP (0.000s)
[207.301658] [040/131] (813s left) syncobj_wait (wait-all-for-submit-complex)
[207.353371] Starting subtest: wait-all-for-submit-complex
[207.568105] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[207.631350] [041/131] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[207.738754] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[214.966984] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.230s)
[215.100168] [042/131] (805s left) gem_exec_fence (syncobj-timeline-wait)
[215.647596] Starting subtest: syncobj-timeline-wait
[216.924328] Subtest syncobj-timeline-wait: SUCCESS (1.277s)
[217.148893] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[217.150873] [043/131] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[217.245358] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[217.246992] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[217.344567] [044/131] (803s left) syncobj_timeline (transfer-timeline-point)
[217.398380] Starting subtest: transfer-timeline-point
[217.399274] Subtest transfer-timeline-point: SUCCESS (0.000s)
[217.497059] [045/131] (803s left) gem_spin_batch (legacy)
[217.552955] Starting subtest: legacy
[217.553946] Starting dynamic subtest: default
[220.795926] Dynamic subtest default: SUCCESS (3.238s)
[220.804581] Starting dynamic subtest: render
[224.033671] Dynamic subtest render: SUCCESS (3.235s)
[224.042458] Starting dynamic subtest: bsd
[227.270310] Dynamic subtest bsd: SUCCESS (3.234s)
[227.279339] Starting dynamic subtest: bsd1
[230.506213] Dynamic subtest bsd1: SUCCESS (3.232s)
[230.513778] Starting dynamic subtest: bsd2
[233.740783] Dynamic subtest bsd2: SUCCESS (3.234s)
[233.749865] Starting dynamic subtest: blt
[236.979667] Dynamic subtest blt: SUCCESS (3.235s)
[236.987385] Starting dynamic subtest: vebox
[240.213933] Dynamic subtest vebox: SUCCESS (3.233s)
[240.215192] Subtest legacy: SUCCESS (22.659s)
[240.969108] [046/131] (779s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[241.073218] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[241.074888] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[241.186452] [047/131] (779s left) api_intel_allocator (gem-pool)
[241.236273] Starting subtest: gem-pool
[241.245876] Subtest gem-pool: SUCCESS (0.010s)
[241.376308] [048/131] (779s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[241.469849] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[241.471575] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[241.584323] [049/131] (779s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[241.676553] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[242.576789] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.901s)
[242.707103] [050/131] (778s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt)
[242.800283] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt
[247.027570] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (4.229s)
[248.126776] [051/131] (772s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[248.221194] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[248.222817] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[248.327119] [052/131] (772s left) kms_cursor_crc (cursor-sliding-512x512)
[248.573431] Starting subtest: cursor-sliding-512x512
[248.575130] Subtest cursor-sliding-512x512: SKIP (0.001s)
[248.717275] [053/131] (772s left) gem_request_retire (retire-vma-not-inactive)
[248.765730] Starting subtest: retire-vma-not-inactive
[248.824546] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[248.958369] [054/131] (771s left) gem_exec_schedule (noreorder)
[249.129556] Starting subtest: noreorder
[249.130864] Starting dynamic subtest: rcs0
[249.209772] Dynamic subtest rcs0: SUCCESS (0.081s)
[249.220166] Starting dynamic subtest: vcs0
[250.949385] Dynamic subtest vcs0: SUCCESS (1.736s)
[250.958164] Starting dynamic subtest: vcs1
[252.909270] Dynamic subtest vcs1: SUCCESS (1.957s)
[252.916376] Starting dynamic subtest: vecs0
[254.945340] Dynamic subtest vecs0: SUCCESS (2.035s)
[254.952585] Starting dynamic subtest: ccs0
[255.009320] Dynamic subtest ccs0: SUCCESS (0.065s)
[255.010528] Subtest noreorder: SUCCESS (5.882s)
[255.188839] [055/131] (765s left) gem_userptr_blits (coherency-sync)
[255.249911] Starting subtest: coherency-sync
[255.493832] Subtest coherency-sync: SKIP (0.225s)
[255.614930] [056/131] (765s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[255.729966] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[255.730957] Starting dynamic subtest: pipe-A-eDP-1
[255.739264] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[255.746177] Starting dynamic subtest: pipe-B-eDP-1
[255.753920] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[255.761039] Starting dynamic subtest: pipe-C-eDP-1
[255.768685] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[255.774778] Starting dynamic subtest: pipe-D-eDP-1
[255.782347] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[255.783239] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[257.896277] [057/131] (763s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[262.885195] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[262.887214] Starting dynamic subtest: pipe-A-eDP-1
[274.305829] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.418s)
[274.312254] Starting dynamic subtest: pipe-B-eDP-1
[285.726941] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.418s)
[285.727849] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.840s)
[286.615723] [058/131] (734s left) kms_selftest (drm_dp_mst_helper)
[286.653760] Starting subtest: drm_dp_mst_helper
[286.670786] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[286.808738] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.137s)
[286.816994] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[286.951065] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.141s)
[286.960072] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[287.099015] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.146s)
[287.099968] Subtest drm_dp_mst_helper: SUCCESS (0.444s)
[287.293286] [059/131] (733s left) kms_vblank (query-idle-hang)
[287.375806] Starting subtest: query-idle-hang
[287.378200] Starting dynamic subtest: pipe-A-eDP-1
[313.763056] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.384s)
[313.774669] Starting dynamic subtest: pipe-D-eDP-1
[337.675288] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.909s)
[337.676346] Subtest query-idle-hang: SUCCESS (50.297s)
[338.469912] [060/131] (682s left) kms_hdr (invalid-metadata-sizes)
[338.559899] Starting subtest: invalid-metadata-sizes
[338.562668] Subtest invalid-metadata-sizes: SKIP (0.000s)
[338.624629] [061/131] (682s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[338.708549] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[338.710289] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[338.815976] [062/131] (682s left) gem_exec_schedule (preempt-other)
[338.877347] Starting subtest: preempt-other
[338.878435] Starting dynamic subtest: rcs0
[338.950434] Dynamic subtest rcs0: SUCCESS (0.072s)
[338.960739] Starting dynamic subtest: bcs0
[339.016853] Dynamic subtest bcs0: SUCCESS (0.066s)
[339.026434] Starting dynamic subtest: vcs0
[339.082363] Dynamic subtest vcs0: SUCCESS (0.065s)
[339.090778] Starting dynamic subtest: vcs1
[339.147748] Dynamic subtest vcs1: SUCCESS (0.065s)
[339.157030] Starting dynamic subtest: vecs0
[339.212286] Dynamic subtest vecs0: SUCCESS (0.063s)
[339.222492] Starting dynamic subtest: ccs0
[339.277827] Dynamic subtest ccs0: SUCCESS (0.065s)
[339.279026] Subtest preempt-other: SUCCESS (0.400s)
[340.978600] [063/131] (680s left) tools_test (sysfs_l3_parity)
[341.012460] Starting subtest: sysfs_l3_parity
[341.071193] Subtest sysfs_l3_parity: SKIP (0.066s)
[341.118822] [064/131] (680s left) gem_tiled_partial_pwrite_pread (writes)
[341.176883] Subtest writes: SKIP (0.000s)
[341.255995] [065/131] (680s left) gem_userptr_blits (process-exit-busy)
[341.304982] Starting subtest: process-exit-busy
[341.317769] Subtest process-exit-busy: SUCCESS (0.013s)
[341.446408] [066/131] (679s left) gem_create (create-clear)
[341.492203] Starting subtest: create-clear
[341.493068] Starting dynamic subtest: smem0
[374.209180] Dynamic subtest smem0: SUCCESS (32.716s)
[374.210514] Subtest create-clear: SUCCESS (32.717s)
[374.388780] [067/131] (646s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[374.493390] Starting subtest: y-tiled-16bpp-rotate-270
[374.495270] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[374.582903] [068/131] (646s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[374.681375] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[379.162162] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.482s)
[380.303505] [069/131] (641s left) gem_exec_params (dr4-dirt)
[380.356043] Starting subtest: DR4-dirt
[380.357047] Subtest DR4-dirt: SUCCESS (0.000s)
[380.460435] [070/131] (640s left) gem_exec_fence (keep-in-fence)
[380.623682] Starting subtest: keep-in-fence
[380.624978] Starting dynamic subtest: rcs0
[380.678610] Dynamic subtest rcs0: SUCCESS (0.055s)
[380.689224] Starting dynamic subtest: bcs0
[380.734836] Dynamic subtest bcs0: SUCCESS (0.054s)
[380.745454] Starting dynamic subtest: vcs0
[381.911956] Dynamic subtest vcs0: SUCCESS (1.173s)
[381.921621] Starting dynamic subtest: vcs1
[383.895822] Dynamic subtest vcs1: SUCCESS (1.981s)
[383.905645] Starting dynamic subtest: vecs0
[385.944706] Dynamic subtest vecs0: SUCCESS (2.047s)
[385.953715] Starting dynamic subtest: ccs0
[386.180656] Dynamic subtest ccs0: SUCCESS (0.236s)
[386.182264] Subtest keep-in-fence: SUCCESS (5.557s)
[388.050993] [071/131] (633s left) gem_eio (in-flight-10ms)
[388.271292] Starting subtest: in-flight-10ms
[396.821030] Subtest in-flight-10ms: SUCCESS (8.549s)
[396.987407] [072/131] (624s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[397.078432] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[397.079350] Starting dynamic subtest: pipe-A-default-mode
[397.376018] Dynamic subtest pipe-A-default-mode: SKIP (0.296s)
[397.377706] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.298s)
[398.214144] [073/131] (623s left) kms_content_protection (content-type-change)
[398.365174] Starting subtest: content-type-change
[401.782375] Subtest content-type-change: SKIP (3.416s)
[402.953402] [074/131] (618s left) kms_fbcon_fbt (psr-suspend)
[403.008799] Starting subtest: psr-suspend
[453.389960] Subtest psr-suspend: SUCCESS (20.437s)
[455.470441] [075/131] (568s left) gem_exec_reloc (basic-wc-active)
[455.535240] Subtest basic-wc-active: SKIP (0.000s)
[455.616819] [076/131] (568s left) syncobj_wait (invalid-single-wait-unsubmitted)
[455.675865] Starting subtest: invalid-single-wait-unsubmitted
[455.676810] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[455.781430] [077/131] (567s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[455.881276] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[455.882954] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[455.994372] [078/131] (567s left) gem_ctx_persistence (legacy-engines-mixed)
[456.060867] Starting subtest: legacy-engines-mixed
[456.061970] Starting dynamic subtest: render
[456.188534] Dynamic subtest render: SUCCESS (0.126s)
[456.200348] Starting dynamic subtest: bsd1
[456.271766] Dynamic subtest bsd1: SUCCESS (0.080s)
[456.284255] Starting dynamic subtest: bsd2
[456.346615] Dynamic subtest bsd2: SUCCESS (0.072s)
[456.359485] Starting dynamic subtest: blt
[456.432916] Dynamic subtest blt: SUCCESS (0.083s)
[456.444396] Starting dynamic subtest: vebox
[456.520618] Dynamic subtest vebox: SUCCESS (0.085s)
[456.521980] Subtest legacy-engines-mixed: SUCCESS (0.459s)
[456.592436] [079/131] (567s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[456.982002] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[457.784321] [080/131] (566s left) gem_userptr_blits (readonly-pwrite-unsync)
[457.846824] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[457.991546] [081/131] (565s left) kms_flip (plain-flip-fb-recreate)
[458.082396] Starting subtest: plain-flip-fb-recreate
[458.084968] Starting dynamic subtest: A-eDP1
[467.012702] Dynamic subtest A-eDP1: SUCCESS (8.912s)
[467.022621] Starting dynamic subtest: B-eDP1
[475.863800] Dynamic subtest B-eDP1: SUCCESS (8.842s)
[475.874090] Starting dynamic subtest: C-eDP1
[484.694001] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[484.702831] Starting dynamic subtest: D-eDP1
[493.536980] Dynamic subtest D-eDP1: SUCCESS (8.844s)
[493.539064] Subtest plain-flip-fb-recreate: SUCCESS (35.430s)
[494.700812] [082/131] (529s left) gem_pipe_control_store_loop (fresh-buffer)
[494.758900] Starting subtest: fresh-buffer
[496.912279] Subtest fresh-buffer: SUCCESS (2.153s)
[497.040887] [083/131] (526s left) gem_exec_alignment (pi)
[497.101884] Starting subtest: pi
[550.308110] Subtest pi: SUCCESS (53.193s)
[551.229071] [084/131] (472s left) kms_plane (pixel-format)
[551.359748] Starting subtest: pixel-format
[551.390242] Starting dynamic subtest: pipe-A-plane-0
[556.377192] Dynamic subtest pipe-A-plane-0: SUCCESS (4.989s)
[556.388960] Starting dynamic subtest: pipe-A-plane-3
[558.643452] Dynamic subtest pipe-A-plane-3: SUCCESS (2.266s)
[558.651662] Starting dynamic subtest: pipe-A-plane-5
[558.821123] Dynamic subtest pipe-A-plane-5: SUCCESS (0.177s)
[559.895671] Starting dynamic subtest: pipe-B-plane-0
[564.719672] Dynamic subtest pipe-B-plane-0: SUCCESS (4.833s)
[564.730076] Starting dynamic subtest: pipe-B-plane-3
[567.008101] Dynamic subtest pipe-B-plane-3: SUCCESS (2.288s)
[567.015969] Starting dynamic subtest: pipe-B-plane-5
[567.175044] Dynamic subtest pipe-B-plane-5: SUCCESS (0.166s)
[567.483393] Subtest pixel-format: SUCCESS (16.125s)
[568.354321] [085/131] (455s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[568.417982] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[568.419067] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[568.525714] [086/131] (455s left) kms_flip (flip-vs-dpms-on-nop)
[568.610510] Starting subtest: flip-vs-dpms-on-nop
[568.613330] Starting dynamic subtest: A-eDP1
[570.462814] Dynamic subtest A-eDP1: SUCCESS (1.851s)
[570.473335] Starting dynamic subtest: B-eDP1
[572.284353] Dynamic subtest B-eDP1: SUCCESS (1.821s)
[572.294822] Starting dynamic subtest: C-eDP1
[574.103431] Dynamic subtest C-eDP1: SUCCESS (1.818s)
[574.113079] Starting dynamic subtest: D-eDP1
[575.938551] Dynamic subtest D-eDP1: SUCCESS (1.832s)
[575.941173] Subtest flip-vs-dpms-on-nop: SUCCESS (7.331s)
[577.111565] [087/131] (446s left) kms_vblank (ts-continuation-modeset-rpm)
[577.198859] Starting subtest: ts-continuation-modeset-rpm
[577.199872] Starting dynamic subtest: pipe-A-eDP-1
[579.714506] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.514s)
[579.725294] Starting dynamic subtest: pipe-D-eDP-1
[581.961994] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.245s)
[581.962970] Subtest ts-continuation-modeset-rpm: SUCCESS (4.763s)
[582.829593] [088/131] (441s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[582.883620] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[582.994594] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[583.063462] [089/131] (441s left) kms_pm_rpm (universal-planes-dpms)
[584.991870] Starting subtest: universal-planes-dpms
[584.993057] Starting dynamic subtest: plane-33
[593.603153] Dynamic subtest plane-33: SUCCESS (8.610s)
[593.617972] Starting dynamic subtest: plane-43
[602.294740] Dynamic subtest plane-43: SUCCESS (8.689s)
[602.306894] Starting dynamic subtest: plane-53
[610.619861] Dynamic subtest plane-53: SUCCESS (8.321s)
[610.630738] Starting dynamic subtest: plane-63
[619.211912] Dynamic subtest plane-63: SUCCESS (8.588s)
[619.224904] Starting dynamic subtest: plane-73
[627.798140] Dynamic subtest plane-73: SUCCESS (8.583s)
[627.809329] Starting dynamic subtest: plane-83
[636.096977] Dynamic subtest plane-83: SUCCESS (8.294s)
[636.098843] Subtest universal-planes-dpms: SUCCESS (51.099s)
[636.459728] [090/131] (387s left) kms_atomic_transition (modeset-transition-nonblocking)
[636.556427] Starting subtest: modeset-transition-nonblocking
[636.557295] Starting dynamic subtest: 1x-outputs
[647.172435] Dynamic subtest 1x-outputs: SUCCESS (10.612s)
[647.442259] Subtest modeset-transition-nonblocking: SUCCESS (10.884s)
[648.290051] [091/131] (375s left) kms_cursor_crc (cursor-offscreen-max-size)
[648.586016] Starting subtest: cursor-offscreen-max-size
[648.589419] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[648.707575] [092/131] (375s left) gem_exec_balancer (smoke)
[648.768592] Starting subtest: smoke
[671.356293] Subtest smoke: SUCCESS (22.577s)
[672.849180] [093/131] (351s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[672.911870] Starting subtest: map-fixed-invalidate-overlap
[672.914017] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[673.038559] [094/131] (351s left) i915_pm_rpm (sysfs-read)
[674.950027] Starting subtest: sysfs-read
[676.106184] Subtest sysfs-read: SUCCESS (1.153s)
[676.467313] [095/131] (347s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[676.518298] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[676.626413] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[676.695272] [096/131] (347s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[676.749430] Starting subtest: multi-wait-for-submit-available-signaled
[676.750282] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[676.860710] [097/131] (347s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[676.944320] Starting subtest: addfb25-y-tiled-small-legacy
[676.945930] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[677.038627] [098/131] (347s left) gem_exec_whisper (basic-forked)
[677.100706] Starting subtest: basic-forked
[684.405978] Subtest basic-forked: SUCCESS (7.305s)
[684.587797] [099/131] (339s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[684.679805] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[684.681035] Starting dynamic subtest: pipe-A-eDP-1
[684.689302] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[684.698282] Starting dynamic subtest: pipe-B-eDP-1
[684.705999] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[684.714706] Starting dynamic subtest: pipe-C-eDP-1
[684.722127] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[684.730221] Starting dynamic subtest: pipe-D-eDP-1
[684.737607] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[684.738460] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[686.838609] [100/131] (337s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[686.923689] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[686.924647] Starting dynamic subtest: pipe-A-eDP-1
[686.933618] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[686.944737] Starting dynamic subtest: pipe-B-eDP-1
[686.954093] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[686.963817] Starting dynamic subtest: pipe-C-eDP-1
[686.972976] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[686.980786] Starting dynamic subtest: pipe-D-eDP-1
[686.989472] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[686.991145] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[689.128370] [101/131] (335s left) device_reset (unbind-reset-rebind)
[689.180092] Starting subtest: unbind-reset-rebind
[693.873432] Subtest unbind-reset-rebind: SUCCESS (4.689s)
[693.912876] [102/131] (330s left) gem_sync (basic-many-each)
[693.976862] Starting subtest: basic-many-each
[696.266120] Subtest basic-many-each: SUCCESS (2.290s)
[696.445656] [103/131] (328s left) kms_frontbuffer_tracking (fbc-1p-rte)
[696.548786] Starting subtest: fbc-1p-rte
[702.019532] Subtest fbc-1p-rte: SUCCESS (5.473s)
[703.210437] [104/131] (321s left) i915_pm_rpm (debugfs-forcewake-user)
[704.931008] Starting subtest: debugfs-forcewake-user
[716.310998] Subtest debugfs-forcewake-user: SUCCESS (11.380s)
[716.681347] [105/131] (307s left) perf (sysctl-defaults)
[716.743648] Starting subtest: sysctl-defaults
[716.744967] Subtest sysctl-defaults: SUCCESS (0.000s)
[716.821179] [106/131] (307s left) gem_create (hog-create)
[716.875030] Starting subtest: hog-create
[716.876104] Starting dynamic subtest: smem0
[750.834142] Dynamic subtest smem0: SUCCESS (33.958s)
[750.835542] Subtest hog-create: SUCCESS (33.960s)
[751.013676] [107/131] (273s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[751.118031] Starting subtest: yf-tiled-64bpp-rotate-0
[751.119766] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[751.224088] [108/131] (273s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[751.318873] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[755.464959] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.146s)
[756.585395] [109/131] (268s left) gem_pwrite_snooped
[756.739036] [110/131] (268s left) gem_mmap_gtt (fault-concurrent)
[756.791137] Subtest fault-concurrent: SKIP (0.000s)
[756.857100] [111/131] (267s left) gem_softpin (noreloc-s3)
[756.909663] Starting subtest: noreloc-S3
[777.129682] Subtest noreloc-S3: SUCCESS (5.423s)
[786.266537] [112/131] (247s left) api_intel_bb (lot-of-buffers)
[786.328928] Starting subtest: lot-of-buffers
[787.357611] Subtest lot-of-buffers: SUCCESS (1.031s)
[787.733975] [113/131] (246s left) gen7_exec_parse (load-register-reg)
[787.786305] Subtest load-register-reg: SKIP (0.000s)
[787.847848] [114/131] (246s left) kms_plane_scaling (planes-scaler-unity-scaling)
[787.940225] Starting subtest: planes-scaler-unity-scaling
[787.941136] Starting dynamic subtest: pipe-A
[788.008424] Dynamic subtest pipe-A: SUCCESS (0.069s)
[788.023316] Starting dynamic subtest: pipe-B
[789.147329] Dynamic subtest pipe-B: SUCCESS (1.140s)
[789.156399] Starting dynamic subtest: pipe-C
[790.255942] Dynamic subtest pipe-C: SUCCESS (1.110s)
[790.266363] Starting dynamic subtest: pipe-D
[791.372250] Dynamic subtest pipe-D: SUCCESS (1.117s)
[791.373727] Subtest planes-scaler-unity-scaling: SUCCESS (3.441s)
[792.524826] [115/131] (241s left) gem_lmem_swapping (verify-random-ccs)
[792.559117] Subtest verify-random-ccs: SKIP (0.000s)
[792.598952] [116/131] (241s left) kms_big_fb (4-tiled-addfb-size-overflow)
[792.698125] Starting subtest: 4-tiled-addfb-size-overflow
[792.699046] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[792.778114] [117/131] (241s left) kms_properties (get_properties-sanity-atomic)
[792.859757] Starting subtest: get_properties-sanity-atomic
[792.862144] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[792.931050] [118/131] (241s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[793.011658] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[793.013126] Starting dynamic subtest: pipe-A-default-mode
[795.803468] Dynamic subtest pipe-A-default-mode: SUCCESS (2.793s)
[795.804426] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.795s)
[796.631012] [119/131] (237s left) kms_psr (psr2-cursor-mmap-gtt)
[796.718068] Starting subtest: psr2-cursor-mmap-gtt
[796.719063] Starting dynamic subtest: eDP-1
[798.408947] Dynamic subtest eDP-1: SUCCESS (1.691s)
[798.410026] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.692s)
[799.204474] [120/131] (234s left) kms_psr (fbc-pr-sprite-blt)
[799.299134] Starting subtest: fbc-pr-sprite-blt
[799.301299] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[799.365454] [121/131] (234s left) syncobj_wait (single-wait-submitted)
[799.413254] Starting subtest: single-wait-submitted
[799.522879] Subtest single-wait-submitted: SUCCESS (0.108s)
[799.593809] [122/131] (234s left) gem_close (basic)
[799.657407] Starting subtest: basic
[799.659150] Subtest basic: SUCCESS (0.000s)
[799.767078] [123/131] (234s left) prime_mmap (test_forked_cpu_write)
[799.818552] Starting subtest: test_forked_cpu_write
[799.820020] Starting dynamic subtest: test_forked_cpu_write-smem
[799.828213] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[799.829292] Subtest test_forked_cpu_write: SUCCESS (0.011s)
[799.924906] [124/131] (234s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[800.006603] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[807.279699] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.278s)
[807.426413] [125/131] (226s left) perf_pmu (busy-no-semaphores)
[807.462287] Starting subtest: busy-no-semaphores
[807.463190] Starting dynamic subtest: rcs0
[808.047137] Dynamic subtest rcs0: SUCCESS (0.582s)
[808.058072] Starting dynamic subtest: bcs0
[808.599408] Dynamic subtest bcs0: SUCCESS (0.550s)
[808.610213] Starting dynamic subtest: vcs0
[809.151555] Dynamic subtest vcs0: SUCCESS (0.550s)
[809.162783] Starting dynamic subtest: vcs1
[811.113117] Dynamic subtest vcs1: SUCCESS (1.961s)
[811.125731] Starting dynamic subtest: vecs0
[813.098122] Dynamic subtest vecs0: SUCCESS (1.981s)
[813.110171] Starting dynamic subtest: ccs0
[815.081020] Dynamic subtest ccs0: SUCCESS (1.983s)
[815.082615] Subtest busy-no-semaphores: SUCCESS (7.621s)
[815.205632] [126/131] (219s left) kms_cursor_edge_walk (128x128-left-edge)
[815.303042] Starting subtest: 128x128-left-edge
[815.304099] Starting dynamic subtest: pipe-A-eDP-1
[818.774482] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[818.785148] Starting dynamic subtest: pipe-D-eDP-1
[821.907893] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[821.908858] Subtest 128x128-left-edge: SUCCESS (6.606s)
[822.705078] [127/131] (211s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[822.800575] Starting subtest: stress-xrgb8888-yftiled
[822.802376] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[822.865596] [128/131] (211s left) gem_exec_schedule (wide)
[823.040249] Starting subtest: wide
[823.041550] Starting dynamic subtest: rcs0
[835.738043] Dynamic subtest rcs0: SUCCESS (12.694s)
[835.748528] Starting dynamic subtest: vcs0
[849.800574] Dynamic subtest vcs0: SUCCESS (14.062s)
[849.810648] Starting dynamic subtest: vcs1
[863.265532] Dynamic subtest vcs1: SUCCESS (13.464s)
[863.275659] Starting dynamic subtest: vecs0
[876.298159] Dynamic subtest vecs0: SUCCESS (13.033s)
[876.309260] Starting dynamic subtest: ccs0
[891.893515] Dynamic subtest ccs0: SUCCESS (15.593s)
[891.895343] Subtest wide: SUCCESS (68.853s)
[894.133309] [129/131] (140s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[894.182757] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[894.185331] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[894.360854] [130/131] (140s left) syncobj_timeline (invalid-query-one-illegal-handle)
[894.412118] Starting subtest: invalid-query-one-illegal-handle
[894.413943] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[894.526919] [131/131] (139s left) gem_mmap_offset (pf-nonblock)
[894.574338] Starting subtest: pf-nonblock
[894.582620] Subtest pf-nonblock: SUCCESS (0.010s)
[894.706185] 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.