[59.093292] Initializing watchdogs
[59.093336]   /dev/watchdog0
[59.109182] [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]
[59.113835] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.116107] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.119692] [001/133] (960s left) perf (whitelisted-registers-userspace-config)
[59.267734] Starting subtest: whitelisted-registers-userspace-config
[59.269847] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[59.307601] [002/133] (960s left) gem_busy (busy)
[59.373468] Starting subtest: busy
[59.375860] Starting dynamic subtest: all-engines
[59.446201] Dynamic subtest all-engines: SUCCESS (0.073s)
[59.454457] Starting dynamic subtest: rcs0
[60.898515] Dynamic subtest rcs0: SUCCESS (1.449s)
[60.906220] Starting dynamic subtest: bcs0
[60.949973] Dynamic subtest bcs0: SUCCESS (0.052s)
[60.957443] Starting dynamic subtest: vcs0
[60.989870] Dynamic subtest vcs0: SUCCESS (0.039s)
[60.996976] Starting dynamic subtest: vcs1
[62.938043] Dynamic subtest vcs1: SUCCESS (1.944s)
[62.946665] Starting dynamic subtest: vecs0
[64.922112] Dynamic subtest vecs0: SUCCESS (1.982s)
[64.930159] Starting dynamic subtest: ccs0
[66.906282] Dynamic subtest ccs0: SUCCESS (1.983s)
[66.908914] Subtest busy: SUCCESS (7.525s)
[67.485382] [003/133] (952s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[67.634900] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[67.639013] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[67.721353] [004/133] (952s left) i915_pm_freq_mult (media-freq)
[67.806189] Starting subtest: media-freq
[67.809075] Starting dynamic subtest: gt0
[67.813971] Dynamic subtest gt0: SKIP (0.000s)
[67.823105] Starting dynamic subtest: gt1
[67.827276] Dynamic subtest gt1: SKIP (0.000s)
[67.831442] Subtest media-freq: SKIP (0.002s)
[67.971699] [005/133] (951s left) prime_mmap (test_map_unmap)
[68.139660] Starting subtest: test_map_unmap
[68.141979] Starting dynamic subtest: test_map_unmap-smem
[68.176384] Dynamic subtest test_map_unmap-smem: SUCCESS (0.036s)
[68.178751] Subtest test_map_unmap: SUCCESS (0.037s)
[68.266649] [006/133] (951s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[68.376802] Starting subtest: short-flip-after-cursor-toggle
[69.361051] Subtest short-flip-after-cursor-toggle: SUCCESS (0.983s)
[70.197718] [007/133] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[70.303820] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[77.992419] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.687s)
[78.104064] [008/133] (941s left) i915_module_load (resize-bar)
[78.146611] Starting subtest: resize-bar
[78.157176] Subtest resize-bar: SKIP (0.011s)
[78.198955] [009/133] (941s left) kms_pwrite_crc
[79.855330] [010/133] (940s left) gem_userptr_blits (coherency-unsync)
[79.916501] Subtest coherency-unsync: SKIP (0.000s)
[80.030997] [011/133] (940s left) gem_softpin (allocator-fork)
[80.093860] Starting subtest: allocator-fork
[82.304971] Subtest allocator-fork: SUCCESS (2.209s)
[82.420959] [012/133] (937s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[82.517827] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[82.522183] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[82.588964] [013/133] (937s left) kms_plane_multiple (tiling-yf)
[82.685380] Starting subtest: tiling-yf
[82.689588] Subtest tiling-yf: SKIP (0.000s)
[82.757242] [014/133] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[82.848458] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[82.852891] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[82.938140] [015/133] (937s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[83.033776] Starting subtest: plane-all-modeset-transition-fencing
[83.038290] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[83.103331] [016/133] (937s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[83.193067] Starting subtest: crc-primary-suspend-y-tiled-ccs
[83.195265] Starting dynamic subtest: pipe-A-eDP-1
[83.204063] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.211752] Starting dynamic subtest: pipe-B-eDP-1
[83.220189] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.227743] Starting dynamic subtest: pipe-C-eDP-1
[83.236074] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.243225] Starting dynamic subtest: pipe-D-eDP-1
[83.251487] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.255597] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.003s)
[85.431438] [017/133] (934s left) kms_prop_blob (blob-prop-core)
[85.499900] Starting subtest: blob-prop-core
[85.502363] Subtest blob-prop-core: SUCCESS (0.000s)
[85.604700] [018/133] (934s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[85.705674] Starting subtest: fbc-farfromfence-mmap-gtt
[85.710248] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[85.812098] [019/133] (934s left) gem_mmap_gtt (basic-write-read)
[85.862763] Subtest basic-write-read: SKIP (0.000s)
[85.930291] [020/133] (934s left) syncobj_wait (wait-for-submit-delayed-submit)
[85.983581] Starting subtest: wait-for-submit-delayed-submit
[86.088040] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[86.162856] [021/133] (934s left) syncobj_timeline (multi-wait-available-signaled)
[86.221776] Starting subtest: multi-wait-available-signaled
[86.224117] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[86.305997] [022/133] (934s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[86.406661] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[86.408733] Starting dynamic subtest: pipe-A-eDP-1
[88.597659] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.192s)
[88.605988] Starting dynamic subtest: pipe-B-eDP-1
[90.972129] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.372s)
[90.983948] Starting dynamic subtest: pipe-C-eDP-1
[93.071763] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.100s)
[93.078599] Starting dynamic subtest: pipe-D-eDP-1
[95.189836] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.115s)
[95.191880] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.783s)
[96.367643] [023/133] (924s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[96.484360] Starting subtest: primary-yf-tiled-reflect-x-90
[96.488469] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[96.553519] [024/133] (924s left) syncobj_basic (bad-flags-handle-to-fd)
[96.610510] Starting subtest: bad-flags-handle-to-fd
[96.612826] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[96.719296] [025/133] (923s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[96.832109] Starting subtest: extended-modeset-hang-newfb-with-reset
[96.834299] Starting dynamic subtest: pipe-A
[112.095052] Dynamic subtest pipe-A: SUCCESS (15.262s)
[112.103818] Starting dynamic subtest: pipe-D
[127.642436] Dynamic subtest pipe-D: SUCCESS (15.542s)
[127.644432] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.808s)
[128.446142] [026/133] (892s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[128.543883] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[128.546167] Starting dynamic subtest: pipe-A
[129.603803] Dynamic subtest pipe-A: SUCCESS (1.061s)
[129.618365] Starting dynamic subtest: pipe-B
[131.773825] Dynamic subtest pipe-B: SUCCESS (2.167s)
[131.787803] Starting dynamic subtest: pipe-C
[132.957594] Dynamic subtest pipe-C: SUCCESS (1.182s)
[132.967963] Starting dynamic subtest: pipe-D
[134.109437] Dynamic subtest pipe-D: SUCCESS (1.151s)
[134.111759] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.567s)
[135.312019] [027/133] (885s left) kms_cursor_crc (cursor-random-max-size)
[135.644928] Starting subtest: cursor-random-max-size
[135.651413] Subtest cursor-random-max-size: SKIP (0.000s)
[135.749598] [028/133] (884s left) gem_exec_schedule (noreorder)
[135.930531] Starting subtest: noreorder
[135.932794] Starting dynamic subtest: rcs0
[135.982591] Dynamic subtest rcs0: SUCCESS (0.052s)
[135.991414] Starting dynamic subtest: vcs0
[137.877057] Dynamic subtest vcs0: SUCCESS (1.891s)
[137.885698] Starting dynamic subtest: vcs1
[139.928258] Dynamic subtest vcs1: SUCCESS (2.049s)
[139.943427] Starting dynamic subtest: vecs0
[141.911317] Dynamic subtest vecs0: SUCCESS (1.980s)
[141.922130] Starting dynamic subtest: ccs0
[141.977206] Dynamic subtest ccs0: SUCCESS (0.066s)
[141.979558] Subtest noreorder: SUCCESS (6.048s)
[142.161322] [029/133] (878s left) gem_ctx_persistence (engines-persistence)
[142.214141] Starting subtest: engines-persistence
[142.216442] Starting dynamic subtest: rcs0
[143.001822] Dynamic subtest rcs0: SUCCESS (0.787s)
[143.011699] Starting dynamic subtest: bcs0
[143.742815] Dynamic subtest bcs0: SUCCESS (0.739s)
[143.752023] Starting dynamic subtest: vcs0
[144.596027] Dynamic subtest vcs0: SUCCESS (0.851s)
[144.609827] Starting dynamic subtest: vcs1
[145.359624] Dynamic subtest vcs1: SUCCESS (0.762s)
[145.369866] Starting dynamic subtest: vecs0
[146.125785] Dynamic subtest vecs0: SUCCESS (0.764s)
[146.136242] Starting dynamic subtest: ccs0
[146.876963] Dynamic subtest ccs0: SUCCESS (0.749s)
[146.879510] Subtest engines-persistence: SUCCESS (4.663s)
[146.995275] [030/133] (873s left) gem_mmap_wc (pf-nonblock)
[147.051111] Subtest pf-nonblock: SKIP (0.000s)
[147.107326] [031/133] (873s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[147.205708] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[147.209666] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[147.276403] [032/133] (873s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[147.324750] Starting subtest: invalid-single-wait-all-unsubmitted
[147.327060] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[147.418966] [033/133] (873s left) core_debugfs (read-all-entries)
[147.479132] Starting subtest: read-all-entries
[147.572657] Subtest read-all-entries: SUCCESS (0.094s)
[147.648838] [034/133] (873s left) gem_render_copy (yf-tiled)
[147.709235] Starting subtest: yf-tiled
[147.713414] Subtest yf-tiled: SKIP (0.000s)
[147.896439] [035/133] (873s left) gem_partial_pwrite_pread (reads-uncached)
[147.951956] Subtest reads-uncached: SKIP (0.000s)
[148.007745] [036/133] (873s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[148.101822] Starting subtest: plane-scaler-unity-scaling-with-rotation
[148.104149] Starting dynamic subtest: pipe-A
[148.339977] Dynamic subtest pipe-A: SUCCESS (0.240s)
[148.348816] Starting dynamic subtest: pipe-B
[149.615051] Dynamic subtest pipe-B: SUCCESS (1.274s)
[149.623939] Starting dynamic subtest: pipe-C
[150.943318] Dynamic subtest pipe-C: SUCCESS (1.327s)
[150.952308] Starting dynamic subtest: pipe-D
[152.275653] Dynamic subtest pipe-D: SUCCESS (1.332s)
[152.278030] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.176s)
[153.455267] [037/133] (867s left) kms_plane_alpha_blend (alpha-7efc)
[153.546947] Starting subtest: alpha-7efc
[153.837126] Starting dynamic subtest: pipe-A-eDP-1
[154.462799] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s)
[154.491246] Starting dynamic subtest: pipe-D-eDP-1
[155.764227] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.279s)
[155.766676] Subtest alpha-7efc: SUCCESS (2.218s)
[156.610907] [038/133] (864s left) kms_psr (pr-sprite-plane-onoff)
[156.704224] Starting subtest: pr-sprite-plane-onoff
[156.708805] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[156.775273] [039/133] (864s left) prime_vgem (basic-gtt)
[156.904921] Starting subtest: basic-gtt
[156.909634] Subtest basic-gtt: SKIP (0.000s)
[156.998537] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[157.002180] [040/133] (864s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[157.107827] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[157.111657] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[157.223491] [041/133] (864s left) kms_invalid_mode (zero-hdisplay)
[157.332067] Starting subtest: zero-hdisplay
[157.334204] Starting dynamic subtest: pipe-A-eDP-1
[157.636842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.304s)
[157.644910] Starting dynamic subtest: pipe-B-eDP-1
[157.647049] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[157.654524] Starting dynamic subtest: pipe-C-eDP-1
[157.656666] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[157.664175] Starting dynamic subtest: pipe-D-eDP-1
[157.666086] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[157.667904] Subtest zero-hdisplay: SUCCESS (0.310s)
[158.451992] [042/133] (862s left) i915_suspend (basic-s2idle-without-i915)
[158.493883] Starting subtest: basic-s2idle-without-i915
[179.303897] Subtest basic-s2idle-without-i915: SUCCESS (6.080s)
[185.441420] [043/133] (841s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[185.563671] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[185.565846] Starting dynamic subtest: pipe-A-eDP-1
[185.587485] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[185.596491] Starting dynamic subtest: pipe-B-eDP-1
[185.617230] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[185.624742] Starting dynamic subtest: pipe-C-eDP-1
[185.644776] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[185.652358] Starting dynamic subtest: pipe-D-eDP-1
[185.673327] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[185.677257] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[187.865576] [044/133] (839s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[187.928933] Starting subtest: invalid-bsd2-flag-on-vebox
[187.931329] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[188.032323] [045/133] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[188.139687] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[188.144104] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[188.234050] [046/133] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[188.331194] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[188.335366] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[188.427058] [047/133] (839s left) gem_sync (basic-store-all)
[188.497058] Starting subtest: basic-store-all
[191.497431] Subtest basic-store-all: SUCCESS (2.998s)
[191.684520] [048/133] (835s left) kms_pm_rpm (pm-caching)
[193.760937] Starting subtest: pm-caching
[193.766017] Subtest pm-caching: SKIP (0.000s)
[194.152910] [049/133] (833s left) gem_unref_active_buffers
[194.354138] [050/133] (833s left) kms_psr (fbc-pr-primary-mmap-gtt)
[194.438151] Starting subtest: fbc-pr-primary-mmap-gtt
[194.442749] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[194.514306] [051/133] (833s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[194.579685] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[194.681998] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[194.760170] [052/133] (832s left) gem_exec_reloc (basic-wc-noreloc)
[194.826712] Subtest basic-wc-noreloc: SKIP (0.000s)
[194.899578] [053/133] (832s left) gem_lmem_swapping (random-engines)
[194.937787] Subtest random-engines: SKIP (0.000s)
[194.980563] [054/133] (832s left) gem_exec_flush (basic-wb-ro-before-default)
[195.037629] Starting subtest: basic-wb-ro-before-default
[200.513046] Subtest basic-wb-ro-before-default: SUCCESS (5.465s)
[200.695017] [055/133] (827s left) gem_ctx_persistence (heartbeat-hostile)
[200.763236] Starting subtest: heartbeat-hostile
[200.767958] Subtest heartbeat-hostile: SKIP (0.000s)
[200.859243] [056/133] (827s left) dmabuf_sync_file (import-basic)
[200.903880] Starting subtest: import-basic
[200.906079] Subtest import-basic: SUCCESS (0.002s)
[200.960781] [057/133] (826s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[201.066576] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[201.070715] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[201.172393] [058/133] (826s left) syncobj_wait (single-wait-all-submitted)
[201.232726] Starting subtest: single-wait-all-submitted
[201.338692] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[201.430744] [059/133] (826s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[201.512534] Starting subtest: fbc-psr2-sprite-mmap-gtt
[201.514811] Starting dynamic subtest: eDP-1
[201.519076] Dynamic subtest eDP-1: SKIP (0.000s)
[201.523324] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[201.584608] [060/133] (826s left) gem_exec_store (dword)
[201.637751] Starting subtest: dword
[201.640044] Starting dynamic subtest: rcs0
[201.703703] Dynamic subtest rcs0: SUCCESS (0.066s)
[201.715561] Starting dynamic subtest: bcs0
[201.746279] Dynamic subtest bcs0: SUCCESS (0.041s)
[201.757506] Starting dynamic subtest: vcs0
[201.788240] Dynamic subtest vcs0: SUCCESS (0.040s)
[201.797997] Starting dynamic subtest: vcs1
[201.834589] Dynamic subtest vcs1: SUCCESS (0.045s)
[201.845716] Starting dynamic subtest: vecs0
[201.879082] Dynamic subtest vecs0: SUCCESS (0.042s)
[201.888604] Starting dynamic subtest: ccs0
[201.921308] Dynamic subtest ccs0: SUCCESS (0.040s)
[201.923717] Subtest dword: SUCCESS (0.285s)
[202.106386] [061/133] (825s left) gem_exec_fence (concurrent)
[202.295235] Starting subtest: concurrent
[202.300118] Subtest concurrent: SKIP (0.000s)
[203.687192] [062/133] (824s left) perf_pmu (busy-accuracy-50)
[203.729528] Starting subtest: busy-accuracy-50
[203.731776] Starting dynamic subtest: rcs0
[205.271164] Dynamic subtest rcs0: SUCCESS (1.537s)
[205.281924] Starting dynamic subtest: bcs0
[206.824295] Dynamic subtest bcs0: SUCCESS (1.549s)
[206.836570] Starting dynamic subtest: vcs0
[208.366210] Dynamic subtest vcs0: SUCCESS (1.540s)
[208.377219] Starting dynamic subtest: vcs1
[209.914398] Dynamic subtest vcs1: SUCCESS (1.545s)
[209.923332] Starting dynamic subtest: vecs0
[211.455183] Dynamic subtest vecs0: SUCCESS (1.537s)
[211.465840] Starting dynamic subtest: ccs0
[213.005364] Dynamic subtest ccs0: SUCCESS (1.547s)
[213.007485] Subtest busy-accuracy-50: SUCCESS (9.267s)
[213.120947] [063/133] (815s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[213.236313] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[213.240269] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[213.335630] [064/133] (814s left) i915_drm_fdinfo (busy-check-all)
[213.379868] Starting subtest: busy-check-all
[213.382113] Starting dynamic subtest: rcs0
[213.389529] Dynamic subtest rcs0: SKIP (0.007s)
[213.400192] Starting dynamic subtest: bcs0
[213.404122] Dynamic subtest bcs0: SKIP (0.001s)
[213.412670] Starting dynamic subtest: vcs0
[213.416987] Dynamic subtest vcs0: SKIP (0.000s)
[213.427392] Starting dynamic subtest: vcs1
[213.431348] Dynamic subtest vcs1: SKIP (0.000s)
[213.439619] Starting dynamic subtest: vecs0
[213.443560] Dynamic subtest vecs0: SKIP (0.000s)
[213.451834] Starting dynamic subtest: ccs0
[213.455855] Dynamic subtest ccs0: SKIP (0.000s)
[213.459831] Subtest busy-check-all: SKIP (0.015s)
[213.498569] [065/133] (814s left) kms_pm_dc (dc5-dpms)
[214.629560] Starting subtest: dc5-dpms
[216.735355] Subtest dc5-dpms: SUCCESS (2.104s)
[216.813091] [066/133] (811s left) gem_exec_reloc (basic-cpu-read-active)
[216.867720] Subtest basic-cpu-read-active: SKIP (0.000s)
[216.937297] [067/133] (811s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[217.061108] Starting subtest: short-flip-after-cursor-atomic-transitions
[218.058510] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.997s)
[218.914471] [068/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[219.007793] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[219.012039] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[219.102081] [069/133] (809s left) gem_partial_pwrite_pread (writes-after-reads)
[219.164427] Subtest writes-after-reads: SKIP (0.000s)
[219.238066] [070/133] (809s left) gem_eio (in-flight-1us)
[219.454552] Starting subtest: in-flight-1us
[227.154228] Subtest in-flight-1us: SUCCESS (7.694s)
[227.282471] [071/133] (801s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[227.332358] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[227.433620] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[227.524108] [072/133] (800s left) gem_render_tiled_blits (basic)
[227.589482] Subtest basic: SKIP (0.000s)
[227.648827] [073/133] (800s left) prime_vgem (wait)
[227.731078] Starting subtest: wait
[227.733368] Starting dynamic subtest: rcs0
[227.772532] Dynamic subtest rcs0: SUCCESS (0.042s)
[227.781809] Starting dynamic subtest: bcs0
[227.839442] Dynamic subtest bcs0: SUCCESS (0.066s)
[227.848528] Starting dynamic subtest: vcs0
[227.885353] Dynamic subtest vcs0: SUCCESS (0.045s)
[227.894725] Starting dynamic subtest: vcs1
[227.932284] Dynamic subtest vcs1: SUCCESS (0.045s)
[227.941644] Starting dynamic subtest: vecs0
[227.976818] Dynamic subtest vecs0: SUCCESS (0.044s)
[227.985932] Starting dynamic subtest: ccs0
[228.022559] Dynamic subtest ccs0: SUCCESS (0.045s)
[228.024869] Subtest wait: SUCCESS (0.292s)
[228.152634] [074/133] (800s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[228.258833] Starting subtest: fbc-tiling-linear
[231.949163] Subtest fbc-tiling-linear: SUCCESS (3.691s)
[233.133316] [075/133] (795s left) kms_color (ctm-0-50)
[233.242628] Starting subtest: ctm-0-50
[233.245271] Starting dynamic subtest: pipe-A-eDP-1
[236.745373] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.503s)
[236.755022] Starting dynamic subtest: pipe-B-eDP-1
[241.061055] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.314s)
[241.070582] Starting dynamic subtest: pipe-C-eDP-1
[245.103708] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.038s)
[245.113313] Starting dynamic subtest: pipe-D-eDP-1
[249.080406] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.974s)
[249.082911] Subtest ctm-0-50: SUCCESS (15.833s)
[249.910850] [076/133] (778s left) kms_vblank (ts-continuation-modeset-rpm)
[250.018805] Starting subtest: ts-continuation-modeset-rpm
[250.020696] Starting dynamic subtest: pipe-A-eDP-1
[252.613304] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.591s)
[252.628637] Starting dynamic subtest: pipe-D-eDP-1
[254.869366] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.255s)
[254.871740] Subtest ts-continuation-modeset-rpm: SUCCESS (4.850s)
[255.683404] [077/133] (773s left) gem_create (create-valid-nonaligned)
[255.742670] Starting subtest: create-valid-nonaligned
[255.744964] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[255.928099] [078/133] (772s left) gem_exec_reloc (basic-cpu-gtt)
[255.989527] Subtest basic-cpu-gtt: SKIP (0.000s)
[256.071394] [079/133] (772s left) gem_exec_reloc (basic-write-cpu)
[256.133088] Subtest basic-write-cpu: SKIP (0.000s)
[256.195921] [080/133] (772s left) sysfs_preempt_timeout (invalid)
[256.251331] Starting subtest: invalid
[256.253632] Starting dynamic subtest: vecs0
[256.255972] Dynamic subtest vecs0: SUCCESS (0.000s)
[256.266218] Starting dynamic subtest: ccs0
[256.268034] Dynamic subtest ccs0: SUCCESS (0.000s)
[256.276702] Starting dynamic subtest: vcs0
[256.278492] Dynamic subtest vcs0: SUCCESS (0.000s)
[256.287177] Starting dynamic subtest: bcs0
[256.289037] Dynamic subtest bcs0: SUCCESS (0.000s)
[256.297715] Starting dynamic subtest: rcs0
[256.299760] Dynamic subtest rcs0: SUCCESS (0.000s)
[256.308653] Starting dynamic subtest: vcs1
[256.310742] Dynamic subtest vcs1: SUCCESS (0.000s)
[256.312845] Subtest invalid: SUCCESS (0.006s)
[256.376544] [081/133] (772s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[256.445004] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[256.567326] [082/133] (772s left) gem_exec_params (invalid-batch-start-offset)
[256.630379] Starting subtest: invalid-batch-start-offset
[256.636195] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[256.760116] [083/133] (772s left) perf_pmu (rc6)
[256.801333] Starting subtest: rc6
[256.803348] Starting dynamic subtest: gt0
[263.169981] Dynamic subtest gt0: SUCCESS (6.365s)
[263.182607] Starting dynamic subtest: runtime-pm-gt0
[270.887430] Dynamic subtest runtime-pm-gt0: SUCCESS (7.711s)
[270.899948] Starting dynamic subtest: runtime-pm-long-gt0
[283.333747] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.443s)
[283.345820] Starting dynamic subtest: other-idle-gt0
[289.676559] Dynamic subtest other-idle-gt0: SUCCESS (6.345s)
[289.688261] Starting dynamic subtest: gt1
[296.018544] Dynamic subtest gt1: SUCCESS (6.343s)
[296.031552] Starting dynamic subtest: runtime-pm-gt1
[303.515298] Dynamic subtest runtime-pm-gt1: SUCCESS (7.496s)
[303.528161] Starting dynamic subtest: runtime-pm-long-gt1
[316.033000] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.518s)
[316.045254] Starting dynamic subtest: other-idle-gt1
[322.376336] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[322.379360] Subtest rc6: SUCCESS (65.581s)
[323.519830] [084/133] (705s left) gem_mmap_offset (partial-unmap)
[323.587608] Starting subtest: partial-unmap
[323.589702] Starting dynamic subtest: smem0
[324.097559] Dynamic subtest smem0: SUCCESS (0.509s)
[324.100546] Subtest partial-unmap: SUCCESS (0.510s)
[324.189116] [085/133] (704s left) kms_dsc (dsc-basic)
[324.284895] Starting subtest: dsc-basic
[324.297940] Subtest dsc-basic: SKIP (0.001s)
[324.338527] [086/133] (704s left) perf_pmu (multi-client)
[324.377220] Starting subtest: multi-client
[324.379466] Starting dynamic subtest: rcs0
[325.429551] Dynamic subtest rcs0: SUCCESS (1.052s)
[325.441731] Starting dynamic subtest: bcs0
[326.480729] Dynamic subtest bcs0: SUCCESS (1.047s)
[326.492250] Starting dynamic subtest: vcs0
[327.533384] Dynamic subtest vcs0: SUCCESS (1.050s)
[327.546197] Starting dynamic subtest: vcs1
[328.662931] Dynamic subtest vcs1: SUCCESS (1.126s)
[328.673506] Starting dynamic subtest: vecs0
[330.648110] Dynamic subtest vecs0: SUCCESS (1.982s)
[330.660502] Starting dynamic subtest: ccs0
[332.631884] Dynamic subtest ccs0: SUCCESS (1.981s)
[332.634770] Subtest multi-client: SUCCESS (8.255s)
[332.726977] [087/133] (696s left) gem_exec_schedule (u-semaphore-user)
[332.804525] Starting subtest: u-semaphore-user
[332.857997] Subtest u-semaphore-user: SUCCESS (0.061s)
[334.646017] [088/133] (694s left) gem_eio (banned)
[334.851537] Starting subtest: banned
[335.398711] Subtest banned: SUCCESS (0.547s)
[335.538587] [089/133] (693s left) kms_lease (lease-revoke)
[335.639033] Starting subtest: lease-revoke
[335.640831] Starting dynamic subtest: pipe-A-eDP-1
[335.670397] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[335.682254] Starting dynamic subtest: pipe-B-eDP-1
[335.700365] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[335.710606] Starting dynamic subtest: pipe-C-eDP-1
[335.727694] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[335.737092] Starting dynamic subtest: pipe-D-eDP-1
[335.753249] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[335.755301] Subtest lease-revoke: SUCCESS (0.117s)
[335.851481] [090/133] (693s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[336.231227] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[337.048943] [091/133] (692s left) gem_exec_await (wide-contexts)
[337.241776] Starting subtest: wide-contexts
[360.577956] Subtest wide-contexts: SUCCESS (23.332s)
[360.756091] [092/133] (668s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[360.898129] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[360.977626] [093/133] (668s left) kms_dp_linktrain_fallback (dsc-fallback)
[361.071850] Starting subtest: dsc-fallback
[361.078430] Subtest dsc-fallback: SKIP (0.000s)
[361.121153] [094/133] (668s left) gem_lmem_swapping (parallel-random)
[361.172841] Subtest parallel-random: SKIP (0.000s)
[361.221369] [095/133] (668s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[361.317749] Starting subtest: y-tiled-64bpp-rotate-270
[361.322157] Subtest y-tiled-64bpp-rotate-270: SKIP (0.001s)
[361.383495] [096/133] (668s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[361.496290] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[361.500599] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[361.580881] [097/133] (668s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[361.676130] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[368.781130] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.108s)
[368.865112] [098/133] (660s left) gem_fenced_exec_thrash (too-many-fences)
[368.923790] Subtest too-many-fences: SKIP (0.000s)
[369.002777] [099/133] (660s left) kms_big_fb (linear-16bpp-rotate-0)
[369.099591] Starting subtest: linear-16bpp-rotate-0
[370.479535] Subtest linear-16bpp-rotate-0: SUCCESS (1.379s)
[370.569478] [100/133] (659s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[370.625545] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[370.731160] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[370.785920] [101/133] (658s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[370.883430] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[370.887813] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[370.943668] [102/133] (658s left) gen7_exec_parse (basic-rejected)
[371.001999] Subtest basic-rejected: SKIP (0.000s)
[371.075868] [103/133] (658s left) api_intel_allocator (reserve-simple)
[371.127652] Starting subtest: reserve-simple
[371.129970] Subtest reserve-simple: SUCCESS (0.003s)
[371.229832] [104/133] (658s left) gem_eio (create)
[371.476263] Starting subtest: create
[371.845671] Subtest create: SUCCESS (0.371s)
[371.939331] [105/133] (657s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[371.994195] Starting subtest: y-tiled-ccs-to-yf-tiled
[371.997843] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[372.153855] [106/133] (657s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[372.266669] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[372.271039] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[372.344449] [107/133] (657s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[372.480233] Starting subtest: dp-mst-lic-type-0-hdcp14
[372.484861] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[372.574186] [108/133] (657s left) gem_create (create-ext-placement-all)
[372.741406] Starting subtest: create-ext-placement-all
[372.743461] Subtest create-ext-placement-all: SUCCESS (0.000s)
[372.814727] [109/133] (657s left) kms_cursor_crc (cursor-dpms)
[372.956489] Starting subtest: cursor-dpms
[372.958364] Starting dynamic subtest: pipe-A-eDP-1
[376.022730] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.065s)
[376.033031] Starting dynamic subtest: pipe-D-eDP-1
[379.593446] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.570s)
[379.595848] Subtest cursor-dpms: SUCCESS (6.638s)
[380.421813] [110/133] (649s left) syncobj_timeline (wait-all-complex)
[380.480449] Starting subtest: wait-all-complex
[380.696368] Subtest wait-all-complex: SUCCESS (0.217s)
[380.748862] [111/133] (649s left) kms_sequence (get-busy)
[380.835866] Starting subtest: get-busy
[380.838236] Starting dynamic subtest: pipe-A-eDP-1
[382.770825] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[382.782047] Starting dynamic subtest: pipe-B-eDP-1
[385.347849] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.577s)
[385.359117] Starting dynamic subtest: pipe-C-eDP-1
[387.955643] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.606s)
[387.966448] Starting dynamic subtest: pipe-D-eDP-1
[390.500332] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[390.502738] Subtest get-busy: SUCCESS (9.665s)
[391.286074] [112/133] (638s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[391.388368] Starting subtest: fbcpsr-rgb101010-draw-render
[398.139356] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.752s)
[398.247463] [113/133] (632s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[398.355760] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[399.047441] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[399.176240] [114/133] (631s left) gem_busy (close-race)
[399.233280] Starting subtest: close-race
[422.622148] Subtest close-race: SUCCESS (23.389s)
[422.961722] [115/133] (607s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[423.118162] Starting subtest: fbc-rgb565-draw-mmap-gtt
[423.122242] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[423.204182] [116/133] (607s left) kms_cursor_crc (cursor-sliding-64x64)
[423.391731] Starting subtest: cursor-sliding-64x64
[423.396989] Starting dynamic subtest: pipe-A-eDP-1
[426.657180] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.263s)
[426.687258] Starting dynamic subtest: pipe-D-eDP-1
[430.503476] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.824s)
[430.505837] Subtest cursor-sliding-64x64: SUCCESS (7.113s)
[431.367710] [117/133] (599s left) gem_softpin (evict-active)
[431.427476] Starting subtest: evict-active
[431.433040] Subtest evict-active: SUCCESS (0.004s)
[431.516220] [118/133] (598s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[431.906004] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[432.697052] [119/133] (597s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[432.788725] Starting subtest: psr-rgb101010-draw-pwrite
[440.529097] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.745s)
[440.611775] [120/133] (589s left) kms_cdclk (mode-transition-all-outputs)
[440.714021] Starting subtest: mode-transition-all-outputs
[441.008034] Subtest mode-transition-all-outputs: SKIP (0.292s)
[441.784194] [121/133] (588s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[441.887437] Starting subtest: fbc-pr-sprite-mmap-cpu
[441.891826] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[441.940086] [122/133] (588s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[442.047363] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[442.051567] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[442.096650] [123/133] (588s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[442.201133] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[443.225197] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.024s)
[443.327932] [124/133] (587s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[443.416720] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[443.418947] Starting dynamic subtest: pipe-A-eDP-1
[443.474604] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[443.486025] Starting dynamic subtest: pipe-B-eDP-1
[443.532527] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[443.545587] Starting dynamic subtest: pipe-C-eDP-1
[443.593736] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[443.604499] Starting dynamic subtest: pipe-D-eDP-1
[443.651629] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[443.655593] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[445.558711] [125/133] (585s left) gem_exec_fence (syncobj-import)
[446.029002] Starting subtest: syncobj-import
[446.037193] Subtest syncobj-import: SUCCESS (0.010s)
[447.700853] [126/133] (583s left) kms_psr (psr2-sprite-plane-move)
[447.803483] Starting subtest: psr2-sprite-plane-move
[447.805617] Starting dynamic subtest: eDP-1
[449.593491] Dynamic subtest eDP-1: SUCCESS (1.788s)
[449.595726] Subtest psr2-sprite-plane-move: SUCCESS (1.789s)
[450.420186] [127/133] (580s left) kms_atomic_transition (modeset-transition-fencing)
[450.515164] Starting subtest: modeset-transition-fencing
[450.517498] Starting dynamic subtest: 1x-outputs
[461.328879] Dynamic subtest 1x-outputs: SUCCESS (10.815s)
[461.331975] Subtest modeset-transition-fencing: SUCCESS (10.817s)
[462.172011] [128/133] (568s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[462.265277] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[469.245107] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.982s)
[469.354297] [129/133] (561s left) gem_exec_balancer (busy)
[469.417960] Starting subtest: busy
[470.615704] Subtest busy: SUCCESS (1.197s)
[470.921273] [130/133] (560s left) kms_flip (flip-vs-blocking-wf-vblank)
[471.032281] Starting subtest: flip-vs-blocking-wf-vblank
[471.034410] Starting dynamic subtest: A-eDP1
[479.972208] Dynamic subtest A-eDP1: SUCCESS (8.941s)
[479.988940] Starting dynamic subtest: B-eDP1
[488.895043] Dynamic subtest B-eDP1: SUCCESS (8.920s)
[488.904883] Starting dynamic subtest: C-eDP1
[497.821399] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[497.832237] Starting dynamic subtest: D-eDP1
[506.752605] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[506.758001] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.726s)
[507.952968] [131/133] (523s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[508.045163] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[512.501854] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.460s)
[513.656849] [132/133] (517s left) gem_create (create-invalid-size)
[513.715591] Starting subtest: create-invalid-size
[513.717837] Subtest create-invalid-size: SUCCESS (0.000s)
[513.882065] [133/133] (517s left) kms_psr (psr-sprite-render)
[513.973324] Starting subtest: psr-sprite-render
[513.975560] Starting dynamic subtest: eDP-1
[515.695626] Dynamic subtest eDP-1: SUCCESS (1.723s)
[515.698034] Subtest psr-sprite-render: SUCCESS (1.724s)
[516.512828] 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.