[59.541496] Initializing watchdogs
[59.541606]   /dev/watchdog0
[59.557886] [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.562994] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.565581] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.575451] [001/133] (960s left) perf (whitelisted-registers-userspace-config)
[59.698472] Starting subtest: whitelisted-registers-userspace-config
[59.699332] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[59.732921] [002/133] (960s left) gem_busy (busy)
[59.806687] Starting subtest: busy
[59.807691] Starting dynamic subtest: all-engines
[59.871821] Dynamic subtest all-engines: SUCCESS (0.064s)
[59.878888] Starting dynamic subtest: rcs0
[61.923631] Dynamic subtest rcs0: SUCCESS (2.048s)
[61.933070] Starting dynamic subtest: bcs0
[61.969114] Dynamic subtest bcs0: SUCCESS (0.046s)
[61.974462] Starting dynamic subtest: vcs0
[62.007520] Dynamic subtest vcs0: SUCCESS (0.038s)
[62.013854] Starting dynamic subtest: vcs1
[63.906310] Dynamic subtest vcs1: SUCCESS (1.886s)
[63.914577] Starting dynamic subtest: vecs0
[65.954283] Dynamic subtest vecs0: SUCCESS (2.045s)
[65.962360] Starting dynamic subtest: ccs0
[67.937023] Dynamic subtest ccs0: SUCCESS (1.981s)
[67.938024] Subtest busy: SUCCESS (8.112s)
[68.274371] [003/133] (951s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[68.372049] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[68.373858] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[68.433388] [004/133] (951s left) i915_pm_freq_mult (media-freq)
[68.483358] Starting subtest: media-freq
[68.484296] Starting dynamic subtest: gt0
[68.486019] Dynamic subtest gt0: SKIP (0.000s)
[68.493257] Starting dynamic subtest: gt1
[68.494924] Dynamic subtest gt1: SKIP (0.000s)
[68.496495] Subtest media-freq: SKIP (0.001s)
[68.572047] [005/133] (951s left) prime_mmap (test_map_unmap)
[68.620921] Starting subtest: test_map_unmap
[68.621853] Starting dynamic subtest: test_map_unmap-smem
[68.653369] Dynamic subtest test_map_unmap-smem: SUCCESS (0.032s)
[68.654397] Subtest test_map_unmap: SUCCESS (0.033s)
[68.754949] [006/133] (951s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[68.866032] Starting subtest: short-flip-after-cursor-toggle
[69.832350] Subtest short-flip-after-cursor-toggle: SUCCESS (0.965s)
[70.635822] [007/133] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[70.734742] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[78.600370] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.864s)
[78.702121] [008/133] (941s left) i915_module_load (resize-bar)
[78.735595] Starting subtest: resize-bar
[78.742719] Subtest resize-bar: SKIP (0.007s)
[78.776908] [009/133] (941s left) kms_pwrite_crc
[80.347672] [010/133] (939s left) gem_userptr_blits (coherency-unsync)
[80.402926] Subtest coherency-unsync: SKIP (0.000s)
[80.526201] [011/133] (939s left) gem_softpin (allocator-fork)
[80.578972] Starting subtest: allocator-fork
[82.841779] Subtest allocator-fork: SUCCESS (2.216s)
[82.899877] [012/133] (937s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[82.994420] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[82.996300] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[83.088864] [013/133] (937s left) kms_plane_multiple (tiling-yf)
[83.168086] Starting subtest: tiling-yf
[83.169872] Subtest tiling-yf: SKIP (0.000s)
[83.234749] [014/133] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[83.330114] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[83.331877] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[83.419504] [015/133] (937s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[83.520213] Starting subtest: plane-all-modeset-transition-fencing
[83.522477] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[83.602133] [016/133] (936s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[83.685175] Starting subtest: crc-primary-suspend-y-tiled-ccs
[83.686128] Starting dynamic subtest: pipe-A-eDP-1
[83.689809] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.696879] Starting dynamic subtest: pipe-B-eDP-1
[83.700368] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.706765] Starting dynamic subtest: pipe-C-eDP-1
[83.710275] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.716166] Starting dynamic subtest: pipe-D-eDP-1
[83.719752] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.721507] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.003s)
[85.927647] [017/133] (934s left) kms_prop_blob (blob-prop-core)
[85.981575] Starting subtest: blob-prop-core
[85.982478] Subtest blob-prop-core: SUCCESS (0.000s)
[86.083539] [018/133] (934s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[86.170940] Starting subtest: fbc-farfromfence-mmap-gtt
[86.172892] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[86.255561] [019/133] (934s left) gem_mmap_gtt (basic-write-read)
[86.304823] Subtest basic-write-read: SKIP (0.000s)
[86.358249] [020/133] (934s left) syncobj_wait (wait-for-submit-delayed-submit)
[86.407736] Starting subtest: wait-for-submit-delayed-submit
[86.511871] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[86.580342] [021/133] (934s left) syncobj_timeline (multi-wait-available-signaled)
[86.622730] Starting subtest: multi-wait-available-signaled
[86.623590] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[86.718807] [022/133] (934s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[86.800884] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[86.801778] Starting dynamic subtest: pipe-A-eDP-1
[88.995431] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.194s)
[89.002605] Starting dynamic subtest: pipe-B-eDP-1
[91.352076] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.355s)
[91.359035] Starting dynamic subtest: pipe-C-eDP-1
[93.440535] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.087s)
[93.448794] Starting dynamic subtest: pipe-D-eDP-1
[95.608333] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.166s)
[95.609207] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.806s)
[96.768671] [023/133] (923s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[96.870443] Starting subtest: primary-yf-tiled-reflect-x-90
[96.872363] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[96.938861] [024/133] (923s left) syncobj_basic (bad-flags-handle-to-fd)
[96.988498] Starting subtest: bad-flags-handle-to-fd
[96.989713] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[97.073524] [025/133] (923s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[97.179752] Starting subtest: extended-modeset-hang-newfb-with-reset
[97.180638] Starting dynamic subtest: pipe-A
[111.139749] Dynamic subtest pipe-A: SUCCESS (13.957s)
[111.146806] Starting dynamic subtest: pipe-D
[126.716389] Dynamic subtest pipe-D: SUCCESS (15.574s)
[126.717452] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.535s)
[127.515926] [026/133] (893s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[127.600405] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[127.601247] Starting dynamic subtest: pipe-A
[128.649326] Dynamic subtest pipe-A: SUCCESS (1.050s)
[128.655939] Starting dynamic subtest: pipe-B
[130.715823] Dynamic subtest pipe-B: SUCCESS (2.066s)
[130.723708] Starting dynamic subtest: pipe-C
[131.916271] Dynamic subtest pipe-C: SUCCESS (1.198s)
[131.924216] Starting dynamic subtest: pipe-D
[133.067184] Dynamic subtest pipe-D: SUCCESS (1.150s)
[133.069444] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.468s)
[134.262918] [027/133] (886s left) kms_cursor_crc (cursor-random-max-size)
[134.603445] Starting subtest: cursor-random-max-size
[134.606152] Subtest cursor-random-max-size: SKIP (0.000s)
[134.725655] [028/133] (886s left) gem_exec_schedule (noreorder)
[134.902493] Starting subtest: noreorder
[134.903818] Starting dynamic subtest: rcs0
[134.967806] Dynamic subtest rcs0: SUCCESS (0.065s)
[134.977652] Starting dynamic subtest: vcs0
[136.925188] Dynamic subtest vcs0: SUCCESS (1.948s)
[136.936175] Starting dynamic subtest: vcs1
[138.821978] Dynamic subtest vcs1: SUCCESS (1.893s)
[138.831690] Starting dynamic subtest: vecs0
[139.945666] Dynamic subtest vecs0: SUCCESS (1.122s)
[139.954451] Starting dynamic subtest: ccs0
[139.987283] Dynamic subtest ccs0: SUCCESS (0.049s)
[139.988388] Subtest noreorder: SUCCESS (5.086s)
[140.164504] [029/133] (880s left) gem_ctx_persistence (engines-persistence)
[140.227929] Starting subtest: engines-persistence
[140.229102] Starting dynamic subtest: rcs0
[141.089763] Dynamic subtest rcs0: SUCCESS (0.861s)
[141.101425] Starting dynamic subtest: bcs0
[141.850639] Dynamic subtest bcs0: SUCCESS (0.759s)
[141.861341] Starting dynamic subtest: vcs0
[142.612342] Dynamic subtest vcs0: SUCCESS (0.760s)
[142.622875] Starting dynamic subtest: vcs1
[143.377416] Dynamic subtest vcs1: SUCCESS (0.763s)
[143.387808] Starting dynamic subtest: vecs0
[144.155724] Dynamic subtest vecs0: SUCCESS (0.776s)
[144.166488] Starting dynamic subtest: ccs0
[144.912625] Dynamic subtest ccs0: SUCCESS (0.755s)
[144.913742] Subtest engines-persistence: SUCCESS (4.686s)
[144.999414] [030/133] (875s left) gem_mmap_wc (pf-nonblock)
[145.057220] Subtest pf-nonblock: SKIP (0.000s)
[145.108891] [031/133] (875s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[145.197223] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[145.198831] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[145.264782] [032/133] (875s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[145.310726] Starting subtest: invalid-single-wait-all-unsubmitted
[145.311755] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[145.413382] [033/133] (875s left) core_debugfs (read-all-entries)
[145.459138] Starting subtest: read-all-entries
[145.553378] Subtest read-all-entries: SUCCESS (0.095s)
[145.611966] [034/133] (875s left) gem_render_copy (yf-tiled)
[145.663388] Starting subtest: yf-tiled
[145.665368] Subtest yf-tiled: SKIP (0.000s)
[145.842045] [035/133] (875s left) gem_partial_pwrite_pread (reads-uncached)
[145.904536] Subtest reads-uncached: SKIP (0.000s)
[145.968155] [036/133] (875s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[146.044075] Starting subtest: plane-scaler-unity-scaling-with-rotation
[146.044938] Starting dynamic subtest: pipe-A
[146.306314] Dynamic subtest pipe-A: SUCCESS (0.262s)
[146.314620] Starting dynamic subtest: pipe-B
[147.646572] Dynamic subtest pipe-B: SUCCESS (1.339s)
[147.654957] Starting dynamic subtest: pipe-C
[148.984083] Dynamic subtest pipe-C: SUCCESS (1.336s)
[148.992893] Starting dynamic subtest: pipe-D
[150.297716] Dynamic subtest pipe-D: SUCCESS (1.312s)
[150.298641] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.254s)
[151.471494] [037/133] (869s left) kms_plane_alpha_blend (alpha-7efc)
[151.561183] Starting subtest: alpha-7efc
[151.846102] Starting dynamic subtest: pipe-A-eDP-1
[152.464754] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s)
[152.493048] Starting dynamic subtest: pipe-D-eDP-1
[153.790582] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.304s)
[153.791456] Subtest alpha-7efc: SUCCESS (2.230s)
[154.633191] [038/133] (866s left) kms_psr (pr-sprite-plane-onoff)
[154.716750] Starting subtest: pr-sprite-plane-onoff
[154.718449] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[154.784475] [039/133] (866s left) prime_vgem (basic-gtt)
[154.938407] Starting subtest: basic-gtt
[154.940219] Subtest basic-gtt: SKIP (0.000s)
[155.057639] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[155.060681] [040/133] (866s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[155.148244] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[155.150017] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[155.242447] [041/133] (866s left) kms_invalid_mode (zero-hdisplay)
[155.321727] Starting subtest: zero-hdisplay
[155.322604] Starting dynamic subtest: pipe-A-eDP-1
[155.613518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[155.621527] Starting dynamic subtest: pipe-B-eDP-1
[155.622398] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[155.628615] Starting dynamic subtest: pipe-C-eDP-1
[155.629450] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[155.635737] Starting dynamic subtest: pipe-D-eDP-1
[155.636598] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[155.637520] Subtest zero-hdisplay: SUCCESS (0.297s)
[156.485165] [042/133] (864s left) i915_suspend (basic-s2idle-without-i915)
[156.517567] Starting subtest: basic-s2idle-without-i915
[176.301623] Subtest basic-s2idle-without-i915: SUCCESS (4.509s)
[182.442802] [043/133] (844s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[182.547254] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[182.548144] Starting dynamic subtest: pipe-A-eDP-1
[182.556603] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[182.563435] Starting dynamic subtest: pipe-B-eDP-1
[182.571724] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[182.578389] Starting dynamic subtest: pipe-C-eDP-1
[182.586638] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[182.593438] Starting dynamic subtest: pipe-D-eDP-1
[182.602057] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[182.603886] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[184.825496] [044/133] (842s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[184.896868] Starting subtest: invalid-bsd2-flag-on-vebox
[184.897911] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[184.995634] [045/133] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[185.092699] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[185.094602] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[185.184106] [046/133] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[185.282425] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[185.284459] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[185.373275] [047/133] (842s left) gem_sync (basic-store-all)
[185.441778] Starting subtest: basic-store-all
[188.528883] Subtest basic-store-all: SUCCESS (3.065s)
[188.711763] [048/133] (838s left) kms_pm_rpm (pm-caching)
[190.352513] Starting subtest: pm-caching
[190.355104] Subtest pm-caching: SKIP (0.000s)
[190.983953] [049/133] (836s left) gem_unref_active_buffers
[191.191227] [050/133] (836s left) kms_psr (fbc-pr-primary-mmap-gtt)
[191.282712] Starting subtest: fbc-pr-primary-mmap-gtt
[191.284535] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[191.352237] [051/133] (836s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[191.406694] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[191.508569] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[191.583331] [052/133] (836s left) gem_exec_reloc (basic-wc-noreloc)
[191.629226] Subtest basic-wc-noreloc: SKIP (0.000s)
[191.687684] [053/133] (836s left) gem_lmem_swapping (random-engines)
[191.728668] Subtest random-engines: SKIP (0.000s)
[191.771721] [054/133] (836s left) gem_exec_flush (basic-wb-ro-before-default)
[191.841543] Starting subtest: basic-wb-ro-before-default
[197.309479] Subtest basic-wb-ro-before-default: SUCCESS (5.452s)
[197.498548] [055/133] (830s left) gem_ctx_persistence (heartbeat-hostile)
[197.565208] Starting subtest: heartbeat-hostile
[197.567148] Subtest heartbeat-hostile: SKIP (0.000s)
[197.667962] [056/133] (830s left) dmabuf_sync_file (import-basic)
[197.708587] Starting subtest: import-basic
[197.711052] Subtest import-basic: SUCCESS (0.002s)
[197.782397] [057/133] (830s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[197.873175] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[197.875196] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[197.965356] [058/133] (830s left) syncobj_wait (single-wait-all-submitted)
[198.025074] Starting subtest: single-wait-all-submitted
[198.139208] Subtest single-wait-all-submitted: SUCCESS (0.106s)
[198.218443] [059/133] (829s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[198.301833] Starting subtest: fbc-psr2-sprite-mmap-gtt
[198.302713] Starting dynamic subtest: eDP-1
[198.304446] Dynamic subtest eDP-1: SKIP (0.000s)
[198.306236] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[198.367462] [060/133] (829s left) gem_exec_store (dword)
[198.426655] Starting subtest: dword
[198.427695] Starting dynamic subtest: rcs0
[198.490464] Dynamic subtest rcs0: SUCCESS (0.063s)
[198.501762] Starting dynamic subtest: bcs0
[198.532601] Dynamic subtest bcs0: SUCCESS (0.040s)
[198.542206] Starting dynamic subtest: vcs0
[198.572978] Dynamic subtest vcs0: SUCCESS (0.039s)
[198.582371] Starting dynamic subtest: vcs1
[198.615443] Dynamic subtest vcs1: SUCCESS (0.040s)
[198.624964] Starting dynamic subtest: vecs0
[198.657813] Dynamic subtest vecs0: SUCCESS (0.040s)
[198.667109] Starting dynamic subtest: ccs0
[198.700271] Dynamic subtest ccs0: SUCCESS (0.040s)
[198.703078] Subtest dword: SUCCESS (0.274s)
[198.882718] [061/133] (829s left) gem_exec_fence (concurrent)
[199.058857] Starting subtest: concurrent
[199.060745] Subtest concurrent: SKIP (0.000s)
[201.253295] [062/133] (826s left) perf_pmu (busy-accuracy-50)
[201.290583] Starting subtest: busy-accuracy-50
[201.291672] Starting dynamic subtest: rcs0
[202.837409] Dynamic subtest rcs0: SUCCESS (1.540s)
[202.847527] Starting dynamic subtest: bcs0
[204.388423] Dynamic subtest bcs0: SUCCESS (1.546s)
[204.398251] Starting dynamic subtest: vcs0
[205.928987] Dynamic subtest vcs0: SUCCESS (1.536s)
[205.939123] Starting dynamic subtest: vcs1
[207.478014] Dynamic subtest vcs1: SUCCESS (1.544s)
[207.488009] Starting dynamic subtest: vecs0
[209.022996] Dynamic subtest vecs0: SUCCESS (1.541s)
[209.033066] Starting dynamic subtest: ccs0
[210.575008] Dynamic subtest ccs0: SUCCESS (1.547s)
[210.576167] Subtest busy-accuracy-50: SUCCESS (9.272s)
[210.699732] [063/133] (817s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[210.795027] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[210.796804] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[210.880296] [064/133] (817s left) i915_drm_fdinfo (busy-check-all)
[210.920959] Starting subtest: busy-check-all
[210.921938] Starting dynamic subtest: rcs0
[210.925387] Dynamic subtest rcs0: SKIP (0.003s)
[210.934161] Starting dynamic subtest: bcs0
[210.936035] Dynamic subtest bcs0: SKIP (0.000s)
[210.944549] Starting dynamic subtest: vcs0
[210.946084] Dynamic subtest vcs0: SKIP (0.000s)
[210.953472] Starting dynamic subtest: vcs1
[210.955118] Dynamic subtest vcs1: SKIP (0.000s)
[210.962135] Starting dynamic subtest: vecs0
[210.963741] Dynamic subtest vecs0: SKIP (0.001s)
[210.971005] Starting dynamic subtest: ccs0
[210.972747] Dynamic subtest ccs0: SKIP (0.001s)
[210.974592] Subtest busy-check-all: SKIP (0.015s)
[211.004586] [065/133] (817s left) kms_pm_dc (dc5-dpms)
[212.103436] Starting subtest: dc5-dpms
[214.195518] Subtest dc5-dpms: SUCCESS (2.083s)
[214.258271] [066/133] (813s left) gem_exec_reloc (basic-cpu-read-active)
[214.305159] Subtest basic-cpu-read-active: SKIP (0.000s)
[214.376981] [067/133] (813s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[214.485861] Starting subtest: short-flip-after-cursor-atomic-transitions
[215.445565] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.959s)
[216.265349] [068/133] (812s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[216.352828] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[216.355079] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[216.447675] [069/133] (811s left) gem_partial_pwrite_pread (writes-after-reads)
[216.504478] Subtest writes-after-reads: SKIP (0.000s)
[216.568987] [070/133] (811s left) gem_eio (in-flight-1us)
[216.768515] Starting subtest: in-flight-1us
[224.711944] Subtest in-flight-1us: SUCCESS (7.942s)
[224.824320] [071/133] (803s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[224.868419] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[224.973223] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[225.045137] [072/133] (803s left) gem_render_tiled_blits (basic)
[225.094783] Subtest basic: SKIP (0.000s)
[225.153652] [073/133] (803s left) prime_vgem (wait)
[225.219469] Starting subtest: wait
[225.220533] Starting dynamic subtest: rcs0
[225.253329] Dynamic subtest rcs0: SUCCESS (0.033s)
[225.261508] Starting dynamic subtest: bcs0
[225.313227] Dynamic subtest bcs0: SUCCESS (0.059s)
[225.320867] Starting dynamic subtest: vcs0
[225.360296] Dynamic subtest vcs0: SUCCESS (0.046s)
[225.368117] Starting dynamic subtest: vcs1
[225.404628] Dynamic subtest vcs1: SUCCESS (0.043s)
[225.412410] Starting dynamic subtest: vecs0
[225.451917] Dynamic subtest vecs0: SUCCESS (0.047s)
[225.459630] Starting dynamic subtest: ccs0
[225.499897] Dynamic subtest ccs0: SUCCESS (0.047s)
[225.500889] Subtest wait: SUCCESS (0.281s)
[225.617861] [074/133] (802s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[225.709254] Starting subtest: fbc-tiling-linear
[229.396636] Subtest fbc-tiling-linear: SUCCESS (3.686s)
[230.595650] [075/133] (797s left) kms_color (ctm-0-50)
[230.684496] Starting subtest: ctm-0-50
[230.685293] Starting dynamic subtest: pipe-A-eDP-1
[234.189612] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.502s)
[234.205089] Starting dynamic subtest: pipe-B-eDP-1
[238.484364] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.293s)
[238.492550] Starting dynamic subtest: pipe-C-eDP-1
[242.453671] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.968s)
[242.462431] Starting dynamic subtest: pipe-D-eDP-1
[246.445105] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.988s)
[246.445959] Subtest ctm-0-50: SUCCESS (15.756s)
[247.271975] [076/133] (781s left) kms_vblank (ts-continuation-modeset-rpm)
[247.377375] Starting subtest: ts-continuation-modeset-rpm
[247.378149] Starting dynamic subtest: pipe-A-eDP-1
[249.879680] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.500s)
[249.889318] Starting dynamic subtest: pipe-D-eDP-1
[252.124293] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.241s)
[252.125151] Subtest ts-continuation-modeset-rpm: SUCCESS (4.745s)
[252.922731] [077/133] (775s left) gem_create (create-valid-nonaligned)
[252.983016] Starting subtest: create-valid-nonaligned
[252.983983] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[253.179164] [078/133] (775s left) gem_exec_reloc (basic-cpu-gtt)
[253.241809] Subtest basic-cpu-gtt: SKIP (0.000s)
[253.295632] [079/133] (775s left) gem_exec_reloc (basic-write-cpu)
[253.350866] Subtest basic-write-cpu: SKIP (0.000s)
[253.410295] [080/133] (775s left) sysfs_preempt_timeout (invalid)
[253.466432] Starting subtest: invalid
[253.467465] Starting dynamic subtest: vecs0
[253.468470] Dynamic subtest vecs0: SUCCESS (0.000s)
[253.477356] Starting dynamic subtest: ccs0
[253.478228] Dynamic subtest ccs0: SUCCESS (0.000s)
[253.486221] Starting dynamic subtest: vcs0
[253.487131] Dynamic subtest vcs0: SUCCESS (0.000s)
[253.495272] Starting dynamic subtest: bcs0
[253.496175] Dynamic subtest bcs0: SUCCESS (0.000s)
[253.504121] Starting dynamic subtest: rcs0
[253.505071] Dynamic subtest rcs0: SUCCESS (0.000s)
[253.512934] Starting dynamic subtest: vcs1
[253.513901] Dynamic subtest vcs1: SUCCESS (0.000s)
[253.514838] Subtest invalid: SUCCESS (0.006s)
[253.544247] [081/133] (775s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[253.613430] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[253.743675] [082/133] (775s left) gem_exec_params (invalid-batch-start-offset)
[253.792697] Starting subtest: invalid-batch-start-offset
[253.796019] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[253.907208] [083/133] (774s left) perf_pmu (rc6)
[253.937771] Starting subtest: rc6
[253.938779] Starting dynamic subtest: gt0
[260.347169] Dynamic subtest gt0: SUCCESS (6.359s)
[260.357923] Starting dynamic subtest: runtime-pm-gt0
[268.110268] Dynamic subtest runtime-pm-gt0: SUCCESS (7.794s)
[268.120983] Starting dynamic subtest: runtime-pm-long-gt0
[280.547911] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.433s)
[280.560995] Starting dynamic subtest: other-idle-gt0
[286.891758] Dynamic subtest other-idle-gt0: SUCCESS (6.343s)
[286.903103] Starting dynamic subtest: gt1
[293.233537] Dynamic subtest gt1: SUCCESS (6.341s)
[293.244613] Starting dynamic subtest: runtime-pm-gt1
[300.669709] Dynamic subtest runtime-pm-gt1: SUCCESS (7.434s)
[300.680375] Starting dynamic subtest: runtime-pm-long-gt1
[313.093024] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.421s)
[313.104361] Starting dynamic subtest: other-idle-gt1
[319.437161] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[319.438717] Subtest rc6: SUCCESS (65.485s)
[320.049157] [084/133] (708s left) gem_mmap_offset (partial-unmap)
[320.098435] Starting subtest: partial-unmap
[320.099308] Starting dynamic subtest: smem0
[320.615234] Dynamic subtest smem0: SUCCESS (0.508s)
[320.616665] Subtest partial-unmap: SUCCESS (0.509s)
[320.691075] [085/133] (708s left) kms_dsc (dsc-basic)
[320.773353] Starting subtest: dsc-basic
[320.778295] Subtest dsc-basic: SKIP (0.001s)
[320.821622] [086/133] (708s left) perf_pmu (multi-client)
[320.886686] Starting subtest: multi-client
[320.887600] Starting dynamic subtest: rcs0
[321.938892] Dynamic subtest rcs0: SUCCESS (1.050s)
[321.950711] Starting dynamic subtest: bcs0
[322.998894] Dynamic subtest bcs0: SUCCESS (1.050s)
[323.012858] Starting dynamic subtest: vcs0
[324.052001] Dynamic subtest vcs0: SUCCESS (1.050s)
[324.062858] Starting dynamic subtest: vcs1
[325.185030] Dynamic subtest vcs1: SUCCESS (1.130s)
[325.196263] Starting dynamic subtest: vecs0
[327.231517] Dynamic subtest vecs0: SUCCESS (2.044s)
[327.241726] Starting dynamic subtest: ccs0
[329.218041] Dynamic subtest ccs0: SUCCESS (1.983s)
[329.219283] Subtest multi-client: SUCCESS (8.324s)
[329.302380] [087/133] (699s left) gem_exec_schedule (u-semaphore-user)
[329.353327] Starting subtest: u-semaphore-user
[329.411782] Subtest u-semaphore-user: SUCCESS (0.058s)
[331.150272] [088/133] (697s left) gem_eio (banned)
[331.330065] Starting subtest: banned
[331.864549] Subtest banned: SUCCESS (0.536s)
[332.003779] [089/133] (697s left) kms_lease (lease-revoke)
[332.090585] Starting subtest: lease-revoke
[332.091567] Starting dynamic subtest: pipe-A-eDP-1
[332.122721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[332.131925] Starting dynamic subtest: pipe-B-eDP-1
[332.150827] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[332.161456] Starting dynamic subtest: pipe-C-eDP-1
[332.183964] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.032s)
[332.194424] Starting dynamic subtest: pipe-D-eDP-1
[332.214514] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[332.215562] Subtest lease-revoke: SUCCESS (0.126s)
[332.320059] [090/133] (696s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[332.684888] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[333.485391] [091/133] (695s left) gem_exec_await (wide-contexts)
[333.664237] Starting subtest: wide-contexts
[357.109676] Subtest wide-contexts: SUCCESS (23.443s)
[357.277750] [092/133] (671s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[357.412339] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[357.484736] [093/133] (671s left) kms_dp_linktrain_fallback (dsc-fallback)
[357.593433] Starting subtest: dsc-fallback
[357.596065] Subtest dsc-fallback: SKIP (0.000s)
[357.639862] [094/133] (671s left) gem_lmem_swapping (parallel-random)
[357.680586] Subtest parallel-random: SKIP (0.000s)
[357.719896] [095/133] (671s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[357.825076] Starting subtest: y-tiled-64bpp-rotate-270
[357.826777] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[357.888014] [096/133] (671s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[357.987073] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[357.988891] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[358.051136] [097/133] (671s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[358.145418] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[365.192909] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.046s)
[365.270547] [098/133] (664s left) gem_fenced_exec_thrash (too-many-fences)
[365.315594] Subtest too-many-fences: SKIP (0.000s)
[365.384005] [099/133] (663s left) kms_big_fb (linear-16bpp-rotate-0)
[365.481398] Starting subtest: linear-16bpp-rotate-0
[366.951038] Subtest linear-16bpp-rotate-0: SUCCESS (1.469s)
[367.025116] [100/133] (662s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[367.081608] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[367.189451] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[367.240349] [101/133] (662s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[367.334688] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[367.336618] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[367.411304] [102/133] (662s left) gen7_exec_parse (basic-rejected)
[367.464251] Subtest basic-rejected: SKIP (0.000s)
[367.545500] [103/133] (661s left) api_intel_allocator (reserve-simple)
[367.604912] Starting subtest: reserve-simple
[367.609160] Subtest reserve-simple: SUCCESS (0.004s)
[367.696942] [104/133] (661s left) gem_eio (create)
[367.948083] Starting subtest: create
[368.293580] Subtest create: SUCCESS (0.345s)
[368.405824] [105/133] (661s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[368.464829] Starting subtest: y-tiled-ccs-to-yf-tiled
[368.467149] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[368.620632] [106/133] (661s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[368.722413] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[368.724169] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[368.778942] [107/133] (660s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[368.915614] Starting subtest: dp-mst-lic-type-0-hdcp14
[368.917357] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[368.993683] [108/133] (660s left) gem_create (create-ext-placement-all)
[369.172273] Starting subtest: create-ext-placement-all
[369.173347] Subtest create-ext-placement-all: SUCCESS (0.000s)
[369.239967] [109/133] (660s left) kms_cursor_crc (cursor-dpms)
[369.379466] Starting subtest: cursor-dpms
[369.380437] Starting dynamic subtest: pipe-A-eDP-1
[372.398631] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.017s)
[372.408376] Starting dynamic subtest: pipe-D-eDP-1
[376.000439] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.600s)
[376.001940] Subtest cursor-dpms: SUCCESS (6.620s)
[376.822334] [110/133] (652s left) syncobj_timeline (wait-all-complex)
[376.867825] Starting subtest: wait-all-complex
[377.091863] Subtest wait-all-complex: SUCCESS (0.215s)
[377.130285] [111/133] (652s left) kms_sequence (get-busy)
[377.211507] Starting subtest: get-busy
[377.212492] Starting dynamic subtest: pipe-A-eDP-1
[379.143323] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[379.153106] Starting dynamic subtest: pipe-B-eDP-1
[381.768622] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.623s)
[381.797774] Starting dynamic subtest: pipe-C-eDP-1
[384.363797] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.591s)
[384.372972] Starting dynamic subtest: pipe-D-eDP-1
[386.897141] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.531s)
[386.898560] Subtest get-busy: SUCCESS (9.684s)
[387.672319] [112/133] (642s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[387.762567] Starting subtest: fbcpsr-rgb101010-draw-render
[394.539373] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.770s)
[394.618953] [113/133] (635s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[394.722135] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[395.392733] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[395.540254] [114/133] (634s left) gem_busy (close-race)
[395.597848] Starting subtest: close-race
[419.208722] Subtest close-race: SUCCESS (23.602s)
[419.527013] [115/133] (610s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[419.672157] Starting subtest: fbc-rgb565-draw-mmap-gtt
[419.674232] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[419.782209] [116/133] (610s left) kms_cursor_crc (cursor-sliding-64x64)
[419.986476] Starting subtest: cursor-sliding-64x64
[419.991764] Starting dynamic subtest: pipe-A-eDP-1
[423.236506] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.245s)
[423.267138] Starting dynamic subtest: pipe-D-eDP-1
[427.077890] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.820s)
[427.078742] Subtest cursor-sliding-64x64: SUCCESS (7.094s)
[427.947797] [117/133] (602s left) gem_softpin (evict-active)
[428.001474] Starting subtest: evict-active
[428.007038] Subtest evict-active: SUCCESS (0.005s)
[428.064779] [118/133] (602s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[428.437756] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[429.280733] [119/133] (600s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[429.365457] Starting subtest: psr-rgb101010-draw-pwrite
[437.381167] Subtest psr-rgb101010-draw-pwrite: SUCCESS (8.017s)
[437.467724] [120/133] (592s left) kms_cdclk (mode-transition-all-outputs)
[437.562026] Starting subtest: mode-transition-all-outputs
[437.853844] Subtest mode-transition-all-outputs: SKIP (0.291s)
[438.637623] [121/133] (591s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[438.724657] Starting subtest: fbc-pr-sprite-mmap-cpu
[438.726648] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[438.770592] [122/133] (591s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[438.850994] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[438.852608] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[438.893571] [123/133] (591s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[438.989567] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[440.033744] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.044s)
[440.119475] [124/133] (590s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[440.210781] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[440.211723] Starting dynamic subtest: pipe-A-eDP-1
[440.234569] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[440.244744] Starting dynamic subtest: pipe-B-eDP-1
[440.275860] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[440.285274] Starting dynamic subtest: pipe-C-eDP-1
[440.307157] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[440.315866] Starting dynamic subtest: pipe-D-eDP-1
[440.336914] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[440.338524] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[442.505878] [125/133] (587s left) gem_exec_fence (syncobj-import)
[442.971531] Starting subtest: syncobj-import
[442.977617] Subtest syncobj-import: SUCCESS (0.006s)
[444.220637] [126/133] (586s left) kms_psr (psr2-sprite-plane-move)
[444.323506] Starting subtest: psr2-sprite-plane-move
[444.324373] Starting dynamic subtest: eDP-1
[446.047639] Dynamic subtest eDP-1: SUCCESS (1.724s)
[446.048601] Subtest psr2-sprite-plane-move: SUCCESS (1.725s)
[446.857765] [127/133] (583s left) kms_atomic_transition (modeset-transition-fencing)
[446.957803] Starting subtest: modeset-transition-fencing
[446.958975] Starting dynamic subtest: 1x-outputs
[457.802941] Dynamic subtest 1x-outputs: SUCCESS (10.845s)
[457.804258] Subtest modeset-transition-fencing: SUCCESS (10.847s)
[458.632024] [128/133] (571s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[458.716975] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[465.808516] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.079s)
[465.895268] [129/133] (564s left) gem_exec_balancer (busy)
[465.964372] Starting subtest: busy
[467.204766] Subtest busy: SUCCESS (1.231s)
[467.484660] [130/133] (563s left) kms_flip (flip-vs-blocking-wf-vblank)
[467.583707] Starting subtest: flip-vs-blocking-wf-vblank
[467.586028] Starting dynamic subtest: A-eDP1
[476.521347] Dynamic subtest A-eDP1: SUCCESS (8.936s)
[476.535016] Starting dynamic subtest: B-eDP1
[485.466734] Dynamic subtest B-eDP1: SUCCESS (8.943s)
[485.496139] Starting dynamic subtest: C-eDP1
[494.425624] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[494.438878] Starting dynamic subtest: D-eDP1
[503.353583] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[503.354620] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.732s)
[504.529902] [131/133] (526s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[504.621716] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[509.147172] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.526s)
[510.227977] [132/133] (520s left) gem_create (create-invalid-size)
[510.287494] Starting subtest: create-invalid-size
[510.288420] Subtest create-invalid-size: SUCCESS (0.000s)
[510.453687] [133/133] (520s left) kms_psr (psr-sprite-render)
[510.536634] Starting subtest: psr-sprite-render
[510.537560] Starting dynamic subtest: eDP-1
[512.282083] Dynamic subtest eDP-1: SUCCESS (1.745s)
[512.283005] Subtest psr-sprite-render: SUCCESS (1.746s)
[513.084276] 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.