[62.373146] Initializing watchdogs
[62.373306]   /dev/watchdog0
[62.388338] [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]
[62.392574] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.394928] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.398170] [001/130] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[62.525474] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[62.529648] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[62.663862] [002/130] (960s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[62.761302] Starting subtest: plane-primary-overlay-mutable-zpos
[66.234763] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.483s)
[67.472110] [003/130] (955s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[67.692378] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[67.694917] Starting dynamic subtest: pipe-A-default-mode
[67.983158] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[67.988172] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.288s)
[68.851616] [004/130] (954s left) vgem_basic (dmabuf-mmap)
[68.917762] Starting subtest: dmabuf-mmap
[68.937705] Subtest dmabuf-mmap: SUCCESS (0.022s)
[69.016427] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[69.019609] [005/130] (954s left) kms_invalid_mode (zero-vdisplay)
[69.105182] Starting subtest: zero-vdisplay
[69.107446] Starting dynamic subtest: pipe-A-eDP-1
[69.391269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[69.398227] Starting dynamic subtest: pipe-B-eDP-1
[69.400455] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[69.407210] Starting dynamic subtest: pipe-C-eDP-1
[69.409525] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[69.416219] Starting dynamic subtest: pipe-D-eDP-1
[69.418396] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[69.420695] Subtest zero-vdisplay: SUCCESS (0.291s)
[70.272909] [006/130] (952s left) gem_spin_batch (engines)
[70.347036] Starting subtest: engines
[70.349315] Starting dynamic subtest: rcs0
[73.586027] Dynamic subtest rcs0: SUCCESS (3.238s)
[73.593685] Starting dynamic subtest: bcs0
[76.819540] Dynamic subtest bcs0: SUCCESS (3.234s)
[76.827174] Starting dynamic subtest: vcs0
[80.053995] Dynamic subtest vcs0: SUCCESS (3.234s)
[80.063620] Starting dynamic subtest: vcs1
[83.288973] Dynamic subtest vcs1: SUCCESS (3.234s)
[83.298519] Starting dynamic subtest: vecs0
[86.521470] Dynamic subtest vecs0: SUCCESS (3.232s)
[86.531134] Starting dynamic subtest: ccs0
[89.759456] Dynamic subtest ccs0: SUCCESS (3.236s)
[89.761907] Subtest engines: SUCCESS (19.414s)
[89.964177] [007/130] (933s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[90.031794] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[90.034102] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[90.155299] [008/130] (933s left) kms_pm_backlight (brightness-with-dpms)
[90.271194] Starting subtest: brightness-with-dpms
[90.328133] Starting dynamic subtest: eDP-1
[92.735811] Dynamic subtest eDP-1: SUCCESS (2.405s)
[92.738055] Subtest brightness-with-dpms: SUCCESS (2.465s)
[93.619971] [009/130] (929s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[93.714572] Starting subtest: fbcpsr-tiling-linear
[100.307648] Subtest fbcpsr-tiling-linear: SUCCESS (6.594s)
[100.476904] [010/130] (922s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[100.574963] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[100.579485] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[100.716204] [011/130] (922s left) kms_color (ctm-max)
[100.814644] Starting subtest: ctm-max
[100.816534] Starting dynamic subtest: pipe-A-eDP-1
[101.549474] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[101.558256] Starting dynamic subtest: pipe-B-eDP-1
[102.912571] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.363s)
[102.921300] Starting dynamic subtest: pipe-C-eDP-1
[104.315328] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s)
[104.323889] Starting dynamic subtest: pipe-D-eDP-1
[105.643370] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[105.645723] Subtest ctm-max: SUCCESS (4.828s)
[106.467733] [012/130] (916s left) kms_psr (psr2-primary-mmap-gtt)
[106.563204] Starting subtest: psr2-primary-mmap-gtt
[106.565594] Starting dynamic subtest: eDP-1
[107.952978] Dynamic subtest eDP-1: SKIP (1.387s)
[107.958082] Subtest psr2-primary-mmap-gtt: SKIP (1.388s)
[108.114404] [013/130] (915s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[108.219160] Starting subtest: fbcpsr-shrfb-scaledprimary
[114.012059] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.795s)
[114.155016] [014/130] (909s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[114.255760] Starting subtest: y-tiled-32bpp-rotate-180
[114.259768] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[114.382268] [015/130] (909s left) perf_pmu (busy-idle)
[114.419368] Starting subtest: busy-idle
[114.421632] Starting dynamic subtest: rcs0
[115.132764] Dynamic subtest rcs0: SUCCESS (0.713s)
[115.143415] Starting dynamic subtest: bcs0
[115.791305] Dynamic subtest bcs0: SUCCESS (0.658s)
[115.802560] Starting dynamic subtest: vcs0
[116.884134] Dynamic subtest vcs0: SUCCESS (1.091s)
[116.895288] Starting dynamic subtest: vcs1
[118.933237] Dynamic subtest vcs1: SUCCESS (2.047s)
[118.943721] Starting dynamic subtest: vecs0
[120.917217] Dynamic subtest vecs0: SUCCESS (1.982s)
[120.927499] Starting dynamic subtest: ccs0
[121.591703] Dynamic subtest ccs0: SUCCESS (0.674s)
[121.594339] Subtest busy-idle: SUCCESS (7.172s)
[121.749894] [016/130] (901s left) gem_madvise (dontneed-before-exec)
[121.779917] Starting subtest: dontneed-before-exec
[121.803965] Subtest dontneed-before-exec: SKIP (0.019s)
[121.862539] [017/130] (901s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[126.906937] Starting subtest: psr2-overlay-plane-update-continuous-sf
[126.909333] Starting dynamic subtest: pipe-A-eDP-1
[128.653330] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.745s)
[128.663425] Starting dynamic subtest: pipe-B-eDP-1
[130.404857] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.751s)
[130.407135] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.500s)
[131.242862] [018/130] (892s left) kms_flip (absolute-wf_vblank-interruptible)
[131.354375] Starting subtest: absolute-wf_vblank-interruptible
[131.356685] Starting dynamic subtest: A-eDP1
[140.081402] Dynamic subtest A-eDP1: SUCCESS (8.726s)
[140.091669] Starting dynamic subtest: B-eDP1
[148.811519] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[148.822266] Starting dynamic subtest: C-eDP1
[157.522456] Dynamic subtest C-eDP1: SUCCESS (8.709s)
[157.532393] Starting dynamic subtest: D-eDP1
[166.263015] Dynamic subtest D-eDP1: SUCCESS (8.739s)
[166.265432] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.908s)
[167.496847] [019/130] (856s left) gem_exec_big (single)
[167.553972] Starting subtest: single
[169.913169] Subtest single: SUCCESS (2.357s)
[170.141225] [020/130] (853s left) syncobj_timeline (invalid-query-zero-handles)
[170.245319] Starting subtest: invalid-query-zero-handles
[170.247730] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[170.373667] [021/130] (853s left) kms_prop_blob (blob-prop-lifetime)
[170.438575] Starting subtest: blob-prop-lifetime
[170.441057] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[170.572255] [022/130] (853s left) kms_frontbuffer_tracking (fbc-suspend)
[170.684951] Starting subtest: fbc-suspend
[209.319329] Subtest fbc-suspend: SUCCESS (11.142s)
[210.510167] [023/130] (813s left) kms_getfb (getfb-handle-zero)
[210.628902] Starting subtest: getfb-handle-zero
[210.631242] Subtest getfb-handle-zero: SUCCESS (0.000s)
[210.758114] [024/130] (813s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[210.808628] Starting subtest: etime-single-wait-for-submit-unsubmitted
[210.915044] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[211.010692] [025/130] (812s left) sriov_basic (enable-vfs-autoprobe-on)
[211.067263] Starting subtest: enable-vfs-autoprobe-on
[211.069997] Starting dynamic subtest: numvfs-1
[211.149037] Dynamic subtest numvfs-1: FAIL (0.030s)
[211.157707] Starting dynamic subtest: numvfs-2
[211.228748] Dynamic subtest numvfs-2: FAIL (0.003s)
[211.238785] Starting dynamic subtest: numvfs-3
[211.309558] Dynamic subtest numvfs-3: FAIL (0.003s)
[211.319906] Starting dynamic subtest: numvfs-4
[211.391772] Dynamic subtest numvfs-4: FAIL (0.003s)
[211.401329] Starting dynamic subtest: numvfs-5
[211.473537] Dynamic subtest numvfs-5: FAIL (0.003s)
[211.483914] Starting dynamic subtest: numvfs-6
[211.554336] Dynamic subtest numvfs-6: FAIL (0.003s)
[211.564471] Starting dynamic subtest: numvfs-7
[211.636367] Dynamic subtest numvfs-7: FAIL (0.007s)
[211.646526] Starting dynamic subtest: numvfs-random
[211.715198] Dynamic subtest numvfs-random: FAIL (0.005s)
[211.725637] Starting dynamic subtest: numvfs-all
[211.796716] Dynamic subtest numvfs-all: FAIL (0.511s)
[211.798653] Subtest enable-vfs-autoprobe-on: FAIL (0.576s)
[211.836032] [026/130] (812s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[211.936837] Starting subtest: fbcpsr-rgb565-draw-pwrite
[218.867288] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.018s)
[219.017502] [027/130] (804s left) i915_pm_rps (waitboost)
[219.087024] Starting subtest: waitboost
[225.428276] Subtest waitboost: SUCCESS (6.373s)
[225.533872] [028/130] (798s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[225.923570] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[226.770928] [029/130] (797s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[226.869730] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[226.874037] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[227.009255] [030/130] (797s left) kms_vblank (ts-continuation-modeset-hang)
[227.096894] Starting subtest: ts-continuation-modeset-hang
[227.099144] Starting dynamic subtest: pipe-A-eDP-1
[253.297513] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.207s)
[253.312428] Starting dynamic subtest: pipe-D-eDP-1
[278.254654] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.956s)
[278.256653] Subtest ts-continuation-modeset-hang: SUCCESS (51.167s)
[279.136945] [031/130] (745s left) i915_drm_fdinfo (busy-idle)
[279.178038] Starting subtest: busy-idle
[279.180464] Starting dynamic subtest: rcs0
[279.204050] Dynamic subtest rcs0: SKIP (0.024s)
[279.215276] Starting dynamic subtest: bcs0
[279.223998] Dynamic subtest bcs0: SKIP (0.019s)
[279.233073] Starting dynamic subtest: vcs0
[279.237526] Dynamic subtest vcs0: SKIP (0.000s)
[279.246767] Starting dynamic subtest: vcs1
[279.251089] Dynamic subtest vcs1: SKIP (0.000s)
[279.259743] Starting dynamic subtest: vecs0
[279.264206] Dynamic subtest vecs0: SKIP (0.000s)
[279.272915] Starting dynamic subtest: ccs0
[279.277416] Dynamic subtest ccs0: SKIP (0.000s)
[279.281774] Subtest busy-idle: SKIP (0.048s)
[279.320249] [032/130] (744s left) gem_partial_pwrite_pread (write-uncached)
[279.368025] Subtest write-uncached: SKIP (0.000s)
[279.455327] [033/130] (744s left) syncobj_timeline (32bits-limit)
[279.519397] Starting subtest: 32bits-limit
[279.521806] Subtest 32bits-limit: SUCCESS (0.001s)
[279.650511] [034/130] (744s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[279.704924] Subtest tiled-to-untiled: SKIP (0.000s)
[279.776846] [035/130] (744s left) gem_exec_params (invalid-fence-in-submit)
[279.849634] Starting subtest: invalid-fence-in-submit
[279.852112] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[280.012830] [036/130] (744s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[280.078740] Starting subtest: multi-wait-all-for-submit-unsubmitted
[280.187697] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[280.286126] [037/130] (744s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[280.354877] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[280.427248] [038/130] (744s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[280.535065] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[280.539515] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[280.665355] [039/130] (743s left) syncobj_timeline (multi-wait-submitted-signaled)
[280.724328] Starting subtest: multi-wait-submitted-signaled
[280.726313] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[280.855673] [040/130] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[280.960488] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[288.166261] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.207s)
[288.361894] [041/130] (736s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[288.458676] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[288.461339] Starting dynamic subtest: pipe-A-default-mode
[288.755154] Dynamic subtest pipe-A-default-mode: SKIP (0.295s)
[288.759820] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.297s)
[289.607312] [042/130] (734s left) gem_exec_schedule (semaphore-resolve)
[289.691300] Starting subtest: semaphore-resolve
[289.721061] Subtest semaphore-resolve: SUCCESS (0.039s)
[290.098502] [043/130] (734s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[290.202239] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[290.204471] Starting dynamic subtest: pipe-A-eDP-1
[290.227395] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[290.238756] Starting dynamic subtest: pipe-B-eDP-1
[290.260033] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[290.269152] Starting dynamic subtest: pipe-C-eDP-1
[290.290784] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[290.299882] Starting dynamic subtest: pipe-D-eDP-1
[290.321740] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[290.325824] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[292.471050] [044/130] (732s left) dmabuf_sync_file (import-basic)
[292.510620] Starting subtest: import-basic
[292.512905] Subtest import-basic: SUCCESS (0.001s)
[292.591230] [045/130] (732s left) gem_caching (reads)
[292.647180] Subtest reads: SKIP (0.000s)
[292.724768] [046/130] (732s left) gem_lmem_swapping (parallel-random-engines)
[292.767160] Subtest parallel-random-engines: SKIP (0.000s)
[292.815132] [047/130] (731s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[292.903584] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[292.907749] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[293.046702] [048/130] (731s left) gem_wait (wait)
[293.116371] Starting subtest: wait
[293.118603] Starting dynamic subtest: all-engines
[294.504543] Dynamic subtest all-engines: SUCCESS (1.386s)
[294.516519] Starting dynamic subtest: rcs0
[295.550191] Dynamic subtest rcs0: SUCCESS (1.045s)
[295.562337] Starting dynamic subtest: bcs0
[296.597046] Dynamic subtest bcs0: SUCCESS (1.045s)
[296.608689] Starting dynamic subtest: vcs0
[297.642780] Dynamic subtest vcs0: SUCCESS (1.043s)
[297.653898] Starting dynamic subtest: vcs1
[298.686681] Dynamic subtest vcs1: SUCCESS (1.042s)
[298.698726] Starting dynamic subtest: vecs0
[299.730517] Dynamic subtest vecs0: SUCCESS (1.042s)
[299.742381] Starting dynamic subtest: ccs0
[300.779557] Dynamic subtest ccs0: SUCCESS (1.048s)
[300.781973] Subtest wait: SUCCESS (7.666s)
[301.004623] [049/130] (723s left) kms_flip (blocking-absolute-wf_vblank)
[301.119140] Starting subtest: blocking-absolute-wf_vblank
[301.121459] Starting dynamic subtest: A-eDP1
[309.910310] Dynamic subtest A-eDP1: SUCCESS (8.790s)
[309.926286] Starting dynamic subtest: B-eDP1
[318.646891] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[318.656180] Starting dynamic subtest: C-eDP1
[327.362205] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[327.372543] Starting dynamic subtest: D-eDP1
[336.090250] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[336.094705] Subtest blocking-absolute-wf_vblank: SUCCESS (34.972s)
[337.320388] [050/130] (687s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[337.712130] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[338.505377] [051/130] (686s left) kms_psr (fbc-psr2-sprite-blt)
[338.608715] Starting subtest: fbc-psr2-sprite-blt
[338.611086] Starting dynamic subtest: eDP-1
[338.615635] Dynamic subtest eDP-1: SKIP (0.000s)
[338.620213] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[338.709561] [052/130] (686s left) gem_exec_params (dr4-dirt)
[338.765899] Starting subtest: DR4-dirt
[338.768492] Subtest DR4-dirt: SUCCESS (0.000s)
[338.893011] [053/130] (686s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[339.011547] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[339.970938] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.958s)
[340.788001] [054/130] (684s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[340.851460] Subtest writes-after-reads-snoop: SKIP (0.000s)
[340.933835] [055/130] (684s left) kms_force_connector_basic (force-edid)
[341.015201] Starting subtest: force-edid
[341.383770] Subtest force-edid: SUCCESS (0.368s)
[341.554073] [056/130] (683s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[341.656195] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[341.658042] Starting dynamic subtest: pipe-A-eDP-1
[342.393647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.730s)
[342.402601] Starting dynamic subtest: pipe-B-eDP-1
[344.166135] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.770s)
[344.174725] Starting dynamic subtest: pipe-C-eDP-1
[345.970847] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.804s)
[345.981126] Starting dynamic subtest: pipe-D-eDP-1
[347.763411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.790s)
[347.765855] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.100s)
[348.918321] [057/130] (676s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[349.021315] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[349.026040] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[350.209899] [058/130] (675s left) gem_ctx_isolation (dirty-switch)
[350.287045] Starting subtest: dirty-switch
[350.289325] Starting dynamic subtest: rcs0
[350.498154] Dynamic subtest rcs0: SUCCESS (0.210s)
[350.507354] Starting dynamic subtest: bcs0
[350.734667] Dynamic subtest bcs0: SUCCESS (0.235s)
[350.746746] Starting dynamic subtest: vcs0
[350.964811] Dynamic subtest vcs0: SUCCESS (0.230s)
[350.973660] Starting dynamic subtest: vcs1
[352.705158] Dynamic subtest vcs1: SUCCESS (1.738s)
[352.717263] Starting dynamic subtest: vecs0
[354.760000] Dynamic subtest vecs0: SUCCESS (2.054s)
[354.771166] Starting dynamic subtest: ccs0
[356.767675] Dynamic subtest ccs0: SUCCESS (2.006s)
[356.770575] Subtest dirty-switch: SUCCESS (6.481s)
[357.055613] [059/130] (668s left) gem_pwrite (basic-self)
[357.115889] Subtest basic-self: SKIP (0.000s)
[357.177550] [060/130] (668s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[362.172487] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[362.174456] Starting dynamic subtest: pipe-A-eDP-1
[368.974354] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.802s)
[368.984201] Starting dynamic subtest: pipe-B-eDP-1
[375.923067] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.949s)
[375.925328] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.756s)
[376.801929] [061/130] (648s left) gem_exec_whisper (basic-queues-priority-all)
[376.876391] Starting subtest: basic-queues-priority-all
[398.775845] Subtest basic-queues-priority-all: SUCCESS (21.901s)
[398.982558] [062/130] (626s left) i915_pm_rpm (gem-execbuf-stress)
[400.619516] Starting subtest: gem-execbuf-stress
[400.621923] Starting dynamic subtest: smem0
[413.470313] Dynamic subtest smem0: SUCCESS (12.851s)
[413.482970] Starting dynamic subtest: extra-wait-smem0
[475.261043] Dynamic subtest extra-wait-smem0: SUCCESS (61.780s)
[475.264014] Subtest gem-execbuf-stress: SUCCESS (74.638s)
[475.640207] [063/130] (549s left) gem_pipe_control_store_loop (reused-buffer)
[475.711043] Starting subtest: reused-buffer
[477.865626] Subtest reused-buffer: SUCCESS (2.152s)
[478.011641] [064/130] (547s left) syncobj_wait (wait-any-complex)
[478.063107] Starting subtest: wait-any-complex
[478.125010] Subtest wait-any-complex: SUCCESS (0.062s)
[478.227638] [065/130] (547s left) kms_draw_crc (draw-method-blt)
[478.325754] Starting subtest: draw-method-blt
[478.327545] Starting dynamic subtest: xrgb8888-untiled
[478.559154] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[478.569671] Starting dynamic subtest: rgb565-untiled
[478.758686] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[478.768255] Starting dynamic subtest: xrgb2101010-untiled
[478.970043] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.209s)
[478.978916] Starting dynamic subtest: xbgr16161616f-untiled
[479.190373] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[479.200290] Starting dynamic subtest: xrgb8888-xtiled
[479.301604] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[479.311493] Starting dynamic subtest: rgb565-xtiled
[479.412592] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[479.421459] Starting dynamic subtest: xrgb2101010-xtiled
[479.523916] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[479.532989] Starting dynamic subtest: xbgr16161616f-xtiled
[479.634882] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[479.643610] Starting dynamic subtest: xrgb8888-4tiled
[479.745831] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s)
[479.755565] Starting dynamic subtest: rgb565-4tiled
[479.846330] Dynamic subtest rgb565-4tiled: SUCCESS (0.099s)
[479.857464] Starting dynamic subtest: xrgb2101010-4tiled
[479.956801] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.109s)
[479.966543] Starting dynamic subtest: xbgr16161616f-4tiled
[480.068232] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[480.070042] Subtest draw-method-blt: SUCCESS (1.745s)
[480.212123] [066/130] (545s left) gem_exec_whisper (basic-contexts)
[480.281645] Starting subtest: basic-contexts
[487.497917] Subtest basic-contexts: SUCCESS (7.214s)
[487.708174] [067/130] (537s left) gem_exec_schedule (preempt-other)
[487.793104] Starting subtest: preempt-other
[487.795142] Starting dynamic subtest: rcs0
[487.912805] Dynamic subtest rcs0: SUCCESS (0.123s)
[487.927881] Starting dynamic subtest: bcs0
[488.025114] Dynamic subtest bcs0: SUCCESS (0.113s)
[488.039415] Starting dynamic subtest: vcs0
[488.134094] Dynamic subtest vcs0: SUCCESS (0.108s)
[488.150451] Starting dynamic subtest: vcs1
[488.244358] Dynamic subtest vcs1: SUCCESS (0.109s)
[488.259868] Starting dynamic subtest: vecs0
[488.354207] Dynamic subtest vecs0: SUCCESS (0.110s)
[488.367039] Starting dynamic subtest: ccs0
[488.464536] Dynamic subtest ccs0: SUCCESS (0.109s)
[488.467281] Subtest preempt-other: SUCCESS (0.677s)
[489.649971] [068/130] (536s left) kms_psr (pr-primary-mmap-gtt)
[489.751808] Starting subtest: pr-primary-mmap-gtt
[489.756098] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[489.850566] [069/130] (535s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[489.943132] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[489.945467] Starting dynamic subtest: pipe-A
[489.965736] Dynamic subtest pipe-A: SKIP (0.018s)
[489.976841] Starting dynamic subtest: pipe-B
[489.998271] Dynamic subtest pipe-B: SKIP (0.033s)
[490.008219] Starting dynamic subtest: pipe-C
[490.034630] Dynamic subtest pipe-C: SKIP (0.032s)
[490.045148] Starting dynamic subtest: pipe-D
[490.065145] Dynamic subtest pipe-D: SKIP (0.035s)
[490.069254] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.120s)
[490.197364] [070/130] (535s left) gem_exec_flush (basic-uc-set-default)
[490.263387] Starting subtest: basic-uc-set-default
[495.728178] Subtest basic-uc-set-default: SUCCESS (5.466s)
[495.942164] [071/130] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[496.038380] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[496.042927] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[496.159291] [072/130] (529s left) gem_tiled_partial_pwrite_pread (reads)
[496.220968] Subtest reads: SKIP (0.000s)
[496.289158] [073/130] (529s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[496.381946] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[496.386154] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[496.497985] [074/130] (529s left) gem_exec_parallel (contexts)
[496.560655] Starting subtest: contexts
[496.562866] Starting dynamic subtest: rcs0
[499.266173] Dynamic subtest rcs0: SUCCESS (2.703s)
[499.278996] Starting dynamic subtest: bcs0
[502.953089] Dynamic subtest bcs0: SUCCESS (3.684s)
[502.965611] Starting dynamic subtest: vcs0
[507.077454] Dynamic subtest vcs0: SUCCESS (4.121s)
[507.090371] Starting dynamic subtest: vcs1
[510.949490] Dynamic subtest vcs1: SUCCESS (3.871s)
[510.960680] Starting dynamic subtest: vecs0
[515.009654] Dynamic subtest vecs0: SUCCESS (4.058s)
[515.019850] Starting dynamic subtest: ccs0
[518.588811] Dynamic subtest ccs0: SUCCESS (3.578s)
[518.591210] Subtest contexts: SUCCESS (22.028s)
[518.801447] [075/130] (507s left) prime_mmap (test_refcounting)
[518.862928] Starting subtest: test_refcounting
[518.865268] Starting dynamic subtest: test_refcounting-smem
[518.903477] Dynamic subtest test_refcounting-smem: SUCCESS (0.040s)
[518.905856] Subtest test_refcounting: SUCCESS (0.042s)
[519.032310] [076/130] (506s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[519.161181] Starting subtest: cursorB-vs-flipB-toggle
[519.165537] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[519.328312] [077/130] (506s left) gem_basic (bad-close)
[519.378530] Starting subtest: bad-close
[519.383053] Subtest bad-close: SUCCESS (0.000s)
[519.520613] [078/130] (506s left) kms_getfb (getfb2-handle-closed)
[519.611168] Starting subtest: getfb2-handle-closed
[519.613496] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[519.750733] [079/130] (506s left) gem_ctx_persistence (legacy-engines-hostile)
[519.814627] Starting subtest: legacy-engines-hostile
[519.816712] Starting dynamic subtest: render
[519.924361] Dynamic subtest render: SUCCESS (0.109s)
[519.940068] Starting dynamic subtest: bsd1
[520.041392] Dynamic subtest bsd1: SUCCESS (0.114s)
[520.054457] Starting dynamic subtest: bsd2
[520.163094] Dynamic subtest bsd2: SUCCESS (0.119s)
[520.175768] Starting dynamic subtest: blt
[520.288388] Dynamic subtest blt: SUCCESS (0.122s)
[520.303101] Starting dynamic subtest: vebox
[520.369133] Dynamic subtest vebox: SUCCESS (0.078s)
[520.371171] Subtest legacy-engines-hostile: SUCCESS (0.556s)
[520.549103] [080/130] (505s left) kms_cursor_crc (cursor-onscreen-128x42)
[520.760608] Starting subtest: cursor-onscreen-128x42
[520.806642] Subtest cursor-onscreen-128x42: SKIP (0.042s)
[521.039908] [081/130] (505s left) perf_pmu (render-node-busy)
[521.131633] Starting subtest: render-node-busy
[521.133866] Starting dynamic subtest: rcs0
[521.742577] Dynamic subtest rcs0: SUCCESS (0.609s)
[521.754802] Starting dynamic subtest: bcs0
[522.305831] Dynamic subtest bcs0: SUCCESS (0.561s)
[522.317991] Starting dynamic subtest: vcs0
[523.497224] Dynamic subtest vcs0: SUCCESS (1.188s)
[523.510668] Starting dynamic subtest: vcs1
[525.542459] Dynamic subtest vcs1: SUCCESS (2.042s)
[525.554418] Starting dynamic subtest: vecs0
[527.464189] Dynamic subtest vecs0: SUCCESS (1.920s)
[527.480174] Starting dynamic subtest: ccs0
[528.037661] Dynamic subtest ccs0: SUCCESS (0.572s)
[528.040343] Subtest render-node-busy: SUCCESS (6.907s)
[528.141751] [082/130] (498s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[528.245153] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[532.185215] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.943s)
[533.387603] [083/130] (492s left) gem_exec_balancer (hang)
[533.660735] Starting subtest: hang
[535.569277] Subtest hang: SUCCESS (1.911s)
[535.725941] [084/130] (490s left) kms_cursor_crc (cursor-random-max-size)
[536.017143] Starting subtest: cursor-random-max-size
[536.023711] Subtest cursor-random-max-size: SKIP (0.000s)
[536.178049] [085/130] (490s left) kms_cursor_edge_walk (64x64-left-edge)
[536.276931] Starting subtest: 64x64-left-edge
[536.279235] Starting dynamic subtest: pipe-A-eDP-1
[539.711708] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.433s)
[539.722665] Starting dynamic subtest: pipe-D-eDP-1
[542.872441] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.160s)
[542.874707] Subtest 64x64-left-edge: SUCCESS (6.596s)
[543.701478] [086/130] (482s left) kms_chamelium_audio (hdmi-audio-edid)
[544.091504] Subtest hdmi-audio-edid: SKIP (0.000s)
[544.940870] [087/130] (481s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[545.040478] Starting subtest: x-tiled-8bpp-rotate-180
[546.175306] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.134s)
[546.347532] [088/130] (480s left) kms_psr (psr-sprite-plane-move)
[546.444313] Starting subtest: psr-sprite-plane-move
[546.446084] Starting dynamic subtest: eDP-1
[548.254530] Dynamic subtest eDP-1: SUCCESS (1.811s)
[548.256763] Subtest psr-sprite-plane-move: SUCCESS (1.812s)
[549.084201] [089/130] (477s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[549.175234] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[549.177532] Starting dynamic subtest: pipe-A-eDP-1
[566.128432] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.416s)
[566.138982] Starting dynamic subtest: pipe-B-eDP-1
[583.137409] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.465s)
[583.149555] Starting dynamic subtest: pipe-C-eDP-1
[600.050969] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.416s)
[600.061231] Starting dynamic subtest: pipe-D-eDP-1
[617.079076] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.420s)
[617.081310] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.722s)
[618.307252] [090/130] (408s left) kms_cursor_crc (cursor-sliding-256x85)
[618.562485] Starting subtest: cursor-sliding-256x85
[618.607638] Subtest cursor-sliding-256x85: SKIP (0.041s)
[618.834435] [091/130] (407s left) gem_pxp (reject-modify-context-protection-on)
[618.952834] Starting subtest: reject-modify-context-protection-on
[618.955147] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[619.100361] [092/130] (407s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[619.187304] Starting subtest: coverage-vs-premult-vs-constant
[619.443323] Starting dynamic subtest: pipe-A-eDP-1
[619.992645] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s)
[620.002983] Starting dynamic subtest: pipe-D-eDP-1
[621.285019] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[621.287333] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.149s)
[622.122398] [093/130] (404s left) kms_flip (flip-vs-suspend)
[622.232758] Starting subtest: flip-vs-suspend
[622.234947] Starting dynamic subtest: A-eDP1
[671.970969] Dynamic subtest A-eDP1: SUCCESS (4.739s)
[671.986521] Starting dynamic subtest: B-eDP1
[720.922604] Dynamic subtest B-eDP1: SUCCESS (4.514s)
[720.942218] Starting dynamic subtest: C-eDP1
[769.942268] Dynamic subtest C-eDP1: SUCCESS (4.578s)
[769.954610] Starting dynamic subtest: D-eDP1
[818.938430] Dynamic subtest D-eDP1: SUCCESS (4.546s)
[818.940928] Subtest flip-vs-suspend: SUCCESS (18.387s)
[820.171213] [094/130] (206s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[820.283911] Starting subtest: 4-tiled-addfb-size-offset-overflow
[820.285686] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[820.416145] [095/130] (206s left) kms_async_flips (async-flip-hang)
[820.509054] Starting subtest: async-flip-hang
[820.883768] Starting dynamic subtest: pipe-A-eDP-1
[836.030047] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.306s)
[836.424275] Starting dynamic subtest: pipe-B-eDP-1
[852.065521] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.674s)
[852.451938] Starting dynamic subtest: pipe-C-eDP-1
[868.134023] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.700s)
[868.511958] Starting dynamic subtest: pipe-D-eDP-1
[884.070718] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.575s)
[884.073510] Subtest async-flip-hang: SUCCESS (63.779s)
[885.338254] [096/130] (141s left) gem_exec_fence (invalid-fence-array)
[885.817010] Starting subtest: invalid-fence-array
[885.819561] Subtest invalid-fence-array: SUCCESS (0.003s)
[887.775773] [097/130] (139s left) kms_pm_rpm (fences-dpms)
[889.808759] Starting subtest: fences-dpms
[889.814518] Subtest fences-dpms: SKIP (0.000s)
[890.219913] [098/130] (136s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[890.317494] Starting subtest: psr-rgb101010-draw-pwrite
[897.823072] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.513s)
[897.961046] [099/130] (129s left) kms_setmode (basic-clone-single-crtc)
[898.022744] Starting subtest: basic-clone-single-crtc
[898.029680] Subtest basic-clone-single-crtc: SKIP (0.000s)
[898.151496] [100/130] (128s left) gem_mmap_gtt (fault-concurrent)
[898.221460] Subtest fault-concurrent: SKIP (0.000s)
[898.284161] [101/130] (128s left) kms_sequence (get-forked-busy)
[898.389247] Starting subtest: get-forked-busy
[898.391511] Starting dynamic subtest: pipe-A-eDP-1
[900.322146] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[900.332366] Starting dynamic subtest: pipe-B-eDP-1
[902.968979] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.645s)
[902.980110] Starting dynamic subtest: pipe-C-eDP-1
[905.553821] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.588s)
[905.565276] Starting dynamic subtest: pipe-D-eDP-1
[908.135646] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.579s)
[908.137919] Subtest get-forked-busy: SUCCESS (9.751s)
[909.017562] [102/130] (118s left) kms_big_fb (linear-64bpp-rotate-270)
[909.121855] Starting subtest: linear-64bpp-rotate-270
[909.140564] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[909.305105] [103/130] (117s left) gem_mmap_gtt (hang-busy)
[909.375518] Subtest hang-busy: SKIP (0.000s)
[909.430701] [104/130] (117s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[914.467154] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[914.471593] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[915.320363] [105/130] (111s left) syncobj_timeline (single-wait-signaled)
[915.382613] Starting subtest: single-wait-signaled
[915.384869] Subtest single-wait-signaled: SUCCESS (0.000s)
[915.520269] [106/130] (111s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[915.629070] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[922.762221] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.115s)
[922.912599] [107/130] (104s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[922.979597] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[922.983953] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[923.193903] [108/130] (104s left) kms_frontbuffer_tracking (fbc-stridechange)
[923.300017] Starting subtest: fbc-stridechange
[926.587334] Subtest fbc-stridechange: SUCCESS (3.283s)
[927.769399] [109/130] ( 99s left) fbdev (pan)
[927.807661] Starting subtest: pan
[927.837108] Subtest pan: SUCCESS (0.031s)
[927.933350] [110/130] ( 99s left) kms_psr (fbc-psr-sprite-plane-onoff)
[928.034049] Starting subtest: fbc-psr-sprite-plane-onoff
[928.035915] Starting dynamic subtest: eDP-1
[928.040029] Dynamic subtest eDP-1: SKIP (0.000s)
[928.044091] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[928.150376] [111/130] ( 99s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[928.202667] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[928.309633] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[928.410236] [112/130] ( 99s left) gem_close_race (basic-process)
[928.491654] Starting subtest: basic-process
[928.573352] Subtest basic-process: SUCCESS (0.081s)
[928.783393] [113/130] ( 98s left) syncobj_wait (multi-wait-submitted-signaled)
[928.840229] Starting subtest: multi-wait-submitted-signaled
[928.842515] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[928.981953] [114/130] ( 98s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[929.068936] Starting subtest: plane-primary-toggle-with-vblank-wait
[929.071165] Starting dynamic subtest: pipe-A-eDP-1
[929.241098] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[929.567295] Starting dynamic subtest: pipe-B-eDP-1
[930.502332] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.948s)
[930.798714] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.730s)
[931.659023] [115/130] ( 96s left) gen7_exec_parse (bitmasks)
[931.721515] Subtest bitmasks: SKIP (0.000s)
[931.811090] [116/130] ( 95s left) api_intel_allocator (two-level-inception)
[931.876387] Starting subtest: two-level-inception
[937.278323] Subtest two-level-inception: SUCCESS (5.397s)
[937.441720] [117/130] ( 90s left) kms_plane_alpha_blend (alpha-7efc)
[937.549669] Starting subtest: alpha-7efc
[937.847406] Starting dynamic subtest: pipe-A-eDP-1
[938.444029] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[938.478592] Starting dynamic subtest: pipe-D-eDP-1
[939.729238] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.262s)
[939.731646] Subtest alpha-7efc: SUCCESS (2.177s)
[940.569005] [118/130] ( 87s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[940.669046] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[940.671024] Starting dynamic subtest: pipe-A-eDP-1
[940.826014] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[940.837680] Starting dynamic subtest: pipe-B-eDP-1
[940.855958] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[940.866414] Starting dynamic subtest: pipe-C-eDP-1
[940.886102] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[940.896775] Starting dynamic subtest: pipe-D-eDP-1
[940.915699] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[940.917595] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.190s)
[943.159805] [119/130] ( 84s left) api_intel_bb (intel-bb-blit-y)
[943.220793] Starting subtest: intel-bb-blit-y
[946.743766] Subtest intel-bb-blit-y: SUCCESS (3.520s)
[946.895744] [120/130] ( 81s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[947.013780] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[947.025989] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[947.161004] [121/130] ( 80s left) gem_userptr_blits (sync-unmap)
[947.213840] Starting subtest: sync-unmap
[947.225033] Subtest sync-unmap: SUCCESS (0.013s)
[947.355851] [122/130] ( 80s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[947.470350] Starting subtest: yf-tiled-32bpp-rotate-270
[947.474471] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[947.592769] [123/130] ( 80s left) gem_ctx_shared (disjoint-timelines)
[947.643717] Starting subtest: disjoint-timelines
[947.663529] Subtest disjoint-timelines: SUCCESS (0.020s)
[947.945755] [124/130] ( 80s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[948.042976] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[948.047001] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[948.160038] [125/130] ( 79s left) kms_lease (empty-lease)
[948.252310] Starting subtest: empty-lease
[948.254719] Starting dynamic subtest: pipe-A-eDP-1
[948.257872] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[948.275516] Starting dynamic subtest: pipe-B-eDP-1
[948.277393] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[948.286945] Starting dynamic subtest: pipe-C-eDP-1
[948.288794] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[948.298179] Starting dynamic subtest: pipe-D-eDP-1
[948.300065] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[948.302115] Subtest empty-lease: SUCCESS (0.009s)
[948.399692] [126/130] ( 79s left) gen3_mixed_blits
[948.524684] [127/130] ( 79s left) gem_cs_tlb (engines)
[948.589282] Starting subtest: engines
[948.591228] Starting dynamic subtest: rcs0
[950.744285] Dynamic subtest rcs0: SUCCESS (2.153s)
[950.757132] Starting dynamic subtest: bcs0
[952.897704] Dynamic subtest bcs0: SUCCESS (2.151s)
[952.908944] Starting dynamic subtest: vcs0
[955.051587] Dynamic subtest vcs0: SUCCESS (2.152s)
[955.064251] Starting dynamic subtest: vcs1
[957.204583] Dynamic subtest vcs1: SUCCESS (2.151s)
[957.222464] Starting dynamic subtest: vecs0
[959.356630] Dynamic subtest vecs0: SUCCESS (2.151s)
[959.370637] Starting dynamic subtest: ccs0
[961.510777] Dynamic subtest ccs0: SUCCESS (2.153s)
[961.513225] Subtest engines: SUCCESS (12.918s)
[961.691603] [128/130] ( 66s left) gem_mmap_gtt (basic-small-bo-tiledy)
[961.752439] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[961.820819] [129/130] ( 66s left) gem_mmap (bad-object)
[961.879452] Subtest bad-object: SKIP (0.000s)
[961.947959] [130/130] ( 66s left) i915_fb_tiling (basic-x-tiling)
[962.015625] Subtest basic-x-tiling: SKIP (0.000s)
[962.085733] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_atomic
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: vgem_basic
results: parsing output: 4/ for test: kms_invalid_mode
results: parsing output: 5/ for test: gem_spin_batch
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_pm_backlight
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_color
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: gem_madvise
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_exec_big
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_prop_blob
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_getfb
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: sriov_basic
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: i915_pm_rps
results: parsing output: 27/ for test: kms_chamelium_edid
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: i915_drm_fdinfo
results: parsing output: 31/ for test: gem_partial_pwrite_pread
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: gem_set_tiling_vs_blt
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_pipe_b_c_ivb
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: dmabuf_sync_file
results: parsing output: 44/ for test: gem_caching
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_wait
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_chamelium_hpd
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_exec_params
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: gem_partial_pwrite_pread
results: parsing output: 54/ for test: kms_force_connector_basic
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_ctx_isolation
results: parsing output: 58/ for test: gem_pwrite
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: gem_pipe_control_store_loop
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_draw_crc
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: gem_exec_flush
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_parallel
results: parsing output: 74/ for test: prime_mmap
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: gem_basic
results: parsing output: 77/ for test: kms_getfb
results: parsing output: 78/ for test: gem_ctx_persistence
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_cursor_edge_walk
results: parsing output: 85/ for test: kms_chamelium_audio
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: gem_pxp
results: parsing output: 91/ for test: kms_plane_alpha_blend
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_async_flips
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_setmode
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_sequence
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: fbdev
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: gem_close_race
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_atomic_transition
results: parsing output: 114/ for test: gen7_exec_parse
results: parsing output: 115/ for test: api_intel_allocator
results: parsing output: 116/ for test: kms_plane_alpha_blend
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: api_intel_bb
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_userptr_blits
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_ctx_shared
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_lease
results: parsing output: 125/ for test: gen3_mixed_blits
results: parsing output: 126/ for test: gem_cs_tlb
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: gem_mmap
results: parsing output: 129/ for test: i915_fb_tiling
Done.