[58.007468] Initializing watchdogs
[58.007527]   /dev/watchdog0
[58.024261] [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.028939] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.031218] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.034825] [001/133] (960s left) perf (whitelisted-registers-userspace-config)
[58.191079] Starting subtest: whitelisted-registers-userspace-config
[58.193339] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[58.230546] [002/133] (960s left) gem_busy (busy)
[58.297081] Starting subtest: busy
[58.299370] Starting dynamic subtest: all-engines
[58.352445] Dynamic subtest all-engines: SUCCESS (0.058s)
[58.362671] Starting dynamic subtest: rcs0
[59.935638] Dynamic subtest rcs0: SUCCESS (1.583s)
[59.944697] Starting dynamic subtest: bcs0
[59.988854] Dynamic subtest bcs0: SUCCESS (0.052s)
[59.996956] Starting dynamic subtest: vcs0
[60.030105] Dynamic subtest vcs0: SUCCESS (0.039s)
[60.038705] Starting dynamic subtest: vcs1
[61.915042] Dynamic subtest vcs1: SUCCESS (1.883s)
[61.924519] Starting dynamic subtest: vecs0
[63.899432] Dynamic subtest vecs0: SUCCESS (1.984s)
[63.908642] Starting dynamic subtest: ccs0
[65.882301] Dynamic subtest ccs0: SUCCESS (1.983s)
[65.884769] Subtest busy: SUCCESS (7.586s)
[66.232225] [003/133] (952s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[66.334845] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[66.338859] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[66.402070] [004/133] (952s left) i915_pm_freq_mult (media-freq)
[66.463640] Starting subtest: media-freq
[66.465849] Starting dynamic subtest: gt0
[66.469885] Dynamic subtest gt0: SKIP (0.000s)
[66.478826] Starting dynamic subtest: gt1
[66.483132] Dynamic subtest gt1: SKIP (0.000s)
[66.487265] Subtest media-freq: SKIP (0.001s)
[66.558397] [005/133] (952s left) prime_mmap (test_map_unmap)
[66.614858] Starting subtest: test_map_unmap
[66.617200] Starting dynamic subtest: test_map_unmap-smem
[66.646987] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[66.649441] Subtest test_map_unmap: SUCCESS (0.034s)
[66.744195] [006/133] (951s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[66.924859] Starting subtest: short-flip-after-cursor-toggle
[67.959121] Subtest short-flip-after-cursor-toggle: SUCCESS (1.033s)
[68.765188] [007/133] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[68.862893] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[76.561125] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.702s)
[76.672458] [008/133] (942s left) i915_module_load (resize-bar)
[76.717583] Starting subtest: resize-bar
[76.724469] Subtest resize-bar: SKIP (0.006s)
[76.770927] [009/133] (942s left) kms_pwrite_crc
[78.434818] [010/133] (940s left) gem_userptr_blits (coherency-unsync)
[78.495726] Subtest coherency-unsync: SKIP (0.000s)
[78.616556] [011/133] (940s left) gem_softpin (allocator-fork)
[78.678047] Starting subtest: allocator-fork
[80.908455] Subtest allocator-fork: SUCCESS (2.230s)
[81.056322] [012/133] (937s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[81.153642] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[81.157719] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[81.222235] [013/133] (937s left) kms_plane_multiple (tiling-yf)
[81.317663] Starting subtest: tiling-yf
[81.321699] Subtest tiling-yf: SKIP (0.000s)
[81.387859] [014/133] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[81.479662] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[81.484192] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[81.588498] [015/133] (937s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[81.696359] Starting subtest: plane-all-modeset-transition-fencing
[81.700461] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[81.778925] [016/133] (937s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[81.874906] Starting subtest: crc-primary-suspend-y-tiled-ccs
[81.877275] Starting dynamic subtest: pipe-A-eDP-1
[81.886526] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[81.895761] Starting dynamic subtest: pipe-B-eDP-1
[81.903541] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[81.910764] Starting dynamic subtest: pipe-C-eDP-1
[81.917409] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[81.924058] Starting dynamic subtest: pipe-D-eDP-1
[81.930948] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[81.934140] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.003s)
[84.204772] [017/133] (934s left) kms_prop_blob (blob-prop-core)
[84.267757] Starting subtest: blob-prop-core
[84.269835] Subtest blob-prop-core: SUCCESS (0.000s)
[84.378186] [018/133] (934s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[84.512261] Starting subtest: fbc-farfromfence-mmap-gtt
[84.516175] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[84.610818] [019/133] (934s left) gem_mmap_gtt (basic-write-read)
[84.665306] Subtest basic-write-read: SKIP (0.000s)
[84.719737] [020/133] (934s left) syncobj_wait (wait-for-submit-delayed-submit)
[84.778318] Starting subtest: wait-for-submit-delayed-submit
[84.881119] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[84.958409] [021/133] (934s left) syncobj_timeline (multi-wait-available-signaled)
[85.019945] Starting subtest: multi-wait-available-signaled
[85.022870] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[85.102600] [022/133] (934s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[85.196820] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[85.198759] Starting dynamic subtest: pipe-A-eDP-1
[87.366367] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.170s)
[87.376580] Starting dynamic subtest: pipe-B-eDP-1
[89.792319] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.425s)
[89.800475] Starting dynamic subtest: pipe-C-eDP-1
[91.903589] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.110s)
[91.911937] Starting dynamic subtest: pipe-D-eDP-1
[94.012641] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.107s)
[94.014560] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.817s)
[95.219308] [023/133] (924s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[95.323396] Starting subtest: primary-yf-tiled-reflect-x-90
[95.327986] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[95.409980] [024/133] (924s left) syncobj_basic (bad-flags-handle-to-fd)
[95.462195] Starting subtest: bad-flags-handle-to-fd
[95.464478] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[95.562402] [025/133] (923s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[95.667876] Starting subtest: extended-modeset-hang-newfb-with-reset
[95.670232] Starting dynamic subtest: pipe-A
[110.844389] Dynamic subtest pipe-A: SUCCESS (15.177s)
[110.856247] Starting dynamic subtest: pipe-D
[126.634528] Dynamic subtest pipe-D: SUCCESS (15.786s)
[126.636696] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.968s)
[127.432418] [026/133] (892s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[127.518593] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[127.520989] Starting dynamic subtest: pipe-A
[128.564913] Dynamic subtest pipe-A: SUCCESS (1.050s)
[128.577908] Starting dynamic subtest: pipe-B
[130.723885] Dynamic subtest pipe-B: SUCCESS (2.158s)
[130.731918] Starting dynamic subtest: pipe-C
[131.919450] Dynamic subtest pipe-C: SUCCESS (1.194s)
[131.928182] Starting dynamic subtest: pipe-D
[133.138817] Dynamic subtest pipe-D: SUCCESS (1.218s)
[133.141212] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.624s)
[134.330679] [027/133] (885s left) kms_cursor_crc (cursor-random-max-size)
[134.649084] Starting subtest: cursor-random-max-size
[134.655797] Subtest cursor-random-max-size: SKIP (0.000s)
[134.787949] [028/133] (884s left) gem_exec_schedule (noreorder)
[134.980815] Starting subtest: noreorder
[134.983360] Starting dynamic subtest: rcs0
[135.039779] Dynamic subtest rcs0: SUCCESS (0.062s)
[135.051563] Starting dynamic subtest: vcs0
[136.893776] Dynamic subtest vcs0: SUCCESS (1.850s)
[136.903025] Starting dynamic subtest: vcs1
[138.903088] Dynamic subtest vcs1: SUCCESS (2.008s)
[138.912779] Starting dynamic subtest: vecs0
[140.879727] Dynamic subtest vecs0: SUCCESS (1.975s)
[140.889086] Starting dynamic subtest: ccs0
[140.957282] Dynamic subtest ccs0: SUCCESS (0.076s)
[140.960064] Subtest noreorder: SUCCESS (5.980s)
[141.144476] [029/133] (878s left) gem_ctx_persistence (engines-persistence)
[141.198774] Starting subtest: engines-persistence
[141.201137] Starting dynamic subtest: rcs0
[141.985308] Dynamic subtest rcs0: SUCCESS (0.786s)
[141.998102] Starting dynamic subtest: bcs0
[142.715720] Dynamic subtest bcs0: SUCCESS (0.729s)
[142.725719] Starting dynamic subtest: vcs0
[143.507394] Dynamic subtest vcs0: SUCCESS (0.789s)
[143.521886] Starting dynamic subtest: vcs1
[144.272876] Dynamic subtest vcs1: SUCCESS (0.763s)
[144.283650] Starting dynamic subtest: vecs0
[145.048953] Dynamic subtest vecs0: SUCCESS (0.774s)
[145.060301] Starting dynamic subtest: ccs0
[145.825843] Dynamic subtest ccs0: SUCCESS (0.775s)
[145.828556] Subtest engines-persistence: SUCCESS (4.628s)
[145.920452] [030/133] (873s left) gem_mmap_wc (pf-nonblock)
[145.988649] Subtest pf-nonblock: SKIP (0.000s)
[146.046920] [031/133] (873s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[146.142044] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[146.146194] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[146.216065] [032/133] (873s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[146.271852] Starting subtest: invalid-single-wait-all-unsubmitted
[146.274165] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[146.366265] [033/133] (873s left) core_debugfs (read-all-entries)
[146.417488] Starting subtest: read-all-entries
[146.513025] Subtest read-all-entries: SUCCESS (0.095s)
[146.580740] [034/133] (873s left) gem_render_copy (yf-tiled)
[146.639494] Starting subtest: yf-tiled
[146.643549] Subtest yf-tiled: SKIP (0.000s)
[146.821353] [035/133] (873s left) gem_partial_pwrite_pread (reads-uncached)
[146.896824] Subtest reads-uncached: SKIP (0.000s)
[146.959788] [036/133] (872s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[147.051091] Starting subtest: plane-scaler-unity-scaling-with-rotation
[147.053434] Starting dynamic subtest: pipe-A
[147.277947] Dynamic subtest pipe-A: SUCCESS (0.229s)
[147.287347] Starting dynamic subtest: pipe-B
[148.624353] Dynamic subtest pipe-B: SUCCESS (1.345s)
[148.633072] Starting dynamic subtest: pipe-C
[149.966546] Dynamic subtest pipe-C: SUCCESS (1.340s)
[149.976799] Starting dynamic subtest: pipe-D
[151.295756] Dynamic subtest pipe-D: SUCCESS (1.328s)
[151.298088] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.247s)
[152.462702] [037/133] (867s left) kms_plane_alpha_blend (alpha-7efc)
[152.552349] Starting subtest: alpha-7efc
[152.834379] Starting dynamic subtest: pipe-A-eDP-1
[153.430828] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[153.456991] Starting dynamic subtest: pipe-D-eDP-1
[154.778580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[154.780981] Subtest alpha-7efc: SUCCESS (2.229s)
[155.647602] [038/133] (864s left) kms_psr (pr-sprite-plane-onoff)
[155.746104] Starting subtest: pr-sprite-plane-onoff
[155.750597] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[155.829428] [039/133] (864s left) prime_vgem (basic-gtt)
[155.958671] Starting subtest: basic-gtt
[155.963266] Subtest basic-gtt: SKIP (0.000s)
[156.065404] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[156.069589] [040/133] (864s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[156.165311] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[156.169584] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[156.270888] [041/133] (863s left) kms_invalid_mode (zero-hdisplay)
[156.363925] Starting subtest: zero-hdisplay
[156.366219] Starting dynamic subtest: pipe-A-eDP-1
[156.649891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[156.658693] Starting dynamic subtest: pipe-B-eDP-1
[156.660668] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[156.667845] Starting dynamic subtest: pipe-C-eDP-1
[156.669813] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[156.677632] Starting dynamic subtest: pipe-D-eDP-1
[156.679850] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[156.682195] Subtest zero-hdisplay: SUCCESS (0.292s)
[157.474253] [042/133] (862s left) i915_suspend (basic-s2idle-without-i915)
[157.508781] Starting subtest: basic-s2idle-without-i915
[177.991758] Subtest basic-s2idle-without-i915: SUCCESS (5.423s)
[187.136384] [043/133] (842s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[187.260464] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[187.262808] Starting dynamic subtest: pipe-A-eDP-1
[187.285527] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[187.296695] Starting dynamic subtest: pipe-B-eDP-1
[187.317642] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[187.325717] Starting dynamic subtest: pipe-C-eDP-1
[187.347633] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[187.355342] Starting dynamic subtest: pipe-D-eDP-1
[187.377386] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[187.381470] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[189.552706] [044/133] (839s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[189.633460] Starting subtest: invalid-bsd2-flag-on-vebox
[189.635778] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[189.746639] [045/133] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[189.861138] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[189.865284] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[189.959023] [046/133] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[190.064735] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[190.068691] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[190.160574] [047/133] (839s left) gem_sync (basic-store-all)
[190.236546] Starting subtest: basic-store-all
[193.314892] Subtest basic-store-all: SUCCESS (3.088s)
[193.500945] [048/133] (835s left) kms_pm_rpm (pm-caching)
[195.169142] Starting subtest: pm-caching
[195.173837] Subtest pm-caching: SKIP (0.000s)
[195.834701] [049/133] (833s left) gem_unref_active_buffers
[196.050969] [050/133] (833s left) kms_psr (fbc-pr-primary-mmap-gtt)
[196.138472] Starting subtest: fbc-pr-primary-mmap-gtt
[196.142843] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[196.219198] [051/133] (833s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[196.264890] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[196.373315] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[196.466186] [052/133] (833s left) gem_exec_reloc (basic-wc-noreloc)
[196.526376] Subtest basic-wc-noreloc: SKIP (0.000s)
[196.593012] [053/133] (833s left) gem_lmem_swapping (random-engines)
[196.642887] Subtest random-engines: SKIP (0.000s)
[196.696475] [054/133] (833s left) gem_exec_flush (basic-wb-ro-before-default)
[196.767658] Starting subtest: basic-wb-ro-before-default
[202.218874] Subtest basic-wb-ro-before-default: SUCCESS (5.453s)
[202.409908] [055/133] (827s left) gem_ctx_persistence (heartbeat-hostile)
[202.467123] Starting subtest: heartbeat-hostile
[202.471782] Subtest heartbeat-hostile: SKIP (0.000s)
[202.569168] [056/133] (827s left) dmabuf_sync_file (import-basic)
[202.619570] Starting subtest: import-basic
[202.621839] Subtest import-basic: SUCCESS (0.002s)
[202.679145] [057/133] (827s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[202.785610] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[202.789758] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[202.881290] [058/133] (827s left) syncobj_wait (single-wait-all-submitted)
[202.928632] Starting subtest: single-wait-all-submitted
[203.037327] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[203.114605] [059/133] (826s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[203.210333] Starting subtest: fbc-psr2-sprite-mmap-gtt
[203.212574] Starting dynamic subtest: eDP-1
[203.216729] Dynamic subtest eDP-1: SKIP (0.000s)
[203.220914] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[203.287930] [060/133] (826s left) gem_exec_store (dword)
[203.354354] Starting subtest: dword
[203.356262] Starting dynamic subtest: rcs0
[203.430267] Dynamic subtest rcs0: SUCCESS (0.077s)
[203.441236] Starting dynamic subtest: bcs0
[203.473680] Dynamic subtest bcs0: SUCCESS (0.041s)
[203.483144] Starting dynamic subtest: vcs0
[203.515571] Dynamic subtest vcs0: SUCCESS (0.040s)
[203.524927] Starting dynamic subtest: vcs1
[203.558467] Dynamic subtest vcs1: SUCCESS (0.041s)
[203.567958] Starting dynamic subtest: vecs0
[203.600747] Dynamic subtest vecs0: SUCCESS (0.040s)
[203.609956] Starting dynamic subtest: ccs0
[203.643080] Dynamic subtest ccs0: SUCCESS (0.040s)
[203.645352] Subtest dword: SUCCESS (0.292s)
[203.831372] [061/133] (826s left) gem_exec_fence (concurrent)
[204.010631] Starting subtest: concurrent
[204.014789] Subtest concurrent: SKIP (0.000s)
[206.048424] [062/133] (824s left) perf_pmu (busy-accuracy-50)
[206.104539] Starting subtest: busy-accuracy-50
[206.106884] Starting dynamic subtest: rcs0
[207.652041] Dynamic subtest rcs0: SUCCESS (1.546s)
[207.661211] Starting dynamic subtest: bcs0
[209.204083] Dynamic subtest bcs0: SUCCESS (1.549s)
[209.213232] Starting dynamic subtest: vcs0
[210.747446] Dynamic subtest vcs0: SUCCESS (1.541s)
[210.756020] Starting dynamic subtest: vcs1
[212.291371] Dynamic subtest vcs1: SUCCESS (1.542s)
[212.300585] Starting dynamic subtest: vecs0
[213.832150] Dynamic subtest vecs0: SUCCESS (1.538s)
[213.842664] Starting dynamic subtest: ccs0
[215.374481] Dynamic subtest ccs0: SUCCESS (1.541s)
[215.377390] Subtest busy-accuracy-50: SUCCESS (9.269s)
[215.528502] [063/133] (814s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[215.639118] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[215.643107] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[215.732086] [064/133] (814s left) i915_drm_fdinfo (busy-check-all)
[215.772966] Starting subtest: busy-check-all
[215.775324] Starting dynamic subtest: rcs0
[215.779853] Dynamic subtest rcs0: SKIP (0.005s)
[215.789786] Starting dynamic subtest: bcs0
[215.793655] Dynamic subtest bcs0: SKIP (0.000s)
[215.802597] Starting dynamic subtest: vcs0
[215.807041] Dynamic subtest vcs0: SKIP (0.000s)
[215.815954] Starting dynamic subtest: vcs1
[215.820278] Dynamic subtest vcs1: SKIP (0.000s)
[215.828616] Starting dynamic subtest: vecs0
[215.832804] Dynamic subtest vecs0: SKIP (0.000s)
[215.841140] Starting dynamic subtest: ccs0
[215.845429] Dynamic subtest ccs0: SKIP (0.000s)
[215.849802] Subtest busy-check-all: SKIP (0.010s)
[215.888580] [065/133] (814s left) kms_pm_dc (dc5-dpms)
[217.031696] Starting subtest: dc5-dpms
[219.060929] Subtest dc5-dpms: SUCCESS (2.029s)
[219.139015] [066/133] (811s left) gem_exec_reloc (basic-cpu-read-active)
[219.200470] Subtest basic-cpu-read-active: SKIP (0.000s)
[219.266431] [067/133] (811s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[219.378777] Starting subtest: short-flip-after-cursor-atomic-transitions
[220.340081] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.961s)
[221.151224] [068/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[221.254483] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[221.258682] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[221.363918] [069/133] (809s left) gem_partial_pwrite_pread (writes-after-reads)
[221.427747] Subtest writes-after-reads: SKIP (0.000s)
[221.504369] [070/133] (808s left) gem_eio (in-flight-1us)
[221.707244] Starting subtest: in-flight-1us
[229.525394] Subtest in-flight-1us: SUCCESS (7.816s)
[229.686348] [071/133] (800s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[229.747454] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[229.853010] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[229.932847] [072/133] (800s left) gem_render_tiled_blits (basic)
[229.996537] Subtest basic: SKIP (0.000s)
[230.071014] [073/133] (800s left) prime_vgem (wait)
[230.143811] Starting subtest: wait
[230.146092] Starting dynamic subtest: rcs0
[230.202663] Dynamic subtest rcs0: SUCCESS (0.059s)
[230.212082] Starting dynamic subtest: bcs0
[230.261851] Dynamic subtest bcs0: SUCCESS (0.058s)
[230.271181] Starting dynamic subtest: vcs0
[230.308207] Dynamic subtest vcs0: SUCCESS (0.045s)
[230.317238] Starting dynamic subtest: vcs1
[230.355899] Dynamic subtest vcs1: SUCCESS (0.047s)
[230.365180] Starting dynamic subtest: vecs0
[230.400784] Dynamic subtest vecs0: SUCCESS (0.044s)
[230.409944] Starting dynamic subtest: ccs0
[230.447315] Dynamic subtest ccs0: SUCCESS (0.046s)
[230.449505] Subtest wait: SUCCESS (0.304s)
[230.575572] [074/133] (800s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[230.682926] Starting subtest: fbc-tiling-linear
[234.380916] Subtest fbc-tiling-linear: SUCCESS (3.702s)
[235.546030] [075/133] (795s left) kms_color (ctm-0-50)
[235.660964] Starting subtest: ctm-0-50
[235.662857] Starting dynamic subtest: pipe-A-eDP-1
[239.166881] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.504s)
[239.176308] Starting dynamic subtest: pipe-B-eDP-1
[243.467716] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.300s)
[243.477912] Starting dynamic subtest: pipe-C-eDP-1
[247.511702] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.046s)
[247.522030] Starting dynamic subtest: pipe-D-eDP-1
[251.523723] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.008s)
[251.525962] Subtest ctm-0-50: SUCCESS (15.862s)
[252.345811] [076/133] (778s left) kms_vblank (ts-continuation-modeset-rpm)
[252.432570] Starting subtest: ts-continuation-modeset-rpm
[252.434462] Starting dynamic subtest: pipe-A-eDP-1
[254.955167] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.521s)
[254.970035] Starting dynamic subtest: pipe-D-eDP-1
[257.192555] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.237s)
[257.194850] Subtest ts-continuation-modeset-rpm: SUCCESS (4.762s)
[258.096238] [077/133] (772s left) gem_create (create-valid-nonaligned)
[258.147947] Starting subtest: create-valid-nonaligned
[258.150231] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[258.339441] [078/133] (772s left) gem_exec_reloc (basic-cpu-gtt)
[258.402217] Subtest basic-cpu-gtt: SKIP (0.000s)
[258.466850] [079/133] (772s left) gem_exec_reloc (basic-write-cpu)
[258.524090] Subtest basic-write-cpu: SKIP (0.000s)
[258.594119] [080/133] (772s left) sysfs_preempt_timeout (invalid)
[258.652532] Starting subtest: invalid
[258.654901] Starting dynamic subtest: vecs0
[258.657267] Dynamic subtest vecs0: SUCCESS (0.000s)
[258.668011] Starting dynamic subtest: ccs0
[258.669877] Dynamic subtest ccs0: SUCCESS (0.000s)
[258.678725] Starting dynamic subtest: vcs0
[258.680579] Dynamic subtest vcs0: SUCCESS (0.000s)
[258.689268] Starting dynamic subtest: bcs0
[258.691550] Dynamic subtest bcs0: SUCCESS (0.000s)
[258.703330] Starting dynamic subtest: rcs0
[258.705923] Dynamic subtest rcs0: SUCCESS (0.000s)
[258.717145] Starting dynamic subtest: vcs1
[258.719058] Dynamic subtest vcs1: SUCCESS (0.000s)
[258.720943] Subtest invalid: SUCCESS (0.006s)
[258.758642] [081/133] (772s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[258.829988] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[258.947099] [082/133] (771s left) gem_exec_params (invalid-batch-start-offset)
[259.018281] Starting subtest: invalid-batch-start-offset
[259.023979] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[259.140570] [083/133] (771s left) perf_pmu (rc6)
[259.185594] Starting subtest: rc6
[259.187439] Starting dynamic subtest: gt0
[265.552881] Dynamic subtest gt0: SUCCESS (6.368s)
[265.565569] Starting dynamic subtest: runtime-pm-gt0
[273.333545] Dynamic subtest runtime-pm-gt0: SUCCESS (7.779s)
[273.345747] Starting dynamic subtest: runtime-pm-long-gt0
[285.841733] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.501s)
[285.854132] Starting dynamic subtest: other-idle-gt0
[292.186534] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[292.199149] Starting dynamic subtest: gt1
[298.529757] Dynamic subtest gt1: SUCCESS (6.339s)
[298.542440] Starting dynamic subtest: runtime-pm-gt1
[306.053024] Dynamic subtest runtime-pm-gt1: SUCCESS (7.519s)
[306.065084] Starting dynamic subtest: runtime-pm-long-gt1
[318.545732] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.488s)
[318.558591] Starting dynamic subtest: other-idle-gt1
[324.890953] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[324.894083] Subtest rc6: SUCCESS (65.697s)
[326.040308] [084/133] (704s left) gem_mmap_offset (partial-unmap)
[326.098213] Starting subtest: partial-unmap
[326.100090] Starting dynamic subtest: smem0
[326.620571] Dynamic subtest smem0: SUCCESS (0.523s)
[326.623435] Subtest partial-unmap: SUCCESS (0.524s)
[326.721634] [085/133] (704s left) kms_dsc (dsc-basic)
[326.806550] Starting subtest: dsc-basic
[326.819558] Subtest dsc-basic: SKIP (0.001s)
[326.859742] [086/133] (704s left) perf_pmu (multi-client)
[326.903216] Starting subtest: multi-client
[326.905283] Starting dynamic subtest: rcs0
[327.965095] Dynamic subtest rcs0: SUCCESS (1.062s)
[327.977567] Starting dynamic subtest: bcs0
[329.017599] Dynamic subtest bcs0: SUCCESS (1.048s)
[329.029583] Starting dynamic subtest: vcs0
[330.068789] Dynamic subtest vcs0: SUCCESS (1.049s)
[330.081106] Starting dynamic subtest: vcs1
[332.000928] Dynamic subtest vcs1: SUCCESS (1.929s)
[332.013128] Starting dynamic subtest: vecs0
[333.983989] Dynamic subtest vecs0: SUCCESS (1.981s)
[333.995526] Starting dynamic subtest: ccs0
[335.968215] Dynamic subtest ccs0: SUCCESS (1.982s)
[335.970841] Subtest multi-client: SUCCESS (9.067s)
[336.063200] [087/133] (695s left) gem_exec_schedule (u-semaphore-user)
[336.131633] Starting subtest: u-semaphore-user
[336.187392] Subtest u-semaphore-user: SUCCESS (0.061s)
[337.980250] [088/133] (693s left) gem_eio (banned)
[338.176395] Starting subtest: banned
[338.686997] Subtest banned: SUCCESS (0.513s)
[338.842153] [089/133] (692s left) kms_lease (lease-revoke)
[338.940583] Starting subtest: lease-revoke
[338.942453] Starting dynamic subtest: pipe-A-eDP-1
[338.973791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[338.983385] Starting dynamic subtest: pipe-B-eDP-1
[339.001967] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[339.011484] Starting dynamic subtest: pipe-C-eDP-1
[339.029920] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[339.039555] Starting dynamic subtest: pipe-D-eDP-1
[339.058988] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[339.060835] Subtest lease-revoke: SUCCESS (0.120s)
[339.161386] [090/133] (692s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[339.548789] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[340.366090] [091/133] (690s left) gem_exec_await (wide-contexts)
[340.553247] Starting subtest: wide-contexts
[363.883493] Subtest wide-contexts: SUCCESS (23.327s)
[364.061828] [092/133] (667s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[364.219463] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[364.287675] [093/133] (667s left) kms_dp_linktrain_fallback (dsc-fallback)
[364.380604] Starting subtest: dsc-fallback
[364.386994] Subtest dsc-fallback: SKIP (0.000s)
[364.433206] [094/133] (667s left) gem_lmem_swapping (parallel-random)
[364.483289] Subtest parallel-random: SKIP (0.000s)
[364.534187] [095/133] (666s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[364.643637] Starting subtest: y-tiled-64bpp-rotate-270
[364.647960] Subtest y-tiled-64bpp-rotate-270: SKIP (0.001s)
[364.718613] [096/133] (666s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[364.826161] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[364.830724] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[364.915878] [097/133] (666s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[365.017253] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[372.094276] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.080s)
[372.176043] [098/133] (659s left) gem_fenced_exec_thrash (too-many-fences)
[372.248068] Subtest too-many-fences: SKIP (0.000s)
[372.317227] [099/133] (659s left) kms_big_fb (linear-16bpp-rotate-0)
[372.418853] Starting subtest: linear-16bpp-rotate-0
[373.864451] Subtest linear-16bpp-rotate-0: SUCCESS (1.446s)
[373.964697] [100/133] (657s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[374.025257] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[374.133393] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[374.189080] [101/133] (657s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[374.300168] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[374.304556] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[374.358753] [102/133] (657s left) gen7_exec_parse (basic-rejected)
[374.420489] Subtest basic-rejected: SKIP (0.000s)
[374.490882] [103/133] (657s left) api_intel_allocator (reserve-simple)
[374.555019] Starting subtest: reserve-simple
[374.557232] Subtest reserve-simple: SUCCESS (0.003s)
[374.655401] [104/133] (657s left) gem_eio (create)
[374.892156] Starting subtest: create
[375.235202] Subtest create: SUCCESS (0.345s)
[375.361707] [105/133] (656s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[375.419864] Starting subtest: y-tiled-ccs-to-yf-tiled
[375.423655] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[375.582113] [106/133] (656s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[375.685417] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[375.690127] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[375.759720] [107/133] (656s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[375.903534] Starting subtest: dp-mst-lic-type-0-hdcp14
[375.907997] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[376.008630] [108/133] (656s left) gem_create (create-ext-placement-all)
[376.180269] Starting subtest: create-ext-placement-all
[376.182566] Subtest create-ext-placement-all: SUCCESS (0.000s)
[376.256100] [109/133] (655s left) kms_cursor_crc (cursor-dpms)
[376.381268] Starting subtest: cursor-dpms
[376.383572] Starting dynamic subtest: pipe-A-eDP-1
[379.400998] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.018s)
[379.412108] Starting dynamic subtest: pipe-D-eDP-1
[383.083611] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.681s)
[383.085959] Subtest cursor-dpms: SUCCESS (6.701s)
[383.905601] [110/133] (648s left) syncobj_timeline (wait-all-complex)
[383.966821] Starting subtest: wait-all-complex
[384.181710] Subtest wait-all-complex: SUCCESS (0.215s)
[384.238421] [111/133] (647s left) kms_sequence (get-busy)
[384.330362] Starting subtest: get-busy
[384.332533] Starting dynamic subtest: pipe-A-eDP-1
[386.265431] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[386.275957] Starting dynamic subtest: pipe-B-eDP-1
[388.850185] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.583s)
[388.863325] Starting dynamic subtest: pipe-C-eDP-1
[391.462113] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.611s)
[391.473899] Starting dynamic subtest: pipe-D-eDP-1
[394.015520] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[394.017797] Subtest get-busy: SUCCESS (9.684s)
[394.865855] [112/133] (637s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[394.968920] Starting subtest: fbcpsr-rgb101010-draw-render
[401.734622] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.768s)
[401.826589] [113/133] (630s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[401.933678] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[402.602244] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[402.744612] [114/133] (629s left) gem_busy (close-race)
[402.801477] Starting subtest: close-race
[425.960722] Subtest close-race: SUCCESS (23.156s)
[426.304004] [115/133] (606s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[426.440569] Starting subtest: fbc-rgb565-draw-mmap-gtt
[426.444518] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[426.518197] [116/133] (605s left) kms_cursor_crc (cursor-sliding-64x64)
[426.706236] Starting subtest: cursor-sliding-64x64
[426.708837] Starting dynamic subtest: pipe-A-eDP-1
[429.968789] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.258s)
[430.006788] Starting dynamic subtest: pipe-D-eDP-1
[433.934657] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.934s)
[433.936925] Subtest cursor-sliding-64x64: SUCCESS (7.228s)
[434.753983] [117/133] (597s left) gem_softpin (evict-active)
[434.827988] Starting subtest: evict-active
[434.832968] Subtest evict-active: SUCCESS (0.005s)
[434.940586] [118/133] (597s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[435.318585] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[436.175032] [119/133] (596s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[436.285053] Starting subtest: psr-rgb101010-draw-pwrite
[444.036553] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.754s)
[444.125849] [120/133] (588s left) kms_cdclk (mode-transition-all-outputs)
[444.216588] Starting subtest: mode-transition-all-outputs
[444.510005] Subtest mode-transition-all-outputs: SKIP (0.290s)
[445.339032] [121/133] (587s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[445.447647] Starting subtest: fbc-pr-sprite-mmap-cpu
[445.451967] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[445.498816] [122/133] (587s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[445.614236] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[445.618545] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[445.660208] [123/133] (587s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[445.766255] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[446.872424] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.106s)
[446.984200] [124/133] (585s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[447.086472] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[447.088355] Starting dynamic subtest: pipe-A-eDP-1
[447.136363] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[447.157371] Starting dynamic subtest: pipe-B-eDP-1
[447.203613] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[447.217590] Starting dynamic subtest: pipe-C-eDP-1
[447.265309] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[447.275525] Starting dynamic subtest: pipe-D-eDP-1
[447.322029] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[447.325544] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[449.327181] [125/133] (583s left) gem_exec_fence (syncobj-import)
[449.782839] Starting subtest: syncobj-import
[449.788457] Subtest syncobj-import: SUCCESS (0.005s)
[451.045274] [126/133] (581s left) kms_psr (psr2-sprite-plane-move)
[451.129631] Starting subtest: psr2-sprite-plane-move
[451.131859] Starting dynamic subtest: eDP-1
[452.871834] Dynamic subtest eDP-1: SUCCESS (1.741s)
[452.874152] Subtest psr2-sprite-plane-move: SUCCESS (1.742s)
[453.693215] [127/133] (579s left) kms_atomic_transition (modeset-transition-fencing)
[453.791410] Starting subtest: modeset-transition-fencing
[453.793713] Starting dynamic subtest: 1x-outputs
[464.595579] Dynamic subtest 1x-outputs: SUCCESS (10.802s)
[464.598054] Subtest modeset-transition-fencing: SUCCESS (10.804s)
[465.443366] [128/133] (567s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[465.536243] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[472.502370] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.967s)
[472.623491] [129/133] (560s left) gem_exec_balancer (busy)
[472.690017] Starting subtest: busy
[473.957828] Subtest busy: SUCCESS (1.266s)
[474.247283] [130/133] (558s left) kms_flip (flip-vs-blocking-wf-vblank)
[474.351731] Starting subtest: flip-vs-blocking-wf-vblank
[474.354180] Starting dynamic subtest: A-eDP1
[483.244481] Dynamic subtest A-eDP1: SUCCESS (8.894s)
[483.256639] Starting dynamic subtest: B-eDP1
[492.167712] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[492.179643] Starting dynamic subtest: C-eDP1
[501.102038] Dynamic subtest C-eDP1: SUCCESS (8.931s)
[501.114593] Starting dynamic subtest: D-eDP1
[510.038540] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[510.040780] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.691s)
[511.252671] [131/133] (521s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[511.356091] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[515.786298] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.434s)
[516.966428] [132/133] (516s left) gem_create (create-invalid-size)
[517.024616] Starting subtest: create-invalid-size
[517.026548] Subtest create-invalid-size: SUCCESS (0.000s)
[517.193240] [133/133] (515s left) kms_psr (psr-sprite-render)
[517.282250] Starting subtest: psr-sprite-render
[517.284504] Starting dynamic subtest: eDP-1
[518.999200] Dynamic subtest eDP-1: SUCCESS (1.718s)
[519.001478] Subtest psr-sprite-render: SUCCESS (1.719s)
[519.815433] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: gem_busy
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: i915_pm_freq_mult
results: parsing output: 4/ for test: prime_mmap
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_module_load
results: parsing output: 8/ for test: kms_pwrite_crc
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: kms_plane_multiple
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_atomic_transition
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_prop_blob
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_rotation_crc
results: parsing output: 23/ for test: syncobj_basic
results: parsing output: 24/ for test: kms_busy
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: gem_mmap_wc
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: core_debugfs
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: gem_partial_pwrite_pread
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: kms_plane_alpha_blend
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: prime_vgem
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_invalid_mode
results: parsing output: 41/ for test: i915_suspend
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: gem_exec_params
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_sync
results: parsing output: 47/ for test: kms_pm_rpm
results: parsing output: 48/ for test: gem_unref_active_buffers
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: gem_lmem_swapping
results: parsing output: 53/ for test: gem_exec_flush
results: parsing output: 54/ for test: gem_ctx_persistence
results: parsing output: 55/ for test: dmabuf_sync_file
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_exec_store
results: parsing output: 60/ for test: gem_exec_fence
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: i915_drm_fdinfo
results: parsing output: 64/ for test: kms_pm_dc
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_partial_pwrite_pread
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: gem_render_tiled_blits
results: parsing output: 72/ for test: prime_vgem
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_color
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: gem_create
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: sysfs_preempt_timeout
results: parsing output: 80/ for test: gem_userptr_blits
results: parsing output: 81/ for test: gem_exec_params
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: gem_mmap_offset
results: parsing output: 84/ for test: kms_dsc
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_lease
results: parsing output: 89/ for test: kms_chamelium_hpd
results: parsing output: 90/ for test: gem_exec_await
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_dp_linktrain_fallback
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_fenced_exec_thrash
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gen7_exec_parse
results: parsing output: 102/ for test: api_intel_allocator
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_content_protection
results: parsing output: 107/ for test: gem_create
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_sequence
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_busy
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: gem_softpin
results: parsing output: 117/ for test: kms_chamelium_edid
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_cdclk
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: gem_exec_fence
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_balancer
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_create
results: parsing output: 132/ for test: kms_psr
Done.