[54.265369] Initializing watchdogs
[54.265416]   /dev/watchdog0
[54.281541] [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]
[54.285731] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.288080] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.291240] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[54.409289] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[54.413135] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[54.494966] [002/131] (960s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[54.580751] Starting subtest: 2x-absolute-wf_vblank-interruptible
[54.591587] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[54.684687] [003/131] (960s left) kms_plane (plane-position-hole)
[54.773686] Starting subtest: plane-position-hole
[55.298512] Starting dynamic subtest: pipe-A-plane-1
[56.577923] Dynamic subtest pipe-A-plane-1: SUCCESS (1.297s)
[56.586340] Starting dynamic subtest: pipe-A-plane-2
[57.801845] Dynamic subtest pipe-A-plane-2: SUCCESS (1.241s)
[57.810457] Starting dynamic subtest: pipe-A-plane-3
[59.022823] Dynamic subtest pipe-A-plane-3: SUCCESS (1.231s)
[59.031357] Starting dynamic subtest: pipe-A-plane-4
[60.241259] Dynamic subtest pipe-A-plane-4: SUCCESS (1.231s)
[60.248414] Starting dynamic subtest: pipe-A-plane-5
[60.265588] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[61.379256] Starting dynamic subtest: pipe-B-plane-1
[62.619205] Dynamic subtest pipe-B-plane-1: SUCCESS (1.255s)
[62.628361] Starting dynamic subtest: pipe-B-plane-2
[63.928035] Dynamic subtest pipe-B-plane-2: SUCCESS (1.314s)
[63.936444] Starting dynamic subtest: pipe-B-plane-3
[65.164162] Dynamic subtest pipe-B-plane-3: SUCCESS (1.241s)
[65.173101] Starting dynamic subtest: pipe-B-plane-4
[66.383962] Dynamic subtest pipe-B-plane-4: SUCCESS (1.225s)
[66.390617] Starting dynamic subtest: pipe-B-plane-5
[66.410629] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[66.412506] Subtest plane-position-hole: SUCCESS (11.734s)
[67.186283] [004/131] (947s left) kms_flip (nonblocking-read)
[67.286926] Starting subtest: nonblocking-read
[67.289073] Subtest nonblocking-read: SUCCESS (0.000s)
[67.388232] [005/131] (947s left) gem_tiled_pread_basic
[67.514213] [006/131] (947s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[67.625711] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[68.633024] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.011s)
[68.777944] [007/131] (946s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[68.865273] Starting subtest: fbc-psr-cursor-mmap-cpu
[68.867650] Starting dynamic subtest: eDP-1
[68.872342] Dynamic subtest eDP-1: SKIP (0.000s)
[68.876087] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[68.930751] [008/131] (946s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[69.017359] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[69.019354] Starting dynamic subtest: pipe-A-eDP-1
[69.037827] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[69.045224] Starting dynamic subtest: pipe-B-eDP-1
[69.062754] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[69.068594] Starting dynamic subtest: pipe-C-eDP-1
[69.085741] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[69.091526] Starting dynamic subtest: pipe-D-eDP-1
[69.110323] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[69.114019] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.002s)
[71.197494] [009/131] (943s left) kms_getfb (getfb2-accept-nv12)
[71.538867] Starting subtest: getfb2-accept-nv12
[71.541296] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[71.868107] [010/131] (943s left) kms_pm_rpm (cursor-dpms)
[74.099234] Starting subtest: cursor-dpms
[74.104486] Subtest cursor-dpms: SKIP (0.000s)
[74.465425] [011/131] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[74.574777] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[74.579302] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[74.689189] [012/131] (940s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[75.094036] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[75.859339] [013/131] (939s left) gem_pread (self)
[75.914137] Subtest self: SKIP (0.000s)
[75.953520] [014/131] (939s left) gem_bad_reloc (negative-reloc-lut)
[76.011190] Subtest negative-reloc-lut: SKIP (0.000s)
[76.095433] [015/131] (939s left) sriov_basic (enable-vfs-autoprobe-on)
[76.152923] Starting subtest: enable-vfs-autoprobe-on
[76.155265] Starting dynamic subtest: numvfs-1
[76.233416] Dynamic subtest numvfs-1: FAIL (0.033s)
[76.241201] Starting dynamic subtest: numvfs-2
[76.313108] Dynamic subtest numvfs-2: FAIL (0.004s)
[76.321175] Starting dynamic subtest: numvfs-3
[76.394309] Dynamic subtest numvfs-3: FAIL (0.003s)
[76.402385] Starting dynamic subtest: numvfs-4
[76.475202] Dynamic subtest numvfs-4: FAIL (0.004s)
[76.483132] Starting dynamic subtest: numvfs-5
[76.556714] Dynamic subtest numvfs-5: FAIL (0.003s)
[76.564616] Starting dynamic subtest: numvfs-6
[76.637725] Dynamic subtest numvfs-6: FAIL (0.004s)
[76.645971] Starting dynamic subtest: numvfs-7
[76.719283] Dynamic subtest numvfs-7: FAIL (0.003s)
[76.727206] Starting dynamic subtest: numvfs-random
[76.801522] Dynamic subtest numvfs-random: FAIL (0.003s)
[76.809552] Starting dynamic subtest: numvfs-all
[76.870454] Dynamic subtest numvfs-all: FAIL (0.499s)
[76.872328] Subtest enable-vfs-autoprobe-on: FAIL (0.558s)
[76.906240] [016/131] (938s left) gem_ctx_param (invalid-get-ringsize)
[76.960329] Starting subtest: invalid-get-ringsize
[76.962403] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[77.049586] [017/131] (938s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[77.093725] Starting subtest: multi-wait-all-for-submit-submitted
[77.200436] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[77.274140] [018/131] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[77.366141] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[77.370263] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[77.462658] [019/131] (937s left) kms_flip (modeset-vs-vblank-race-interruptible)
[77.566494] Starting subtest: modeset-vs-vblank-race-interruptible
[77.568751] Starting dynamic subtest: A-eDP1
[82.209124] Dynamic subtest A-eDP1: SUCCESS (4.645s)
[82.218265] Starting dynamic subtest: B-eDP1
[86.854920] Dynamic subtest B-eDP1: SUCCESS (4.644s)
[86.865342] Starting dynamic subtest: C-eDP1
[91.390248] Dynamic subtest C-eDP1: SUCCESS (4.534s)
[91.398498] Starting dynamic subtest: D-eDP1
[95.928566] Dynamic subtest D-eDP1: SUCCESS (4.537s)
[95.933503] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.370s)
[97.077458] [020/131] (918s left) kms_psr (fbc-psr-sprite-render)
[97.171306] Starting subtest: fbc-psr-sprite-render
[97.173648] Starting dynamic subtest: eDP-1
[97.177798] Dynamic subtest eDP-1: SKIP (0.000s)
[97.181980] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[97.243150] [021/131] (918s left) gem_softpin (allocator-basic-reserve)
[97.311776] Starting subtest: allocator-basic-reserve
[97.383279] Subtest allocator-basic-reserve: SUCCESS (0.071s)
[97.534179] [022/131] (918s left) drm_read (invalid-buffer)
[97.689823] Starting subtest: invalid-buffer
[97.692359] Subtest invalid-buffer: SUCCESS (0.000s)
[97.837935] [023/131] (917s left) i915_drm_fdinfo (memory-info-shared)
[97.879455] Starting subtest: memory-info-shared
[97.881282] Starting dynamic subtest: smem0
[97.952766] Dynamic subtest smem0: SUCCESS (0.075s)
[97.955646] Subtest memory-info-shared: SUCCESS (0.075s)
[98.022267] [024/131] (917s left) i915_drm_fdinfo (busy-idle)
[98.060512] Starting subtest: busy-idle
[98.062471] Starting dynamic subtest: rcs0
[98.097299] Dynamic subtest rcs0: SKIP (0.035s)
[98.106280] Starting dynamic subtest: bcs0
[98.109777] Dynamic subtest bcs0: SKIP (0.001s)
[98.115990] Starting dynamic subtest: vcs0
[98.119242] Dynamic subtest vcs0: SKIP (0.001s)
[98.124989] Starting dynamic subtest: vcs1
[98.128621] Dynamic subtest vcs1: SKIP (0.001s)
[98.134553] Starting dynamic subtest: vecs0
[98.137930] Dynamic subtest vecs0: SKIP (0.001s)
[98.145220] Starting dynamic subtest: ccs0
[98.149514] Dynamic subtest ccs0: SKIP (0.000s)
[98.153379] Subtest busy-idle: SKIP (0.042s)
[98.198318] [025/131] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[98.309327] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[98.312778] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[98.424212] [026/131] (917s left) kms_psr (psr2-sprite-plane-onoff)
[98.528925] Starting subtest: psr2-sprite-plane-onoff
[98.530867] Starting dynamic subtest: eDP-1
[100.291481] Dynamic subtest eDP-1: SUCCESS (1.759s)
[100.293402] Subtest psr2-sprite-plane-onoff: SUCCESS (1.760s)
[101.140147] [027/131] (914s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[101.239081] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[101.241407] Starting dynamic subtest: pipe-A-eDP-1
[101.264548] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.273632] Starting dynamic subtest: pipe-B-eDP-1
[101.295147] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.301968] Starting dynamic subtest: pipe-C-eDP-1
[101.323401] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.330221] Starting dynamic subtest: pipe-D-eDP-1
[101.353510] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.358076] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.003s)
[103.419619] [028/131] (912s left) kms_dp_link_training (uhbr-sst)
[103.510607] Starting subtest: uhbr-sst
[103.519644] Subtest uhbr-sst: SKIP (0.000s)
[103.580367] [029/131] (912s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[108.603023] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[108.605212] Starting dynamic subtest: pipe-A-eDP-1
[109.382615] Dynamic subtest pipe-A-eDP-1: SKIP (0.777s)
[109.391199] Starting dynamic subtest: pipe-B-eDP-1
[110.511531] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[110.515893] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.909s)
[111.695076] [030/131] (904s left) perf (blocking-parameterized)
[111.807841] Starting subtest: blocking-parameterized
[131.827339] Subtest blocking-parameterized: SUCCESS (20.019s)
[131.899417] [031/131] (884s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[132.031356] Starting subtest: cursorA-vs-flipB-legacy
[132.035939] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[132.170812] [032/131] (883s left) kms_color (deep-color)
[132.260981] Starting subtest: deep-color
[133.370822] Starting dynamic subtest: pipe-A-eDP-1-gamma
[134.069379] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.695s)
[134.077565] Starting dynamic subtest: pipe-A-eDP-1-degamma
[135.487174] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.412s)
[135.496084] Starting dynamic subtest: pipe-A-eDP-1-ctm
[136.898690] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.417s)
[137.673682] Starting dynamic subtest: pipe-B-eDP-1-gamma
[138.349418] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.679s)
[138.357722] Starting dynamic subtest: pipe-B-eDP-1-degamma
[139.728014] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.379s)
[139.734968] Starting dynamic subtest: pipe-B-eDP-1-ctm
[141.172053] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.442s)
[141.960631] Starting dynamic subtest: pipe-C-eDP-1-gamma
[142.618465] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.662s)
[142.628115] Starting dynamic subtest: pipe-C-eDP-1-degamma
[143.975470] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.358s)
[143.983623] Starting dynamic subtest: pipe-C-eDP-1-ctm
[145.296735] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.321s)
[146.059481] Starting dynamic subtest: pipe-D-eDP-1-gamma
[146.717195] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.662s)
[146.726848] Starting dynamic subtest: pipe-D-eDP-1-degamma
[148.066102] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.345s)
[148.075429] Starting dynamic subtest: pipe-D-eDP-1-ctm
[149.388224] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.324s)
[149.390573] Subtest deep-color: SUCCESS (17.125s)
[150.202224] [033/131] (865s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[150.252043] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[150.311500] [034/131] (865s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[150.410182] Starting subtest: async-flip-with-page-flip-events-linear
[150.784608] Starting dynamic subtest: pipe-A-eDP-1
[153.590724] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.805s)
[153.976032] Starting dynamic subtest: pipe-B-eDP-1
[156.733265] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.760s)
[157.094627] Starting dynamic subtest: pipe-C-eDP-1
[159.855171] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[160.226088] Starting dynamic subtest: pipe-D-eDP-1
[162.990726] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[162.993590] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.576s)
[164.171616] [035/131] (851s left) kms_lease (lessee-list)
[164.263312] Starting subtest: lessee-list
[164.265639] Starting dynamic subtest: pipe-A-eDP-1
[164.267963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[164.274985] Starting dynamic subtest: pipe-B-eDP-1
[164.276942] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[164.283282] Starting dynamic subtest: pipe-C-eDP-1
[164.285130] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[164.291458] Starting dynamic subtest: pipe-D-eDP-1
[164.293385] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[164.295314] Subtest lessee-list: SUCCESS (0.009s)
[164.363033] [036/131] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[164.462821] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[171.170267] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.706s)
[171.273817] [037/131] (844s left) sysfs_timeslice_duration (timeout)
[171.332171] Starting subtest: timeout
[171.334431] Starting dynamic subtest: vecs0
[180.897228] Dynamic subtest vecs0: SUCCESS (9.558s)
[180.907252] Starting dynamic subtest: ccs0
[182.271050] Dynamic subtest ccs0: SUCCESS (1.374s)
[182.281799] Starting dynamic subtest: vcs0
[191.907549] Dynamic subtest vcs0: SUCCESS (9.631s)
[191.920344] Starting dynamic subtest: bcs0
[192.585547] Dynamic subtest bcs0: SUCCESS (0.677s)
[192.594067] Starting dynamic subtest: rcs0
[193.877709] Dynamic subtest rcs0: SUCCESS (1.289s)
[193.887036] Starting dynamic subtest: vcs1
[203.948852] Dynamic subtest vcs1: SUCCESS (10.068s)
[203.951487] Subtest timeout: SUCCESS (32.607s)
[204.022906] [038/131] (812s left) gem_userptr_blits (create-destroy-unsync)
[204.090511] Subtest create-destroy-unsync: SKIP (0.000s)
[204.206047] [039/131] (812s left) gem_mmap_gtt (ptrace)
[204.272327] Subtest ptrace: SKIP (0.000s)
[204.338172] [040/131] (811s left) syncobj_wait (wait-all-for-submit-complex)
[204.398719] Starting subtest: wait-all-for-submit-complex
[204.613792] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[204.685117] [041/131] (811s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[204.786496] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[211.985874] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.200s)
[212.116809] [042/131] (804s left) gem_exec_fence (syncobj-timeline-wait)
[212.671153] Starting subtest: syncobj-timeline-wait
[213.905774] Subtest syncobj-timeline-wait: SUCCESS (1.235s)
[214.137603] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[214.140832] [043/131] (802s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[214.246613] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[214.251338] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[214.368100] [044/131] (802s left) syncobj_timeline (transfer-timeline-point)
[214.412145] Starting subtest: transfer-timeline-point
[214.414319] Subtest transfer-timeline-point: SUCCESS (0.000s)
[214.518700] [045/131] (801s left) gem_spin_batch (legacy)
[214.575924] Starting subtest: legacy
[214.578323] Starting dynamic subtest: default
[217.816501] Dynamic subtest default: SUCCESS (3.234s)
[217.825270] Starting dynamic subtest: render
[221.052842] Dynamic subtest render: SUCCESS (3.233s)
[221.061511] Starting dynamic subtest: bsd
[224.288100] Dynamic subtest bsd: SUCCESS (3.232s)
[224.297123] Starting dynamic subtest: bsd1
[227.523788] Dynamic subtest bsd1: SUCCESS (3.233s)
[227.531492] Starting dynamic subtest: bsd2
[230.757729] Dynamic subtest bsd2: SUCCESS (3.230s)
[230.770871] Starting dynamic subtest: blt
[233.992684] Dynamic subtest blt: SUCCESS (3.233s)
[234.001303] Starting dynamic subtest: vebox
[237.229914] Dynamic subtest vebox: SUCCESS (3.233s)
[237.232457] Subtest legacy: SUCCESS (22.647s)
[237.933975] [046/131] (778s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[238.053448] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[238.057846] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[238.161287] [047/131] (778s left) api_intel_allocator (gem-pool)
[238.221973] Starting subtest: gem-pool
[238.228058] Subtest gem-pool: SUCCESS (0.009s)
[238.369613] [048/131] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[238.475540] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[238.479966] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[238.580346] [049/131] (778s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[238.680353] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[239.783612] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.103s)
[239.914145] [050/131] (776s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt)
[240.013377] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt
[244.206259] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (4.196s)
[245.346178] [051/131] (771s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[245.445513] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[245.449441] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[245.566935] [052/131] (771s left) kms_cursor_crc (cursor-sliding-512x512)
[245.809074] Starting subtest: cursor-sliding-512x512
[245.813473] Subtest cursor-sliding-512x512: SKIP (0.001s)
[245.973838] [053/131] (770s left) gem_request_retire (retire-vma-not-inactive)
[246.041908] Starting subtest: retire-vma-not-inactive
[246.100060] Subtest retire-vma-not-inactive: SUCCESS (0.056s)
[246.217457] [054/131] (770s left) gem_exec_schedule (noreorder)
[246.401298] Starting subtest: noreorder
[246.404090] Starting dynamic subtest: rcs0
[246.483315] Dynamic subtest rcs0: SUCCESS (0.084s)
[246.493851] Starting dynamic subtest: vcs0
[247.866036] Dynamic subtest vcs0: SUCCESS (1.379s)
[247.875773] Starting dynamic subtest: vcs1
[249.935127] Dynamic subtest vcs1: SUCCESS (2.067s)
[249.945467] Starting dynamic subtest: vecs0
[251.946254] Dynamic subtest vecs0: SUCCESS (2.008s)
[251.954222] Starting dynamic subtest: ccs0
[252.043753] Dynamic subtest ccs0: SUCCESS (0.096s)
[252.046503] Subtest noreorder: SUCCESS (5.645s)
[252.223130] [055/131] (764s left) gem_userptr_blits (coherency-sync)
[252.276428] Starting subtest: coherency-sync
[252.552640] Subtest coherency-sync: SKIP (0.244s)
[252.671737] [056/131] (764s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[252.816289] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[252.818507] Starting dynamic subtest: pipe-A-eDP-1
[252.838805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[252.848157] Starting dynamic subtest: pipe-B-eDP-1
[252.867145] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[252.874683] Starting dynamic subtest: pipe-C-eDP-1
[252.893289] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[252.901196] Starting dynamic subtest: pipe-D-eDP-1
[252.921529] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[252.923855] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[255.020280] [057/131] (761s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[260.073690] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[260.076045] Starting dynamic subtest: pipe-A-eDP-1
[271.504665] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.427s)
[271.513744] Starting dynamic subtest: pipe-B-eDP-1
[282.935740] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.428s)
[282.938310] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.861s)
[283.787253] [058/131] (733s left) kms_selftest (drm_dp_mst_helper)
[283.834544] Starting subtest: drm_dp_mst_helper
[283.856706] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[283.994420] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.138s)
[284.001873] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[284.099919] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.105s)
[284.107946] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[284.225586] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.124s)
[284.227433] Subtest drm_dp_mst_helper: SUCCESS (0.390s)
[284.435150] [059/131] (732s left) kms_vblank (query-idle-hang)
[284.520152] Starting subtest: query-idle-hang
[284.522482] Starting dynamic subtest: pipe-A-eDP-1
[310.677041] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.154s)
[310.690620] Starting dynamic subtest: pipe-D-eDP-1
[325.707806] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.028s)
[325.709753] Subtest query-idle-hang: SUCCESS (41.186s)
[326.528657] [060/131] (690s left) kms_hdr (invalid-metadata-sizes)
[326.627272] Starting subtest: invalid-metadata-sizes
[326.633976] Subtest invalid-metadata-sizes: SKIP (0.000s)
[326.701114] [061/131] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[326.812606] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[326.816965] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[326.898174] [062/131] (690s left) gem_exec_schedule (preempt-other)
[326.978343] Starting subtest: preempt-other
[326.980591] Starting dynamic subtest: rcs0
[327.043855] Dynamic subtest rcs0: SUCCESS (0.071s)
[327.056387] Starting dynamic subtest: bcs0
[327.108134] Dynamic subtest bcs0: SUCCESS (0.064s)
[327.121716] Starting dynamic subtest: vcs0
[327.173387] Dynamic subtest vcs0: SUCCESS (0.064s)
[327.186060] Starting dynamic subtest: vcs1
[327.238924] Dynamic subtest vcs1: SUCCESS (0.064s)
[327.251317] Starting dynamic subtest: vecs0
[327.300393] Dynamic subtest vecs0: SUCCESS (0.061s)
[327.310226] Starting dynamic subtest: ccs0
[327.363286] Dynamic subtest ccs0: SUCCESS (0.062s)
[327.365611] Subtest preempt-other: SUCCESS (0.392s)
[329.017634] [063/131] (688s left) tools_test (sysfs_l3_parity)
[329.068065] Starting subtest: sysfs_l3_parity
[329.119358] Subtest sysfs_l3_parity: SKIP (0.061s)
[329.170329] [064/131] (687s left) gem_tiled_partial_pwrite_pread (writes)
[329.238580] Subtest writes: SKIP (0.000s)
[329.331232] [065/131] (687s left) gem_userptr_blits (process-exit-busy)
[329.400688] Starting subtest: process-exit-busy
[329.411073] Subtest process-exit-busy: SUCCESS (0.012s)
[329.539855] [066/131] (687s left) gem_create (create-clear)
[329.596969] Starting subtest: create-clear
[329.599998] Starting dynamic subtest: smem0
[362.395207] Dynamic subtest smem0: SUCCESS (32.796s)
[362.397559] Subtest create-clear: SUCCESS (32.797s)
[362.578463] [067/131] (654s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[362.692532] Starting subtest: y-tiled-16bpp-rotate-270
[362.696972] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[362.789458] [068/131] (654s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[362.893786] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[367.412446] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.523s)
[368.536258] [069/131] (648s left) gem_exec_params (dr4-dirt)
[368.600384] Starting subtest: DR4-dirt
[368.602638] Subtest DR4-dirt: SUCCESS (0.000s)
[368.738480] [070/131] (648s left) gem_exec_fence (keep-in-fence)
[368.906543] Starting subtest: keep-in-fence
[368.909065] Starting dynamic subtest: rcs0
[368.983292] Dynamic subtest rcs0: SUCCESS (0.077s)
[368.994239] Starting dynamic subtest: bcs0
[369.037710] Dynamic subtest bcs0: SUCCESS (0.052s)
[369.051343] Starting dynamic subtest: vcs0
[370.900817] Dynamic subtest vcs0: SUCCESS (1.860s)
[370.911485] Starting dynamic subtest: vcs1
[372.885056] Dynamic subtest vcs1: SUCCESS (1.982s)
[372.896344] Starting dynamic subtest: vecs0
[374.931893] Dynamic subtest vecs0: SUCCESS (2.045s)
[374.941939] Starting dynamic subtest: ccs0
[375.169039] Dynamic subtest ccs0: SUCCESS (0.236s)
[375.171741] Subtest keep-in-fence: SUCCESS (6.264s)
[377.006136] [071/131] (640s left) gem_eio (in-flight-10ms)
[377.224766] Starting subtest: in-flight-10ms
[385.743647] Subtest in-flight-10ms: SUCCESS (8.517s)
[385.899955] [072/131] (631s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[385.990485] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[385.992960] Starting dynamic subtest: pipe-A-default-mode
[386.282280] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[386.286795] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.288s)
[387.156134] [073/131] (630s left) kms_content_protection (content-type-change)
[387.309698] Starting subtest: content-type-change
[390.705081] Subtest content-type-change: SKIP (3.393s)
[391.893997] [074/131] (625s left) kms_fbcon_fbt (psr-suspend)
[391.948387] Starting subtest: psr-suspend
[441.634803] Subtest psr-suspend: SUCCESS (20.059s)
[441.704639] [075/131] (575s left) gem_exec_reloc (basic-wc-active)
[441.766553] Subtest basic-wc-active: SKIP (0.000s)
[441.847358] [076/131] (575s left) syncobj_wait (invalid-single-wait-unsubmitted)
[441.903176] Starting subtest: invalid-single-wait-unsubmitted
[441.905118] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[442.001498] [077/131] (575s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[442.096994] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[442.101327] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[442.186512] [078/131] (575s left) gem_ctx_persistence (legacy-engines-mixed)
[442.246655] Starting subtest: legacy-engines-mixed
[442.248882] Starting dynamic subtest: render
[442.346934] Dynamic subtest render: SUCCESS (0.100s)
[442.357908] Starting dynamic subtest: bsd1
[442.416222] Dynamic subtest bsd1: SUCCESS (0.068s)
[442.427795] Starting dynamic subtest: bsd2
[442.492309] Dynamic subtest bsd2: SUCCESS (0.075s)
[442.503220] Starting dynamic subtest: blt
[442.571323] Dynamic subtest blt: SUCCESS (0.078s)
[442.584859] Starting dynamic subtest: vebox
[442.639010] Dynamic subtest vebox: SUCCESS (0.066s)
[442.641167] Subtest legacy-engines-mixed: SUCCESS (0.398s)
[442.713389] [079/131] (575s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[443.100155] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[443.885670] [080/131] (573s left) gem_userptr_blits (readonly-pwrite-unsync)
[443.952747] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[444.087494] [081/131] (573s left) kms_flip (plain-flip-fb-recreate)
[444.189675] Starting subtest: plain-flip-fb-recreate
[444.191904] Starting dynamic subtest: A-eDP1
[453.082455] Dynamic subtest A-eDP1: SUCCESS (8.944s)
[453.091944] Starting dynamic subtest: B-eDP1
[461.971999] Dynamic subtest B-eDP1: SUCCESS (8.907s)
[461.983563] Starting dynamic subtest: C-eDP1
[470.791285] Dynamic subtest C-eDP1: SUCCESS (8.826s)
[470.804669] Starting dynamic subtest: D-eDP1
[479.628787] Dynamic subtest D-eDP1: SUCCESS (8.839s)
[479.633233] Subtest plain-flip-fb-recreate: SUCCESS (35.524s)
[480.805262] [082/131] (537s left) gem_pipe_control_store_loop (fresh-buffer)
[480.876495] Starting subtest: fresh-buffer
[483.028280] Subtest fresh-buffer: SUCCESS (2.151s)
[483.157987] [083/131] (534s left) gem_exec_alignment (pi)
[483.219787] Starting subtest: pi
[534.476328] Subtest pi: SUCCESS (51.275s)
[535.396184] [084/131] (482s left) kms_plane (pixel-format)
[535.545769] Starting subtest: pixel-format
[535.576932] Starting dynamic subtest: pipe-A-plane-0
[540.512611] Dynamic subtest pipe-A-plane-0: SUCCESS (4.933s)
[540.523467] Starting dynamic subtest: pipe-A-plane-3
[542.813451] Dynamic subtest pipe-A-plane-3: SUCCESS (2.299s)
[542.826864] Starting dynamic subtest: pipe-A-plane-5
[543.013686] Dynamic subtest pipe-A-plane-5: SUCCESS (0.200s)
[544.072355] Starting dynamic subtest: pipe-B-plane-0
[548.911152] Dynamic subtest pipe-B-plane-0: SUCCESS (4.844s)
[548.920009] Starting dynamic subtest: pipe-B-plane-3
[551.178326] Dynamic subtest pipe-B-plane-3: SUCCESS (2.266s)
[551.189551] Starting dynamic subtest: pipe-B-plane-5
[551.367466] Dynamic subtest pipe-B-plane-5: SUCCESS (0.188s)
[551.673660] Subtest pixel-format: SUCCESS (16.120s)
[552.536639] [085/131] (465s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[552.609731] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[552.612103] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[552.723837] [086/131] (465s left) kms_flip (flip-vs-dpms-on-nop)
[552.817863] Starting subtest: flip-vs-dpms-on-nop
[552.820114] Starting dynamic subtest: A-eDP1
[554.733008] Dynamic subtest A-eDP1: SUCCESS (1.914s)
[554.744551] Starting dynamic subtest: B-eDP1
[556.562682] Dynamic subtest B-eDP1: SUCCESS (1.828s)
[556.571798] Starting dynamic subtest: C-eDP1
[558.388698] Dynamic subtest C-eDP1: SUCCESS (1.823s)
[558.399969] Starting dynamic subtest: D-eDP1
[560.225033] Dynamic subtest D-eDP1: SUCCESS (1.835s)
[560.227372] Subtest flip-vs-dpms-on-nop: SUCCESS (7.409s)
[561.405358] [087/131] (456s left) kms_vblank (ts-continuation-modeset-rpm)
[561.503525] Starting subtest: ts-continuation-modeset-rpm
[561.505809] Starting dynamic subtest: pipe-A-eDP-1
[564.003058] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[564.019009] Starting dynamic subtest: pipe-D-eDP-1
[566.241094] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.236s)
[566.243412] Subtest ts-continuation-modeset-rpm: SUCCESS (4.736s)
[567.037012] [088/131] (451s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[567.094903] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[567.203197] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[567.278663] [089/131] (450s left) kms_pm_rpm (universal-planes-dpms)
[568.905664] Starting subtest: universal-planes-dpms
[568.908111] Starting dynamic subtest: plane-33
[577.199401] Dynamic subtest plane-33: SUCCESS (8.297s)
[577.209204] Starting dynamic subtest: plane-43
[585.616184] Dynamic subtest plane-43: SUCCESS (8.414s)
[585.628303] Starting dynamic subtest: plane-53
[593.911340] Dynamic subtest plane-53: SUCCESS (8.295s)
[593.921687] Starting dynamic subtest: plane-63
[602.606633] Dynamic subtest plane-63: SUCCESS (8.695s)
[602.617904] Starting dynamic subtest: plane-73
[611.198538] Dynamic subtest plane-73: SUCCESS (8.591s)
[611.210625] Starting dynamic subtest: plane-83
[619.600089] Dynamic subtest plane-83: SUCCESS (8.400s)
[619.602781] Subtest universal-planes-dpms: SUCCESS (50.706s)
[619.968248] [090/131] (398s left) kms_atomic_transition (modeset-transition-nonblocking)
[620.074297] Starting subtest: modeset-transition-nonblocking
[620.076664] Starting dynamic subtest: 1x-outputs
[630.636586] Dynamic subtest 1x-outputs: SUCCESS (10.567s)
[630.906555] Subtest modeset-transition-nonblocking: SUCCESS (10.838s)
[631.766288] [091/131] (386s left) kms_cursor_crc (cursor-offscreen-max-size)
[632.069288] Starting subtest: cursor-offscreen-max-size
[632.075895] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[632.212876] [092/131] (386s left) gem_exec_balancer (smoke)
[632.275319] Starting subtest: smoke
[654.815211] Subtest smoke: SUCCESS (22.545s)
[655.408800] [093/131] (362s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[655.484564] Starting subtest: map-fixed-invalidate-overlap
[655.488887] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[655.614161] [094/131] (362s left) i915_pm_rpm (sysfs-read)
[657.939322] Starting subtest: sysfs-read
[659.116365] Subtest sysfs-read: SUCCESS (1.171s)
[659.471102] [095/131] (358s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[659.529480] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[659.634924] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[659.713049] [096/131] (358s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[659.770438] Starting subtest: multi-wait-for-submit-available-signaled
[659.772708] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[659.866389] [097/131] (358s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[659.958863] Starting subtest: addfb25-y-tiled-small-legacy
[659.963635] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[660.079428] [098/131] (358s left) gem_exec_whisper (basic-forked)
[660.138787] Starting subtest: basic-forked
[667.256183] Subtest basic-forked: SUCCESS (7.109s)
[667.441940] [099/131] (351s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[667.553020] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[667.555261] Starting dynamic subtest: pipe-A-eDP-1
[667.575078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[667.586366] Starting dynamic subtest: pipe-B-eDP-1
[667.605533] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[667.614989] Starting dynamic subtest: pipe-C-eDP-1
[667.634274] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[667.644785] Starting dynamic subtest: pipe-D-eDP-1
[667.664096] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[667.666305] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.009s)
[669.827136] [100/131] (348s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[669.935437] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[669.937770] Starting dynamic subtest: pipe-A-eDP-1
[669.961022] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[669.972162] Starting dynamic subtest: pipe-B-eDP-1
[669.993800] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[670.003445] Starting dynamic subtest: pipe-C-eDP-1
[670.024643] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[670.034676] Starting dynamic subtest: pipe-D-eDP-1
[670.055877] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[670.059885] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[672.197379] [101/131] (346s left) device_reset (unbind-reset-rebind)
[672.243013] Starting subtest: unbind-reset-rebind
[676.987713] Subtest unbind-reset-rebind: SUCCESS (4.735s)
[677.030025] [102/131] (341s left) gem_sync (basic-many-each)
[677.108214] Starting subtest: basic-many-each
[679.394802] Subtest basic-many-each: SUCCESS (2.295s)
[679.579894] [103/131] (339s left) kms_frontbuffer_tracking (fbc-1p-rte)
[679.687174] Starting subtest: fbc-1p-rte
[685.149238] Subtest fbc-1p-rte: SUCCESS (5.462s)
[686.358447] [104/131] (332s left) i915_pm_rpm (debugfs-forcewake-user)
[687.981226] Starting subtest: debugfs-forcewake-user
[699.385944] Subtest debugfs-forcewake-user: SUCCESS (11.399s)
[699.762717] [105/131] (318s left) perf (sysctl-defaults)
[699.839761] Starting subtest: sysctl-defaults
[699.842304] Subtest sysctl-defaults: SUCCESS (0.000s)
[699.931534] [106/131] (318s left) gem_create (hog-create)
[699.992347] Starting subtest: hog-create
[699.994790] Starting dynamic subtest: smem0
[733.771353] Dynamic subtest smem0: SUCCESS (33.771s)
[733.774255] Subtest hog-create: SUCCESS (33.772s)
[733.953772] [107/131] (284s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[734.061621] Starting subtest: yf-tiled-64bpp-rotate-0
[734.066096] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[734.162641] [108/131] (284s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[734.260889] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[738.413617] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.157s)
[739.556867] [109/131] (279s left) gem_pwrite_snooped
[739.727085] [110/131] (279s left) gem_mmap_gtt (fault-concurrent)
[739.787660] Subtest fault-concurrent: SKIP (0.000s)
[739.859702] [111/131] (279s left) gem_softpin (noreloc-s3)
[739.925501] Starting subtest: noreloc-S3
[760.688777] Subtest noreloc-S3: SUCCESS (5.394s)
[760.835792] [112/131] (258s left) api_intel_bb (lot-of-buffers)
[760.903896] Starting subtest: lot-of-buffers
[761.860274] Subtest lot-of-buffers: SUCCESS (0.957s)
[762.230352] [113/131] (256s left) gen7_exec_parse (load-register-reg)
[762.284707] Subtest load-register-reg: SKIP (0.000s)
[762.354541] [114/131] (256s left) kms_plane_scaling (planes-scaler-unity-scaling)
[762.454279] Starting subtest: planes-scaler-unity-scaling
[762.456488] Starting dynamic subtest: pipe-A
[762.523065] Dynamic subtest pipe-A: SUCCESS (0.068s)
[762.535298] Starting dynamic subtest: pipe-B
[763.712266] Dynamic subtest pipe-B: SUCCESS (1.187s)
[763.724474] Starting dynamic subtest: pipe-C
[764.821916] Dynamic subtest pipe-C: SUCCESS (1.107s)
[764.832598] Starting dynamic subtest: pipe-D
[765.950412] Dynamic subtest pipe-D: SUCCESS (1.127s)
[765.952857] Subtest planes-scaler-unity-scaling: SUCCESS (3.492s)
[767.113850] [115/131] (252s left) gem_lmem_swapping (verify-random-ccs)
[767.155551] Subtest verify-random-ccs: SKIP (0.000s)
[767.204925] [116/131] (251s left) kms_big_fb (4-tiled-addfb-size-overflow)
[767.308292] Starting subtest: 4-tiled-addfb-size-overflow
[767.310998] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[767.417347] [117/131] (251s left) kms_properties (get_properties-sanity-atomic)
[767.514501] Starting subtest: get_properties-sanity-atomic
[767.516922] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[767.592810] [118/131] (251s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[767.680835] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[767.683277] Starting dynamic subtest: pipe-A-default-mode
[770.479576] Dynamic subtest pipe-A-default-mode: SUCCESS (2.793s)
[770.481772] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.795s)
[771.326134] [119/131] (247s left) kms_psr (psr2-cursor-mmap-gtt)
[771.434297] Starting subtest: psr2-cursor-mmap-gtt
[771.436727] Starting dynamic subtest: eDP-1
[773.098144] Dynamic subtest eDP-1: SUCCESS (1.665s)
[773.100813] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.666s)
[773.984564] [120/131] (245s left) kms_psr (fbc-pr-sprite-blt)
[774.093668] Starting subtest: fbc-pr-sprite-blt
[774.097992] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[774.169736] [121/131] (245s left) syncobj_wait (single-wait-submitted)
[774.224137] Starting subtest: single-wait-submitted
[774.329782] Subtest single-wait-submitted: SUCCESS (0.107s)
[774.405925] [122/131] (245s left) gem_close (basic)
[774.471730] Starting subtest: basic
[774.474270] Subtest basic: SUCCESS (0.000s)
[774.565320] [123/131] (244s left) prime_mmap (test_forked_cpu_write)
[774.624878] Starting subtest: test_forked_cpu_write
[774.627014] Starting dynamic subtest: test_forked_cpu_write-smem
[774.631935] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[774.634558] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[774.745220] [124/131] (244s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[774.851993] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[782.151643] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.300s)
[782.277892] [125/131] (237s left) perf_pmu (busy-no-semaphores)
[782.315530] Starting subtest: busy-no-semaphores
[782.317858] Starting dynamic subtest: rcs0
[782.871015] Dynamic subtest rcs0: SUCCESS (0.554s)
[782.884018] Starting dynamic subtest: bcs0
[783.422055] Dynamic subtest bcs0: SUCCESS (0.549s)
[783.435750] Starting dynamic subtest: vcs0
[783.972321] Dynamic subtest vcs0: SUCCESS (0.547s)
[783.985893] Starting dynamic subtest: vcs1
[785.656198] Dynamic subtest vcs1: SUCCESS (1.680s)
[785.669574] Starting dynamic subtest: vecs0
[787.639799] Dynamic subtest vecs0: SUCCESS (1.980s)
[787.651297] Starting dynamic subtest: ccs0
[789.628656] Dynamic subtest ccs0: SUCCESS (1.984s)
[789.632003] Subtest busy-no-semaphores: SUCCESS (7.312s)
[789.753375] [126/131] (229s left) kms_cursor_edge_walk (128x128-left-edge)
[789.850472] Starting subtest: 128x128-left-edge
[789.852729] Starting dynamic subtest: pipe-A-eDP-1
[793.285772] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.432s)
[793.296020] Starting dynamic subtest: pipe-D-eDP-1
[796.404377] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[796.406788] Subtest 128x128-left-edge: SUCCESS (6.552s)
[797.231556] [127/131] (222s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[797.324933] Starting subtest: stress-xrgb8888-yftiled
[797.330479] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[797.395210] [128/131] (222s left) gem_exec_schedule (wide)
[797.575779] Starting subtest: wide
[797.578073] Starting dynamic subtest: rcs0
[807.723626] Dynamic subtest rcs0: SUCCESS (10.148s)
[807.738202] Starting dynamic subtest: vcs0
[817.457195] Dynamic subtest vcs0: SUCCESS (9.732s)
[817.467514] Starting dynamic subtest: vcs1
[827.761612] Dynamic subtest vcs1: SUCCESS (10.303s)
[827.771391] Starting dynamic subtest: vecs0
[837.801007] Dynamic subtest vecs0: SUCCESS (10.036s)
[837.812759] Starting dynamic subtest: ccs0
[852.636465] Dynamic subtest ccs0: SUCCESS (14.832s)
[852.638728] Subtest wide: SUCCESS (55.058s)
[854.121810] [129/131] (165s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[854.192014] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[854.197983] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[854.376895] [130/131] (165s left) syncobj_timeline (invalid-query-one-illegal-handle)
[854.435990] Starting subtest: invalid-query-one-illegal-handle
[854.438739] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[854.551336] [131/131] (165s left) gem_mmap_offset (pf-nonblock)
[854.602747] Starting subtest: pf-nonblock
[854.611662] Subtest pf-nonblock: SUCCESS (0.011s)
[854.743881] 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.