[59.212473] Initializing watchdogs
[59.212524]   /dev/watchdog0
[59.227412] [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.232170] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.234617] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.237280] [001/133] (960s left) perf (whitelisted-registers-userspace-config)
[59.372292] Starting subtest: whitelisted-registers-userspace-config
[59.373249] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[59.405086] [002/133] (960s left) gem_busy (busy)
[59.467343] Starting subtest: busy
[59.468401] Starting dynamic subtest: all-engines
[59.543131] Dynamic subtest all-engines: SUCCESS (0.076s)
[59.551622] Starting dynamic subtest: rcs0
[60.898540] Dynamic subtest rcs0: SUCCESS (1.353s)
[60.906742] Starting dynamic subtest: bcs0
[60.955023] Dynamic subtest bcs0: SUCCESS (0.057s)
[60.962616] Starting dynamic subtest: vcs0
[60.993680] Dynamic subtest vcs0: SUCCESS (0.037s)
[60.999059] Starting dynamic subtest: vcs1
[62.946921] Dynamic subtest vcs1: SUCCESS (1.943s)
[62.955072] Starting dynamic subtest: vecs0
[64.931217] Dynamic subtest vecs0: SUCCESS (1.983s)
[64.939430] Starting dynamic subtest: ccs0
[66.915772] Dynamic subtest ccs0: SUCCESS (1.985s)
[66.916729] Subtest busy: SUCCESS (7.440s)
[67.436568] [003/133] (952s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[67.614199] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[67.616092] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[67.776339] [004/133] (952s left) i915_pm_freq_mult (media-freq)
[67.862440] Starting subtest: media-freq
[67.863479] Starting dynamic subtest: gt0
[67.865474] Dynamic subtest gt0: SKIP (0.000s)
[67.871678] Starting dynamic subtest: gt1
[67.873407] Dynamic subtest gt1: SKIP (0.000s)
[67.875078] Subtest media-freq: SKIP (0.001s)
[67.986106] [005/133] (951s left) prime_mmap (test_map_unmap)
[68.092683] Starting subtest: test_map_unmap
[68.093743] Starting dynamic subtest: test_map_unmap-smem
[68.129623] Dynamic subtest test_map_unmap-smem: SUCCESS (0.036s)
[68.131364] Subtest test_map_unmap: SUCCESS (0.037s)
[68.211144] [006/133] (951s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[68.336909] Starting subtest: short-flip-after-cursor-toggle
[69.292016] Subtest short-flip-after-cursor-toggle: SUCCESS (0.955s)
[70.088471] [007/133] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[70.194790] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[78.065740] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.872s)
[78.168210] [008/133] (941s left) i915_module_load (resize-bar)
[78.201374] Starting subtest: resize-bar
[78.209065] Subtest resize-bar: SKIP (0.007s)
[78.244769] [009/133] (941s left) kms_pwrite_crc
[79.896186] [010/133] (940s left) gem_userptr_blits (coherency-unsync)
[79.956673] Subtest coherency-unsync: SKIP (0.000s)
[80.080359] [011/133] (940s left) gem_softpin (allocator-fork)
[80.140776] Starting subtest: allocator-fork
[82.402191] Subtest allocator-fork: SUCCESS (2.222s)
[82.492557] [012/133] (937s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[82.592085] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[82.594034] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[82.665596] [013/133] (937s left) kms_plane_multiple (tiling-yf)
[82.755923] Starting subtest: tiling-yf
[82.757967] Subtest tiling-yf: SKIP (0.000s)
[82.826786] [014/133] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[82.914254] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[82.915926] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[83.005954] [015/133] (937s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[83.086079] Starting subtest: plane-all-modeset-transition-fencing
[83.088114] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[83.153187] [016/133] (937s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[83.246133] Starting subtest: crc-primary-suspend-y-tiled-ccs
[83.247080] Starting dynamic subtest: pipe-A-eDP-1
[83.250360] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.257014] Starting dynamic subtest: pipe-B-eDP-1
[83.260524] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.268414] Starting dynamic subtest: pipe-C-eDP-1
[83.271815] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.278325] Starting dynamic subtest: pipe-D-eDP-1
[83.282061] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.283738] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.008s)
[85.471071] [017/133] (934s left) kms_prop_blob (blob-prop-core)
[85.523031] Starting subtest: blob-prop-core
[85.523999] Subtest blob-prop-core: SUCCESS (0.000s)
[85.613820] [018/133] (934s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[85.706932] Starting subtest: fbc-farfromfence-mmap-gtt
[85.708755] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[85.816680] [019/133] (934s left) gem_mmap_gtt (basic-write-read)
[85.863834] Subtest basic-write-read: SKIP (0.000s)
[85.924544] [020/133] (934s left) syncobj_wait (wait-for-submit-delayed-submit)
[85.975971] Starting subtest: wait-for-submit-delayed-submit
[86.080810] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[86.149740] [021/133] (934s left) syncobj_timeline (multi-wait-available-signaled)
[86.208626] Starting subtest: multi-wait-available-signaled
[86.209823] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[86.300959] [022/133] (934s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[86.384877] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[86.385974] Starting dynamic subtest: pipe-A-eDP-1
[88.578072] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.193s)
[88.585398] Starting dynamic subtest: pipe-B-eDP-1
[90.970163] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.391s)
[90.977163] Starting dynamic subtest: pipe-C-eDP-1
[93.166937] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.196s)
[93.174682] Starting dynamic subtest: pipe-D-eDP-1
[95.242721] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.075s)
[95.243671] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.858s)
[96.402532] [023/133] (924s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[96.494987] Starting subtest: primary-yf-tiled-reflect-x-90
[96.496668] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[96.564529] [024/133] (923s left) syncobj_basic (bad-flags-handle-to-fd)
[96.615995] Starting subtest: bad-flags-handle-to-fd
[96.616906] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[96.695949] [025/133] (923s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[96.817809] Starting subtest: extended-modeset-hang-newfb-with-reset
[96.818852] Starting dynamic subtest: pipe-A
[112.095274] Dynamic subtest pipe-A: SUCCESS (15.277s)
[112.102734] Starting dynamic subtest: pipe-D
[127.655827] Dynamic subtest pipe-D: SUCCESS (15.558s)
[127.656747] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.840s)
[128.446314] [026/133] (892s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[128.538350] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[128.539418] Starting dynamic subtest: pipe-A
[129.587883] Dynamic subtest pipe-A: SUCCESS (1.050s)
[129.594560] Starting dynamic subtest: pipe-B
[131.664934] Dynamic subtest pipe-B: SUCCESS (2.076s)
[131.672161] Starting dynamic subtest: pipe-C
[132.855818] Dynamic subtest pipe-C: SUCCESS (1.190s)
[132.863789] Starting dynamic subtest: pipe-D
[134.002631] Dynamic subtest pipe-D: SUCCESS (1.146s)
[134.003438] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.466s)
[135.188821] [027/133] (885s left) kms_cursor_crc (cursor-random-max-size)
[135.508122] Starting subtest: cursor-random-max-size
[135.510801] Subtest cursor-random-max-size: SKIP (0.000s)
[135.629330] [028/133] (884s left) gem_exec_schedule (noreorder)
[135.807529] Starting subtest: noreorder
[135.808568] Starting dynamic subtest: rcs0
[135.864720] Dynamic subtest rcs0: SUCCESS (0.063s)
[135.874579] Starting dynamic subtest: vcs0
[137.876788] Dynamic subtest vcs0: SUCCESS (2.011s)
[137.888201] Starting dynamic subtest: vcs1
[139.940367] Dynamic subtest vcs1: SUCCESS (2.053s)
[139.950069] Starting dynamic subtest: vecs0
[141.923671] Dynamic subtest vecs0: SUCCESS (1.981s)
[141.933323] Starting dynamic subtest: ccs0
[141.995418] Dynamic subtest ccs0: SUCCESS (0.079s)
[141.996598] Subtest noreorder: SUCCESS (6.195s)
[142.178619] [029/133] (878s left) gem_ctx_persistence (engines-persistence)
[142.251558] Starting subtest: engines-persistence
[142.252696] Starting dynamic subtest: rcs0
[143.067352] Dynamic subtest rcs0: SUCCESS (0.818s)
[143.077878] Starting dynamic subtest: bcs0
[143.835875] Dynamic subtest bcs0: SUCCESS (0.766s)
[143.845659] Starting dynamic subtest: vcs0
[144.575448] Dynamic subtest vcs0: SUCCESS (0.736s)
[144.584514] Starting dynamic subtest: vcs1
[145.368316] Dynamic subtest vcs1: SUCCESS (0.793s)
[145.379120] Starting dynamic subtest: vecs0
[146.137648] Dynamic subtest vecs0: SUCCESS (0.767s)
[146.148179] Starting dynamic subtest: ccs0
[146.898846] Dynamic subtest ccs0: SUCCESS (0.759s)
[146.900102] Subtest engines-persistence: SUCCESS (4.650s)
[146.971591] [030/133] (873s left) gem_mmap_wc (pf-nonblock)
[147.041793] Subtest pf-nonblock: SKIP (0.000s)
[147.101634] [031/133] (873s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[147.195293] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[147.197246] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[147.267996] [032/133] (873s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[147.322429] Starting subtest: invalid-single-wait-all-unsubmitted
[147.323321] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[147.418559] [033/133] (873s left) core_debugfs (read-all-entries)
[147.465636] Starting subtest: read-all-entries
[147.559501] Subtest read-all-entries: SUCCESS (0.095s)
[147.617755] [034/133] (873s left) gem_render_copy (yf-tiled)
[147.664532] Starting subtest: yf-tiled
[147.666716] Subtest yf-tiled: SKIP (0.000s)
[147.844173] [035/133] (873s left) gem_partial_pwrite_pread (reads-uncached)
[147.891407] Subtest reads-uncached: SKIP (0.000s)
[147.952020] [036/133] (872s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[148.037378] Starting subtest: plane-scaler-unity-scaling-with-rotation
[148.038366] Starting dynamic subtest: pipe-A
[148.265072] Dynamic subtest pipe-A: SUCCESS (0.228s)
[148.272365] Starting dynamic subtest: pipe-B
[149.573964] Dynamic subtest pipe-B: SUCCESS (1.308s)
[149.581343] Starting dynamic subtest: pipe-C
[150.913796] Dynamic subtest pipe-C: SUCCESS (1.339s)
[150.921045] Starting dynamic subtest: pipe-D
[152.249959] Dynamic subtest pipe-D: SUCCESS (1.335s)
[152.250895] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.214s)
[153.450380] [037/133] (867s left) kms_plane_alpha_blend (alpha-7efc)
[153.546533] Starting subtest: alpha-7efc
[153.830433] Starting dynamic subtest: pipe-A-eDP-1
[154.433199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[154.460356] Starting dynamic subtest: pipe-D-eDP-1
[155.752639] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s)
[155.753548] Subtest alpha-7efc: SUCCESS (2.207s)
[156.590714] [038/133] (864s left) kms_psr (pr-sprite-plane-onoff)
[156.691209] Starting subtest: pr-sprite-plane-onoff
[156.693344] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[156.760596] [039/133] (864s left) prime_vgem (basic-gtt)
[156.915502] Starting subtest: basic-gtt
[156.917275] Subtest basic-gtt: SKIP (0.000s)
[157.024487] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[157.026422] [040/133] (863s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[157.117723] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[157.119617] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[157.208305] [041/133] (863s left) kms_invalid_mode (zero-hdisplay)
[157.283473] Starting subtest: zero-hdisplay
[157.284248] Starting dynamic subtest: pipe-A-eDP-1
[157.568429] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[157.576412] Starting dynamic subtest: pipe-B-eDP-1
[157.577293] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[157.583441] Starting dynamic subtest: pipe-C-eDP-1
[157.584308] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[157.590323] Starting dynamic subtest: pipe-D-eDP-1
[157.591106] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[157.591828] Subtest zero-hdisplay: SUCCESS (0.290s)
[158.419531] [042/133] (862s left) i915_suspend (basic-s2idle-without-i915)
[158.452914] Starting subtest: basic-s2idle-without-i915
[177.560241] Subtest basic-s2idle-without-i915: SUCCESS (4.420s)
[183.697029] [043/133] (843s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[183.790957] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[183.791918] Starting dynamic subtest: pipe-A-eDP-1
[183.800963] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[183.807698] Starting dynamic subtest: pipe-B-eDP-1
[183.816593] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[183.823408] Starting dynamic subtest: pipe-C-eDP-1
[183.831857] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[183.838311] Starting dynamic subtest: pipe-D-eDP-1
[183.847095] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[183.848792] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[186.030338] [044/133] (841s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[186.081993] Starting subtest: invalid-bsd2-flag-on-vebox
[186.082874] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[186.171481] [045/133] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[186.252233] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[186.253946] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[186.332995] [046/133] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[186.427031] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[186.428780] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[186.517608] [047/133] (840s left) gem_sync (basic-store-all)
[186.582753] Starting subtest: basic-store-all
[189.680863] Subtest basic-store-all: SUCCESS (3.099s)
[189.872084] [048/133] (837s left) kms_pm_rpm (pm-caching)
[191.802540] Starting subtest: pm-caching
[191.804505] Subtest pm-caching: SKIP (0.000s)
[192.189465] [049/133] (835s left) gem_unref_active_buffers
[192.368195] [050/133] (834s left) kms_psr (fbc-pr-primary-mmap-gtt)
[192.445768] Starting subtest: fbc-pr-primary-mmap-gtt
[192.447400] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[192.543729] [051/133] (834s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[192.602190] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[192.705235] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[192.790701] [052/133] (834s left) gem_exec_reloc (basic-wc-noreloc)
[192.844920] Subtest basic-wc-noreloc: SKIP (0.000s)
[192.920362] [053/133] (834s left) gem_lmem_swapping (random-engines)
[192.954802] Subtest random-engines: SKIP (0.000s)
[192.993704] [054/133] (834s left) gem_exec_flush (basic-wb-ro-before-default)
[193.044296] Starting subtest: basic-wb-ro-before-default
[198.500515] Subtest basic-wb-ro-before-default: SUCCESS (5.452s)
[198.676553] [055/133] (828s left) gem_ctx_persistence (heartbeat-hostile)
[198.732655] Starting subtest: heartbeat-hostile
[198.734250] Subtest heartbeat-hostile: SKIP (0.000s)
[198.853928] [056/133] (828s left) dmabuf_sync_file (import-basic)
[198.897503] Starting subtest: import-basic
[198.899446] Subtest import-basic: SUCCESS (0.003s)
[199.000745] [057/133] (828s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[199.099309] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[199.101063] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[199.194160] [058/133] (828s left) syncobj_wait (single-wait-all-submitted)
[199.240073] Starting subtest: single-wait-all-submitted
[199.346971] Subtest single-wait-all-submitted: SUCCESS (0.106s)
[199.446868] [059/133] (828s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[199.530016] Starting subtest: fbc-psr2-sprite-mmap-gtt
[199.530972] Starting dynamic subtest: eDP-1
[199.532844] Dynamic subtest eDP-1: SKIP (0.000s)
[199.534604] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[199.600746] [060/133] (828s left) gem_exec_store (dword)
[199.650620] Starting subtest: dword
[199.651599] Starting dynamic subtest: rcs0
[199.709447] Dynamic subtest rcs0: SUCCESS (0.058s)
[199.719584] Starting dynamic subtest: bcs0
[199.752711] Dynamic subtest bcs0: SUCCESS (0.041s)
[199.763377] Starting dynamic subtest: vcs0
[199.800474] Dynamic subtest vcs0: SUCCESS (0.045s)
[199.810402] Starting dynamic subtest: vcs1
[199.842444] Dynamic subtest vcs1: SUCCESS (0.040s)
[199.852013] Starting dynamic subtest: vecs0
[199.884502] Dynamic subtest vecs0: SUCCESS (0.040s)
[199.895946] Starting dynamic subtest: ccs0
[199.929259] Dynamic subtest ccs0: SUCCESS (0.042s)
[199.930875] Subtest dword: SUCCESS (0.279s)
[200.106101] [061/133] (827s left) gem_exec_fence (concurrent)
[200.289252] Starting subtest: concurrent
[200.290930] Subtest concurrent: SKIP (0.000s)
[201.663385] [062/133] (826s left) perf_pmu (busy-accuracy-50)
[201.697989] Starting subtest: busy-accuracy-50
[201.698914] Starting dynamic subtest: rcs0
[203.241466] Dynamic subtest rcs0: SUCCESS (1.539s)
[203.251311] Starting dynamic subtest: bcs0
[204.796070] Dynamic subtest bcs0: SUCCESS (1.552s)
[204.806014] Starting dynamic subtest: vcs0
[206.343456] Dynamic subtest vcs0: SUCCESS (1.545s)
[206.351490] Starting dynamic subtest: vcs1
[207.888759] Dynamic subtest vcs1: SUCCESS (1.543s)
[207.898242] Starting dynamic subtest: vecs0
[209.432069] Dynamic subtest vecs0: SUCCESS (1.539s)
[209.440633] Starting dynamic subtest: ccs0
[210.980931] Dynamic subtest ccs0: SUCCESS (1.546s)
[210.981984] Subtest busy-accuracy-50: SUCCESS (9.278s)
[211.084336] [063/133] (816s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[211.179863] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[211.181480] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[211.281588] [064/133] (816s left) i915_drm_fdinfo (busy-check-all)
[211.322565] Starting subtest: busy-check-all
[211.323561] Starting dynamic subtest: rcs0
[211.328536] Dynamic subtest rcs0: SKIP (0.005s)
[211.338036] Starting dynamic subtest: bcs0
[211.339909] Dynamic subtest bcs0: SKIP (0.000s)
[211.347011] Starting dynamic subtest: vcs0
[211.348713] Dynamic subtest vcs0: SKIP (0.000s)
[211.356134] Starting dynamic subtest: vcs1
[211.357901] Dynamic subtest vcs1: SKIP (0.000s)
[211.365474] Starting dynamic subtest: vecs0
[211.367196] Dynamic subtest vecs0: SKIP (0.000s)
[211.375064] Starting dynamic subtest: ccs0
[211.376732] Dynamic subtest ccs0: SKIP (0.000s)
[211.378409] Subtest busy-check-all: SKIP (0.013s)
[211.407563] [065/133] (816s left) kms_pm_dc (dc5-dpms)
[212.505711] Starting subtest: dc5-dpms
[214.561777] Subtest dc5-dpms: SUCCESS (2.047s)
[214.627669] [066/133] (813s left) gem_exec_reloc (basic-cpu-read-active)
[214.683843] Subtest basic-cpu-read-active: SKIP (0.000s)
[214.746011] [067/133] (813s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[214.851862] Starting subtest: short-flip-after-cursor-atomic-transitions
[215.811907] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.958s)
[216.632552] [068/133] (811s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[216.729059] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[216.731005] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[216.839097] [069/133] (811s left) gem_partial_pwrite_pread (writes-after-reads)
[216.888191] Subtest writes-after-reads: SKIP (0.000s)
[216.950795] [070/133] (811s left) gem_eio (in-flight-1us)
[217.151021] Starting subtest: in-flight-1us
[225.037402] Subtest in-flight-1us: SUCCESS (7.887s)
[225.214375] [071/133] (802s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[225.271754] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[225.377977] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[225.449629] [072/133] (802s left) gem_render_tiled_blits (basic)
[225.504324] Subtest basic: SKIP (0.000s)
[225.557380] [073/133] (802s left) prime_vgem (wait)
[225.620530] Starting subtest: wait
[225.621338] Starting dynamic subtest: rcs0
[225.654969] Dynamic subtest rcs0: SUCCESS (0.035s)
[225.662802] Starting dynamic subtest: bcs0
[225.699262] Dynamic subtest bcs0: SUCCESS (0.043s)
[225.707250] Starting dynamic subtest: vcs0
[225.745925] Dynamic subtest vcs0: SUCCESS (0.046s)
[225.753965] Starting dynamic subtest: vcs1
[225.791962] Dynamic subtest vcs1: SUCCESS (0.045s)
[225.800054] Starting dynamic subtest: vecs0
[225.842024] Dynamic subtest vecs0: SUCCESS (0.049s)
[225.850075] Starting dynamic subtest: ccs0
[225.888837] Dynamic subtest ccs0: SUCCESS (0.046s)
[225.889632] Subtest wait: SUCCESS (0.270s)
[225.999261] [074/133] (802s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[226.086406] Starting subtest: fbc-tiling-linear
[229.773995] Subtest fbc-tiling-linear: SUCCESS (3.689s)
[230.955734] [075/133] (797s left) kms_color (ctm-0-50)
[231.040793] Starting subtest: ctm-0-50
[231.041745] Starting dynamic subtest: pipe-A-eDP-1
[234.548071] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.506s)
[234.558461] Starting dynamic subtest: pipe-B-eDP-1
[238.834848] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.287s)
[238.843144] Starting dynamic subtest: pipe-C-eDP-1
[242.883932] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.049s)
[242.891967] Starting dynamic subtest: pipe-D-eDP-1
[246.877993] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.993s)
[246.879023] Subtest ctm-0-50: SUCCESS (15.838s)
[247.689053] [076/133] (780s left) kms_vblank (ts-continuation-modeset-rpm)
[247.787125] Starting subtest: ts-continuation-modeset-rpm
[247.788102] Starting dynamic subtest: pipe-A-eDP-1
[250.289554] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[250.299530] Starting dynamic subtest: pipe-D-eDP-1
[252.531656] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.240s)
[252.532451] Subtest ts-continuation-modeset-rpm: SUCCESS (4.747s)
[253.316088] [077/133] (775s left) gem_create (create-valid-nonaligned)
[253.375313] Starting subtest: create-valid-nonaligned
[253.376302] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[253.555668] [078/133] (774s left) gem_exec_reloc (basic-cpu-gtt)
[253.605967] Subtest basic-cpu-gtt: SKIP (0.000s)
[253.666006] [079/133] (774s left) gem_exec_reloc (basic-write-cpu)
[253.719546] Subtest basic-write-cpu: SKIP (0.000s)
[253.781773] [080/133] (774s left) sysfs_preempt_timeout (invalid)
[253.834653] Starting subtest: invalid
[253.835625] Starting dynamic subtest: vecs0
[253.836520] Dynamic subtest vecs0: SUCCESS (0.000s)
[253.845752] Starting dynamic subtest: ccs0
[253.846662] Dynamic subtest ccs0: SUCCESS (0.000s)
[253.854217] Starting dynamic subtest: vcs0
[253.855081] Dynamic subtest vcs0: SUCCESS (0.000s)
[253.862852] Starting dynamic subtest: bcs0
[253.863711] Dynamic subtest bcs0: SUCCESS (0.000s)
[253.871263] Starting dynamic subtest: rcs0
[253.872122] Dynamic subtest rcs0: SUCCESS (0.000s)
[253.879921] Starting dynamic subtest: vcs1
[253.880780] Dynamic subtest vcs1: SUCCESS (0.000s)
[253.881592] Subtest invalid: SUCCESS (0.009s)
[253.961192] [081/133] (774s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[254.025285] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[254.133836] [082/133] (774s left) gem_exec_params (invalid-batch-start-offset)
[254.194126] Starting subtest: invalid-batch-start-offset
[254.197500] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[254.311577] [083/133] (774s left) perf_pmu (rc6)
[254.345234] Starting subtest: rc6
[254.346358] Starting dynamic subtest: gt0
[260.763244] Dynamic subtest gt0: SUCCESS (6.371s)
[260.771686] Starting dynamic subtest: runtime-pm-gt0
[268.489626] Dynamic subtest runtime-pm-gt0: SUCCESS (7.760s)
[268.500770] Starting dynamic subtest: runtime-pm-long-gt0
[280.982257] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.490s)
[280.993369] Starting dynamic subtest: other-idle-gt0
[287.326819] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[287.338909] Starting dynamic subtest: gt1
[293.669275] Dynamic subtest gt1: SUCCESS (6.339s)
[293.680445] Starting dynamic subtest: runtime-pm-gt1
[301.119910] Dynamic subtest runtime-pm-gt1: SUCCESS (7.447s)
[301.130756] Starting dynamic subtest: runtime-pm-long-gt1
[313.569312] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.446s)
[313.580580] Starting dynamic subtest: other-idle-gt1
[319.914352] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[319.915992] Subtest rc6: SUCCESS (65.554s)
[320.514515] [084/133] (708s left) gem_mmap_offset (partial-unmap)
[320.573082] Starting subtest: partial-unmap
[320.574021] Starting dynamic subtest: smem0
[321.088817] Dynamic subtest smem0: SUCCESS (0.508s)
[321.090282] Subtest partial-unmap: SUCCESS (0.509s)
[321.179655] [085/133] (707s left) kms_dsc (dsc-basic)
[321.267704] Starting subtest: dsc-basic
[321.272704] Subtest dsc-basic: SKIP (0.000s)
[321.310984] [086/133] (707s left) perf_pmu (multi-client)
[321.341679] Starting subtest: multi-client
[321.342566] Starting dynamic subtest: rcs0
[322.398509] Dynamic subtest rcs0: SUCCESS (1.055s)
[322.410633] Starting dynamic subtest: bcs0
[323.459512] Dynamic subtest bcs0: SUCCESS (1.050s)
[323.469461] Starting dynamic subtest: vcs0
[324.511781] Dynamic subtest vcs0: SUCCESS (1.049s)
[324.521918] Starting dynamic subtest: vcs1
[325.621109] Dynamic subtest vcs1: SUCCESS (1.107s)
[325.631467] Starting dynamic subtest: vecs0
[327.606506] Dynamic subtest vecs0: SUCCESS (1.983s)
[327.617281] Starting dynamic subtest: ccs0
[329.592325] Dynamic subtest ccs0: SUCCESS (1.982s)
[329.593457] Subtest multi-client: SUCCESS (8.242s)
[329.676011] [087/133] (699s left) gem_exec_schedule (u-semaphore-user)
[329.724685] Starting subtest: u-semaphore-user
[329.784212] Subtest u-semaphore-user: SUCCESS (0.059s)
[331.605845] [088/133] (697s left) gem_eio (banned)
[331.800469] Starting subtest: banned
[332.351526] Subtest banned: SUCCESS (0.552s)
[332.482725] [089/133] (696s left) kms_lease (lease-revoke)
[332.569791] Starting subtest: lease-revoke
[332.570799] Starting dynamic subtest: pipe-A-eDP-1
[332.600818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[332.611154] Starting dynamic subtest: pipe-B-eDP-1
[332.628508] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[332.637409] Starting dynamic subtest: pipe-C-eDP-1
[332.656964] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[332.665758] Starting dynamic subtest: pipe-D-eDP-1
[332.684940] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[332.686504] Subtest lease-revoke: SUCCESS (0.117s)
[332.783513] [090/133] (696s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[333.163889] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[333.969172] [091/133] (694s left) gem_exec_await (wide-contexts)
[334.146085] Starting subtest: wide-contexts
[357.512261] Subtest wide-contexts: SUCCESS (23.360s)
[357.677359] [092/133] (671s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[357.807444] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[357.869615] [093/133] (671s left) kms_dp_linktrain_fallback (dsc-fallback)
[357.957852] Starting subtest: dsc-fallback
[357.960446] Subtest dsc-fallback: SKIP (0.000s)
[358.006802] [094/133] (670s left) gem_lmem_swapping (parallel-random)
[358.045893] Subtest parallel-random: SKIP (0.000s)
[358.079656] [095/133] (670s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[358.186023] Starting subtest: y-tiled-64bpp-rotate-270
[358.187766] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[358.246466] [096/133] (670s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[358.340627] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[358.342268] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[358.418276] [097/133] (670s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[358.515895] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[365.632505] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.117s)
[365.717014] [098/133] (663s left) gem_fenced_exec_thrash (too-many-fences)
[365.766715] Subtest too-many-fences: SKIP (0.000s)
[365.843343] [099/133] (663s left) kms_big_fb (linear-16bpp-rotate-0)
[365.949286] Starting subtest: linear-16bpp-rotate-0
[367.362462] Subtest linear-16bpp-rotate-0: SUCCESS (1.413s)
[367.469709] [100/133] (661s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[367.519935] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[367.626440] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[367.677782] [101/133] (661s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[367.757188] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[367.758972] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[367.827852] [102/133] (661s left) gen7_exec_parse (basic-rejected)
[367.880900] Subtest basic-rejected: SKIP (0.000s)
[367.940661] [103/133] (661s left) api_intel_allocator (reserve-simple)
[367.994546] Starting subtest: reserve-simple
[367.996525] Subtest reserve-simple: SUCCESS (0.003s)
[368.081877] [104/133] (661s left) gem_eio (create)
[368.317274] Starting subtest: create
[368.675150] Subtest create: SUCCESS (0.357s)
[368.767860] [105/133] (660s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[368.825096] Starting subtest: y-tiled-ccs-to-yf-tiled
[368.826958] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[368.978046] [106/133] (660s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[369.071171] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[369.072884] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[369.144051] [107/133] (660s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[369.280242] Starting subtest: dp-mst-lic-type-0-hdcp14
[369.282243] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[369.367116] [108/133] (660s left) gem_create (create-ext-placement-all)
[369.537670] Starting subtest: create-ext-placement-all
[369.538811] Subtest create-ext-placement-all: SUCCESS (0.000s)
[369.595800] [109/133] (659s left) kms_cursor_crc (cursor-dpms)
[369.722949] Starting subtest: cursor-dpms
[369.723992] Starting dynamic subtest: pipe-A-eDP-1
[372.836090] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.111s)
[372.847603] Starting dynamic subtest: pipe-D-eDP-1
[376.413458] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.575s)
[376.414412] Subtest cursor-dpms: SUCCESS (6.689s)
[377.225140] [110/133] (652s left) syncobj_timeline (wait-all-complex)
[377.279593] Starting subtest: wait-all-complex
[377.505040] Subtest wait-all-complex: SUCCESS (0.216s)
[377.551730] [111/133] (652s left) kms_sequence (get-busy)
[377.646840] Starting subtest: get-busy
[377.647946] Starting dynamic subtest: pipe-A-eDP-1
[379.584622] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[379.594704] Starting dynamic subtest: pipe-B-eDP-1
[382.146119] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.559s)
[382.162172] Starting dynamic subtest: pipe-C-eDP-1
[384.748368] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.601s)
[384.757703] Starting dynamic subtest: pipe-D-eDP-1
[387.292756] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[387.293650] Subtest get-busy: SUCCESS (9.646s)
[388.062346] [112/133] (641s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[388.155673] Starting subtest: fbcpsr-rgb101010-draw-render
[394.961484] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.806s)
[395.053115] [113/133] (634s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[395.171228] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[396.011720] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.841s)
[396.122811] [114/133] (633s left) gem_busy (close-race)
[396.186032] Starting subtest: close-race
[419.645764] Subtest close-race: SUCCESS (23.449s)
[419.972637] [115/133] (609s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[420.113792] Starting subtest: fbc-rgb565-draw-mmap-gtt
[420.115671] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[420.184449] [116/133] (609s left) kms_cursor_crc (cursor-sliding-64x64)
[420.356349] Starting subtest: cursor-sliding-64x64
[420.360571] Starting dynamic subtest: pipe-A-eDP-1
[423.587341] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.226s)
[423.617494] Starting dynamic subtest: pipe-D-eDP-1
[427.558015] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.950s)
[427.558904] Subtest cursor-sliding-64x64: SUCCESS (7.202s)
[428.344743] [117/133] (601s left) gem_softpin (evict-active)
[428.399368] Starting subtest: evict-active
[428.403592] Subtest evict-active: SUCCESS (0.005s)
[428.486135] [118/133] (601s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[428.873365] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[429.683180] [119/133] (600s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[429.772063] Starting subtest: psr-rgb101010-draw-pwrite
[437.538309] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.766s)
[437.612529] [120/133] (592s left) kms_cdclk (mode-transition-all-outputs)
[437.703577] Starting subtest: mode-transition-all-outputs
[437.991281] Subtest mode-transition-all-outputs: SKIP (0.287s)
[438.772492] [121/133] (591s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[438.862339] Starting subtest: fbc-pr-sprite-mmap-cpu
[438.864241] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[438.906827] [122/133] (591s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[438.990165] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[438.992078] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[439.036127] [123/133] (591s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[439.133350] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[440.144781] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.012s)
[440.230612] [124/133] (589s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[440.316861] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[440.317896] Starting dynamic subtest: pipe-A-eDP-1
[440.340440] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[440.355146] Starting dynamic subtest: pipe-B-eDP-1
[440.376990] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[440.386071] Starting dynamic subtest: pipe-C-eDP-1
[440.407774] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[440.416365] Starting dynamic subtest: pipe-D-eDP-1
[440.436557] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[440.438068] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[442.531676] [125/133] (587s left) gem_exec_fence (syncobj-import)
[443.002635] Starting subtest: syncobj-import
[443.008824] Subtest syncobj-import: SUCCESS (0.006s)
[444.662989] [126/133] (585s left) kms_psr (psr2-sprite-plane-move)
[444.757225] Starting subtest: psr2-sprite-plane-move
[444.758215] Starting dynamic subtest: eDP-1
[446.481644] Dynamic subtest eDP-1: SUCCESS (1.723s)
[446.482519] Subtest psr2-sprite-plane-move: SUCCESS (1.725s)
[447.294383] [127/133] (582s left) kms_atomic_transition (modeset-transition-fencing)
[447.379892] Starting subtest: modeset-transition-fencing
[447.380853] Starting dynamic subtest: 1x-outputs
[458.224832] Dynamic subtest 1x-outputs: SUCCESS (10.844s)
[458.226132] Subtest modeset-transition-fencing: SUCCESS (10.846s)
[459.047393] [128/133] (571s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[459.158436] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[466.226715] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.067s)
[466.337525] [129/133] (563s left) gem_exec_balancer (busy)
[466.407209] Starting subtest: busy
[467.576931] Subtest busy: SUCCESS (1.160s)
[467.863885] [130/133] (562s left) kms_flip (flip-vs-blocking-wf-vblank)
[467.959465] Starting subtest: flip-vs-blocking-wf-vblank
[467.960363] Starting dynamic subtest: A-eDP1
[476.850777] Dynamic subtest A-eDP1: SUCCESS (8.889s)
[476.861462] Starting dynamic subtest: B-eDP1
[485.784148] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[485.796453] Starting dynamic subtest: C-eDP1
[494.742594] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[494.752249] Starting dynamic subtest: D-eDP1
[503.678205] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[503.679197] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.687s)
[504.847753] [131/133] (525s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[504.941678] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[509.428884] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.487s)
[510.547382] [132/133] (519s left) gem_create (create-invalid-size)
[510.593947] Starting subtest: create-invalid-size
[510.594861] Subtest create-invalid-size: SUCCESS (0.000s)
[510.743939] [133/133] (519s left) kms_psr (psr-sprite-render)
[510.819960] Starting subtest: psr-sprite-render
[510.820887] Starting dynamic subtest: eDP-1
[512.581500] Dynamic subtest eDP-1: SUCCESS (1.761s)
[512.582353] Subtest psr-sprite-render: SUCCESS (1.762s)
[513.396317] 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.