[61.548635] Initializing watchdogs
[61.548701]   /dev/watchdog0
[61.568562] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.579286] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.582866] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.585532] [001/134] (960s left) dumb_buffer (map-uaf)
[61.656248] Starting subtest: map-uaf
[61.676622] Subtest map-uaf: SUCCESS (0.020s)
[61.868519] [002/134] (960s left) kms_cursor_crc (cursor-size-hints)
[62.124070] Starting subtest: cursor-size-hints
[62.125836] Starting dynamic subtest: pipe-A-DP-3
[62.717777] Dynamic subtest pipe-A-DP-3: SUCCESS (0.592s)
[62.726945] Starting dynamic subtest: pipe-D-DP-3
[63.231756] Dynamic subtest pipe-D-DP-3: SUCCESS (0.513s)
[63.232641] Subtest cursor-size-hints: SUCCESS (1.107s)
[63.794629] [003/134] (958s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[63.972910] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[63.974597] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[64.301549] [004/134] (957s left) syncobj_wait (single-wait-for-submit-signaled)
[64.370192] Starting subtest: single-wait-for-submit-signaled
[64.371155] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[64.556220] [005/134] (957s left) gem_workarounds (basic-read)
[64.647998] Starting subtest: basic-read
[64.690060] Subtest basic-read: SUCCESS (0.043s)
[64.844717] [006/134] (957s left) kms_dp_linktrain_fallback (dsc-fallback)
[65.018868] Starting subtest: dsc-fallback
[65.021555] Subtest dsc-fallback: SKIP (0.001s)
[65.171011] [007/134] (957s left) gem_create (create-invalid-size)
[65.237876] Starting subtest: create-invalid-size
[65.238755] Subtest create-invalid-size: SUCCESS (0.000s)
[65.494427] [008/134] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[65.680527] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[65.682192] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[65.870084] [009/134] (956s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[66.052599] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[66.054249] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[66.213460] [010/134] (956s left) gem_partial_pwrite_pread (reads)
[66.295338] Subtest reads: SKIP (0.000s)
[66.366920] [011/134] (956s left) api_intel_bb (object-reloc-purge-cache)
[66.440276] Starting subtest: object-reloc-purge-cache
[66.443286] Subtest object-reloc-purge-cache: SKIP (0.002s)
[66.637150] [012/134] (956s left) gem_render_copy (y-tiled-to-vebox-linear)
[66.731712] Starting subtest: y-tiled-to-vebox-linear
[66.733452] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[66.954213] [013/134] (955s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[67.384560] Starting subtest: 2x-absolute-wf_vblank-interruptible
[67.399919] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.014s)
[67.631185] [014/134] (955s left) gem_softpin (allocator-nopin)
[67.759740] Starting subtest: allocator-nopin
[68.070993] Subtest allocator-nopin: SUCCESS (0.311s)
[68.260928] [015/134] (954s left) kms_pm_rpm (drm-resources-equal)
[70.069870] Starting subtest: drm-resources-equal
[71.478914] Subtest drm-resources-equal: SUCCESS (1.409s)
[71.688480] [016/134] (951s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[71.870163] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[71.870959] Starting dynamic subtest: pipe-A
[72.446105] Dynamic subtest pipe-A: SUCCESS (0.576s)
[72.454948] Starting dynamic subtest: pipe-B
[73.076645] Dynamic subtest pipe-B: SUCCESS (0.630s)
[73.092774] Starting dynamic subtest: pipe-C
[73.723525] Dynamic subtest pipe-C: SUCCESS (0.646s)
[73.743072] Starting dynamic subtest: pipe-D
[74.371407] Dynamic subtest pipe-D: SUCCESS (0.647s)
[74.372534] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.501s)
[74.713244] [017/134] (948s left) gem_ctx_persistence (engines-hang)
[74.789629] Starting subtest: engines-hang
[74.790512] Starting dynamic subtest: rcs0
[74.959266] Dynamic subtest rcs0: SUCCESS (0.169s)
[74.994625] Starting dynamic subtest: bcs0
[75.019422] Dynamic subtest bcs0: SUCCESS (0.060s)
[75.035234] Starting dynamic subtest: vcs0
[75.113105] Dynamic subtest vcs0: SUCCESS (0.093s)
[75.147720] Starting dynamic subtest: vcs1
[75.149079] Dynamic subtest vcs1: SUCCESS (0.032s)
[75.164730] Starting dynamic subtest: vecs0
[75.267409] Dynamic subtest vecs0: SUCCESS (0.120s)
[75.302217] Starting dynamic subtest: vecs1
[75.306459] Dynamic subtest vecs1: SUCCESS (0.039s)
[75.325845] Starting dynamic subtest: ccs0
[75.392335] Dynamic subtest ccs0: SUCCESS (0.085s)
[75.394251] Subtest engines-hang: SUCCESS (0.602s)
[75.612372] [018/134] (947s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[75.794949] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[75.816969] Starting dynamic subtest: pipe-A-plane-0
[75.819163] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[75.827660] Starting dynamic subtest: pipe-A-plane-3
[75.829512] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[75.837341] Starting dynamic subtest: pipe-A-plane-5
[75.839170] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[76.044549] Starting dynamic subtest: pipe-B-plane-0
[76.046845] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[76.063597] Starting dynamic subtest: pipe-B-plane-3
[76.065703] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[76.080839] Starting dynamic subtest: pipe-B-plane-5
[76.082768] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[76.125256] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.329s)
[76.412795] [019/134] (946s left) i915_pm_rc6_residency (media-rc6-accuracy)
[76.486187] Starting subtest: media-rc6-accuracy
[76.487967] Subtest media-rc6-accuracy: SKIP (0.000s)
[76.623694] [020/134] (946s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[76.808588] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[76.810250] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[77.011892] [021/134] (946s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[77.186910] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[77.187828] Starting dynamic subtest: pipe-A-valid-mode
[79.590865] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.402s)
[79.592286] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.404s)
[79.904357] [022/134] (943s left) kms_chamelium_hpd (vga-hpd-fast)
[80.152545] Subtest vga-hpd-fast: SKIP (0.000s)
[80.296583] [023/134] (943s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[80.368965] Starting subtest: etime-single-wait-all-for-submit-submitted
[80.478503] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[80.637973] [024/134] (943s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[80.828367] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[80.829290] Starting dynamic subtest: pipe-A-DP-3
[80.832776] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[80.840992] Starting dynamic subtest: pipe-B-DP-3
[80.844468] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[80.852358] Starting dynamic subtest: pipe-C-DP-3
[80.855936] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[80.863768] Starting dynamic subtest: pipe-D-DP-3
[80.867164] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[80.868935] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[81.298560] [025/134] (942s left) kms_psr (psr-cursor-mmap-cpu)
[81.484988] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[81.542403] [026/134] (942s left) kms_sequence (get-forked-busy)
[81.714968] Starting subtest: get-forked-busy
[81.715893] Starting dynamic subtest: pipe-A-DP-3
[84.357033] Dynamic subtest pipe-A-DP-3: SUCCESS (2.640s)
[84.373384] Starting dynamic subtest: pipe-B-DP-3
[86.938758] Dynamic subtest pipe-B-DP-3: SUCCESS (2.580s)
[86.950587] Starting dynamic subtest: pipe-C-DP-3
[89.483967] Dynamic subtest pipe-C-DP-3: SUCCESS (2.543s)
[89.501731] Starting dynamic subtest: pipe-D-DP-3
[92.053957] Dynamic subtest pipe-D-DP-3: SUCCESS (2.566s)
[92.055308] Subtest get-forked-busy: SUCCESS (10.337s)
[92.362136] [027/134] (931s left) sysfs_timeslice_duration (invalid)
[92.440572] Starting subtest: invalid
[92.441474] Starting dynamic subtest: vecs0
[92.442396] Dynamic subtest vecs0: SUCCESS (0.000s)
[92.450799] Starting dynamic subtest: ccs0
[92.451807] Dynamic subtest ccs0: SUCCESS (0.000s)
[92.460163] Starting dynamic subtest: vcs0
[92.461371] Dynamic subtest vcs0: SUCCESS (0.000s)
[92.469634] Starting dynamic subtest: bcs0
[92.470785] Dynamic subtest bcs0: SUCCESS (0.000s)
[92.479257] Starting dynamic subtest: vecs1
[92.480522] Dynamic subtest vecs1: SUCCESS (0.000s)
[92.488630] Starting dynamic subtest: rcs0
[92.489766] Dynamic subtest rcs0: SUCCESS (0.000s)
[92.497787] Starting dynamic subtest: vcs1
[92.498929] Dynamic subtest vcs1: SUCCESS (0.000s)
[92.500100] Subtest invalid: SUCCESS (0.006s)
[92.545106] [028/134] (931s left) perf (i915-ref-count)
[92.678969] Starting subtest: i915-ref-count
[92.952741] Subtest i915-ref-count: SUCCESS (0.274s)
[93.109659] [029/134] (930s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[93.178129] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[93.179072] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[93.358471] [030/134] (930s left) kms_rmfb (close-fd)
[93.531439] Starting subtest: close-fd
[93.533525] Starting dynamic subtest: pipe-A-DP-3
[93.706061] Dynamic subtest pipe-A-DP-3: SUCCESS (0.173s)
[93.719410] Starting dynamic subtest: pipe-B-DP-3
[93.980637] Dynamic subtest pipe-B-DP-3: SUCCESS (0.273s)
[93.991103] Starting dynamic subtest: pipe-C-DP-3
[94.245788] Dynamic subtest pipe-C-DP-3: SUCCESS (0.263s)
[94.256778] Starting dynamic subtest: pipe-D-DP-3
[94.528963] Dynamic subtest pipe-D-DP-3: SUCCESS (0.282s)
[94.530033] Subtest close-fd: SUCCESS (0.998s)
[94.835038] [031/134] (929s left) template (b)
[94.906145] Starting subtest: B
[94.907237] Subtest B: SUCCESS (0.000s)
[95.082369] [032/134] (929s left) kms_plane (pixel-format-linear-modifier)
[95.254780] Starting subtest: pixel-format-linear-modifier
[95.290140] Starting dynamic subtest: pipe-A-plane-0
[101.141157] Dynamic subtest pipe-A-plane-0: SUCCESS (5.850s)
[101.153803] Starting dynamic subtest: pipe-A-plane-3
[104.423710] Dynamic subtest pipe-A-plane-3: SUCCESS (3.281s)
[104.433601] Starting dynamic subtest: pipe-A-plane-5
[104.690837] Dynamic subtest pipe-A-plane-5: SUCCESS (0.266s)
[104.910391] Starting dynamic subtest: pipe-B-plane-0
[110.769357] Dynamic subtest pipe-B-plane-0: SUCCESS (5.867s)
[110.778886] Starting dynamic subtest: pipe-B-plane-3
[113.936374] Dynamic subtest pipe-B-plane-3: SUCCESS (3.166s)
[113.945981] Starting dynamic subtest: pipe-B-plane-5
[114.169912] Dynamic subtest pipe-B-plane-5: SUCCESS (0.233s)
[114.277278] Subtest pixel-format-linear-modifier: SUCCESS (19.021s)
[114.643360] [033/134] (909s left) gem_ctx_shared (q-promotion)
[114.725471] Starting subtest: Q-promotion
[114.726441] Starting dynamic subtest: rcs0
[115.054727] Dynamic subtest rcs0: SUCCESS (0.321s)
[115.063564] Starting dynamic subtest: bcs0
[115.241783] Dynamic subtest bcs0: SUCCESS (0.185s)
[115.250406] Starting dynamic subtest: vcs0
[115.438167] Dynamic subtest vcs0: SUCCESS (0.197s)
[115.446684] Starting dynamic subtest: vcs1
[115.628418] Dynamic subtest vcs1: SUCCESS (0.190s)
[115.637138] Starting dynamic subtest: vecs0
[115.821907] Dynamic subtest vecs0: SUCCESS (0.194s)
[115.830705] Starting dynamic subtest: vecs1
[116.031406] Dynamic subtest vecs1: SUCCESS (0.215s)
[116.040843] Starting dynamic subtest: ccs0
[116.227950] Dynamic subtest ccs0: SUCCESS (0.196s)
[116.228847] Subtest Q-promotion: SUCCESS (1.503s)
[116.578625] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[116.580478] [034/134] (907s left) kms_cursor_crc (cursor-offscreen-max-size)
[117.088203] Starting subtest: cursor-offscreen-max-size
[117.093713] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[117.315444] [035/134] (907s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[117.503540] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[117.554560] [036/134] (906s left) sw_sync (sync_merge_invalid)
[117.603140] Starting subtest: sync_merge_invalid
[117.647124] Subtest sync_merge_invalid: SUCCESS (0.044s)
[117.720663] [037/134] (906s left) i915_drm_fdinfo (busy-idle-check-all)
[117.790585] Starting subtest: busy-idle-check-all
[117.791450] Starting dynamic subtest: rcs0
[117.822303] Dynamic subtest rcs0: SKIP (0.031s)
[117.831471] Starting dynamic subtest: bcs0
[117.833413] Dynamic subtest bcs0: SKIP (0.000s)
[117.842512] Starting dynamic subtest: vcs0
[117.844480] Dynamic subtest vcs0: SKIP (0.000s)
[117.853410] Starting dynamic subtest: vcs1
[117.855573] Dynamic subtest vcs1: SKIP (0.000s)
[117.864315] Starting dynamic subtest: vecs0
[117.866786] Dynamic subtest vecs0: SKIP (0.000s)
[117.875620] Starting dynamic subtest: vecs1
[117.877802] Dynamic subtest vecs1: SKIP (0.000s)
[117.886499] Starting dynamic subtest: ccs0
[117.888857] Dynamic subtest ccs0: SKIP (0.000s)
[117.891025] Subtest busy-idle-check-all: SKIP (0.037s)
[117.960811] [038/134] (906s left) i915_module_load (reload)
[118.006347] Starting subtest: reload
[120.744266] Subtest reload: SUCCESS (2.738s)
[120.788745] [039/134] (903s left) gem_exec_suspend (basic-s3)
[120.973832] Starting subtest: basic-S3
[120.974859] Starting dynamic subtest: smem
[143.687617] Dynamic subtest smem: SUCCESS (7.207s)
[143.698411] Starting dynamic subtest: lmem0
[165.838521] Dynamic subtest lmem0: SUCCESS (7.261s)
[165.839332] Subtest basic-S3: SUCCESS (14.469s)
[166.126153] [040/134] (858s left) gem_close (many-handles-one-vma)
[166.210663] Starting subtest: many-handles-one-vma
[166.242464] Subtest many-handles-one-vma: SUCCESS (0.032s)
[166.462693] [041/134] (858s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[166.649684] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[166.651781] Starting dynamic subtest: pipe-A-DP-3
[166.661142] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[166.671471] Starting dynamic subtest: pipe-B-DP-3
[166.680883] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[166.691815] Starting dynamic subtest: pipe-C-DP-3
[166.700896] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[166.711317] Starting dynamic subtest: pipe-D-DP-3
[166.720998] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[166.722694] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[167.135521] [042/134] (857s left) gem_exec_balancer (parallel-out-fence)
[167.483032] Starting subtest: parallel-out-fence
[169.749876] Subtest parallel-out-fence: SUCCESS (2.267s)
[169.940199] [043/134] (854s left) gem_exec_reloc (basic-gtt-read)
[170.023481] Subtest basic-gtt-read: SKIP (0.000s)
[170.131186] [044/134] (854s left) kms_invalid_mode (bad-vsync-start)
[170.315530] Starting subtest: bad-vsync-start
[170.316416] Starting dynamic subtest: pipe-A-DP-3
[170.403101] Dynamic subtest pipe-A-DP-3: SUCCESS (0.086s)
[170.418982] Starting dynamic subtest: pipe-B-DP-3
[170.420269] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[170.433978] Starting dynamic subtest: pipe-C-DP-3
[170.435268] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[170.446015] Starting dynamic subtest: pipe-D-DP-3
[170.446980] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[170.447894] Subtest bad-vsync-start: SUCCESS (0.096s)
[170.687369] [045/134] (854s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[170.876689] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[170.878311] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[171.088283] [046/134] (854s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[171.281989] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[171.283581] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[171.441025] [047/134] (853s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[171.630980] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[171.632636] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[171.790405] [048/134] (853s left) perf_pmu (busy-idle)
[171.861053] Starting subtest: busy-idle
[171.862060] Starting dynamic subtest: rcs0
[172.581836] Dynamic subtest rcs0: SUCCESS (0.720s)
[172.627905] Starting dynamic subtest: bcs0
[173.272684] Dynamic subtest bcs0: SUCCESS (0.688s)
[173.289149] Starting dynamic subtest: vcs0
[173.936850] Dynamic subtest vcs0: SUCCESS (0.661s)
[173.955492] Starting dynamic subtest: vcs1
[174.601808] Dynamic subtest vcs1: SUCCESS (0.662s)
[174.618215] Starting dynamic subtest: vecs0
[175.266596] Dynamic subtest vecs0: SUCCESS (0.661s)
[175.282452] Starting dynamic subtest: vecs1
[175.935825] Dynamic subtest vecs1: SUCCESS (0.666s)
[175.950601] Starting dynamic subtest: ccs0
[176.606663] Dynamic subtest ccs0: SUCCESS (0.667s)
[176.608422] Subtest busy-idle: SUCCESS (4.747s)
[176.792818] [049/134] (848s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[176.979260] Starting subtest: short-flip-after-cursor-toggle
[178.030059] Subtest short-flip-after-cursor-toggle: SUCCESS (1.051s)
[178.382351] [050/134] (847s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[178.566363] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[178.567084] Starting dynamic subtest: pipe-A
[180.613242] Dynamic subtest pipe-A: SUCCESS (2.048s)
[180.637545] Starting dynamic subtest: pipe-B
[182.693982] Dynamic subtest pipe-B: SUCCESS (2.079s)
[182.720958] Starting dynamic subtest: pipe-C
[183.006911] Dynamic subtest pipe-C: SUCCESS (0.311s)
[183.026018] Starting dynamic subtest: pipe-D
[183.303383] Dynamic subtest pipe-D: SUCCESS (0.295s)
[183.304586] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (4.739s)
[183.677564] [051/134] (841s left) kms_vblank (ts-continuation-modeset)
[183.860022] Starting subtest: ts-continuation-modeset
[183.862375] Starting dynamic subtest: pipe-A-DP-3
[184.389394] Dynamic subtest pipe-A-DP-3: SUCCESS (0.527s)
[184.411610] Starting dynamic subtest: pipe-D-DP-3
[184.832639] Dynamic subtest pipe-D-DP-3: SUCCESS (0.438s)
[184.833570] Subtest ts-continuation-modeset: SUCCESS (0.972s)
[185.125975] [052/134] (840s left) gem_exec_fence (keep-in-fence)
[185.331692] Starting subtest: keep-in-fence
[185.332661] Starting dynamic subtest: rcs0
[185.429453] Dynamic subtest rcs0: SUCCESS (0.103s)
[185.451143] Starting dynamic subtest: bcs0
[185.487164] Dynamic subtest bcs0: SUCCESS (0.056s)
[185.504658] Starting dynamic subtest: vcs0
[185.544678] Dynamic subtest vcs0: SUCCESS (0.054s)
[185.559228] Starting dynamic subtest: vcs1
[185.598469] Dynamic subtest vcs1: SUCCESS (0.052s)
[185.620883] Starting dynamic subtest: vecs0
[185.654023] Dynamic subtest vecs0: SUCCESS (0.054s)
[185.693503] Starting dynamic subtest: vecs1
[185.726446] Dynamic subtest vecs1: SUCCESS (0.070s)
[185.748369] Starting dynamic subtest: ccs0
[185.947303] Dynamic subtest ccs0: SUCCESS (0.219s)
[185.948337] Subtest keep-in-fence: SUCCESS (0.622s)
[186.747212] [053/134] (838s left) gem_basic (create-close)
[186.830893] Starting subtest: create-close
[186.833002] Subtest create-close: SUCCESS (0.000s)
[187.021560] [054/134] (838s left) kms_chamelium_color (gamma)
[187.208926] Subtest gamma: SKIP (0.000s)
[187.272998] [055/134] (838s left) perf_pmu (init-sema)
[187.343189] Starting subtest: init-sema
[187.344132] Starting dynamic subtest: rcs0
[187.346381] Dynamic subtest rcs0: SUCCESS (0.003s)
[187.360521] Starting dynamic subtest: bcs0
[187.361434] Dynamic subtest bcs0: SUCCESS (0.001s)
[187.373946] Starting dynamic subtest: vcs0
[187.374822] Dynamic subtest vcs0: SUCCESS (0.001s)
[187.387538] Starting dynamic subtest: vcs1
[187.388417] Dynamic subtest vcs1: SUCCESS (0.001s)
[187.400120] Starting dynamic subtest: vecs0
[187.401003] Dynamic subtest vecs0: SUCCESS (0.001s)
[187.412641] Starting dynamic subtest: vecs1
[187.413709] Dynamic subtest vecs1: SUCCESS (0.001s)
[187.425198] Starting dynamic subtest: ccs0
[187.426313] Dynamic subtest ccs0: SUCCESS (0.001s)
[187.427437] Subtest init-sema: SUCCESS (0.014s)
[187.494543] [056/134] (838s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[187.684493] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[187.740070] [057/134] (838s left) kms_lease (lease-get)
[187.927501] Starting subtest: lease-get
[187.928387] Starting dynamic subtest: pipe-A-DP-3
[187.930578] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[187.944335] Starting dynamic subtest: pipe-B-DP-3
[187.945243] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[187.956848] Starting dynamic subtest: pipe-C-DP-3
[187.957989] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[187.969476] Starting dynamic subtest: pipe-D-DP-3
[187.970470] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s)
[187.971564] Subtest lease-get: SUCCESS (0.015s)
[188.106559] [058/134] (837s left) gem_lmem_swapping (parallel-random-verify-ccs)
[190.713428] Starting subtest: parallel-random-verify-ccs
[190.714283] Starting dynamic subtest: lmem0
[256.550613] Dynamic subtest lmem0: SUCCESS (65.839s)
[256.551520] Subtest parallel-random-verify-ccs: SUCCESS (65.841s)
[257.643879] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[257.644884] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[257.647021] [059/134] (768s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[259.256982] Starting subtest: y-tiled-ccs-to-x-tiled
[259.259434] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[259.479923] [FACT gem_render_copy (y-tiled-ccs-to-x-tiled)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[259.482537] [FACT gem_render_copy (y-tiled-ccs-to-x-tiled)] new: kernel.kmod_is_loaded.i915: true
[259.485583] [060/134] (766s left) gem_exec_balancer (bonded-false-hang)
[259.875722] Starting subtest: bonded-false-hang
[259.877483] Subtest bonded-false-hang: SKIP (0.000s)
[260.034414] [061/134] (766s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[260.228351] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[260.278936] [062/134] (765s left) gen7_exec_parse (basic-allowed)
[260.366368] Subtest basic-allowed: SKIP (0.000s)
[260.478995] [063/134] (765s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[260.661517] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[260.662388] Starting dynamic subtest: pipe-A-DP-3
[260.670691] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[260.681359] Starting dynamic subtest: pipe-B-DP-3
[260.689700] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[260.701038] Starting dynamic subtest: pipe-C-DP-3
[260.709216] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[260.719846] Starting dynamic subtest: pipe-D-DP-3
[260.730635] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[260.732616] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[261.151049] [064/134] (765s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[261.345537] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[261.393329] [065/134] (765s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[261.587480] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[261.589134] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[261.768360] [066/134] (764s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[261.958519] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[261.959397] Starting dynamic subtest: pipe-A-DP-3
[261.967657] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[261.978230] Starting dynamic subtest: pipe-B-DP-3
[261.986345] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[261.996705] Starting dynamic subtest: pipe-C-DP-3
[262.004945] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[262.015332] Starting dynamic subtest: pipe-D-DP-3
[262.026125] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[262.028011] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[262.408733] [067/134] (764s left) kms_flip (flip-vs-panning)
[262.594555] Starting subtest: flip-vs-panning
[262.599263] Starting dynamic subtest: A-DP3
[270.469479] Dynamic subtest A-DP3: SUCCESS (7.870s)
[270.515662] Starting dynamic subtest: B-DP3
[278.277316] Dynamic subtest B-DP3: SUCCESS (7.803s)
[278.291619] Starting dynamic subtest: C-DP3
[286.060296] Dynamic subtest C-DP3: SUCCESS (7.782s)
[286.074445] Starting dynamic subtest: D-DP3
[293.832317] Dynamic subtest D-DP3: SUCCESS (7.771s)
[293.834651] Subtest flip-vs-panning: SUCCESS (31.240s)
[294.214811] [068/134] (732s left) syncobj_eventfd (timeline-wait)
[294.295561] Starting subtest: timeline-wait
[294.306062] Subtest timeline-wait: SUCCESS (0.010s)
[294.449624] [069/134] (732s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[294.641248] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[294.642948] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[294.845400] [070/134] (732s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[295.033577] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[295.038431] Starting dynamic subtest: A-DP3
[295.957834] Dynamic subtest A-DP3: SUCCESS (0.918s)
[295.971851] Starting dynamic subtest: B-DP3
[296.684856] Dynamic subtest B-DP3: SUCCESS (0.726s)
[296.696301] Starting dynamic subtest: C-DP3
[297.393880] Dynamic subtest C-DP3: SUCCESS (0.708s)
[297.407076] Starting dynamic subtest: D-DP3
[298.127481] Dynamic subtest D-DP3: SUCCESS (0.732s)
[298.128357] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.095s)
[298.444280] [071/134] (728s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[298.639734] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[299.935741] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.283s)
[300.189746] [072/134] (726s left) gem_mmap_offset (oob-read)
[300.273357] Starting subtest: oob-read
[300.274264] Subtest oob-read: SUCCESS (0.000s)
[300.458941] [073/134] (726s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[300.644964] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[300.647419] Starting dynamic subtest: pipe-A-valid-mode
[301.002236] Dynamic subtest pipe-A-valid-mode: SKIP (0.345s)
[301.004391] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.348s)
[301.284989] [074/134] (725s left) gem_pxp (regular-baseline-src-copy-readible)
[303.888346] Starting subtest: regular-baseline-src-copy-readible
[303.890307] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[304.034746] [075/134] (723s left) kms_3d (basic)
[304.112329] Starting subtest: basic
[306.082842] Subtest basic: SUCCESS (1.970s)
[306.534766] [076/134] (720s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[306.726268] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[306.727991] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[306.917564] [077/134] (720s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[307.107240] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[307.108960] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[307.266521] [078/134] (720s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[307.464342] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[307.466146] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[307.675957] [079/134] (719s left) gem_exec_schedule (fairslice-all)
[307.771630] Starting subtest: fairslice-all
[309.899770] Subtest fairslice-all: SUCCESS (2.128s)
[310.316858] [080/134] (717s left) kms_properties (plane-properties-atomic)
[310.500859] Starting subtest: plane-properties-atomic
[310.503354] Starting dynamic subtest: pipe-A-DP-3
[311.000992] Dynamic subtest pipe-A-DP-3: SUCCESS (0.496s)
[311.018226] Starting dynamic subtest: pipe-B-DP-3
[311.526574] Dynamic subtest pipe-B-DP-3: SUCCESS (0.523s)
[311.541203] Starting dynamic subtest: pipe-C-DP-3
[312.046426] Dynamic subtest pipe-C-DP-3: SUCCESS (0.518s)
[312.059838] Starting dynamic subtest: pipe-D-DP-3
[312.567100] Dynamic subtest pipe-D-DP-3: SUCCESS (0.519s)
[312.567987] Subtest plane-properties-atomic: SUCCESS (2.067s)
[312.881529] [081/134] (714s left) gem_cs_tlb (engines)
[312.963849] Starting subtest: engines
[312.964704] Starting dynamic subtest: rcs0
[315.118453] Dynamic subtest rcs0: SUCCESS (2.153s)
[315.131472] Starting dynamic subtest: bcs0
[317.271919] Dynamic subtest bcs0: SUCCESS (2.152s)
[317.285447] Starting dynamic subtest: vcs0
[319.427576] Dynamic subtest vcs0: SUCCESS (2.154s)
[319.439573] Starting dynamic subtest: vcs1
[321.581318] Dynamic subtest vcs1: SUCCESS (2.152s)
[321.593227] Starting dynamic subtest: vecs0
[323.733605] Dynamic subtest vecs0: SUCCESS (2.152s)
[323.745605] Starting dynamic subtest: vecs1
[325.887447] Dynamic subtest vecs1: SUCCESS (2.153s)
[325.899289] Starting dynamic subtest: ccs0
[328.040700] Dynamic subtest ccs0: SUCCESS (2.152s)
[328.041647] Subtest engines: SUCCESS (15.077s)
[328.252445] [082/134] (699s left) kms_scaling_modes (scaling-mode-none)
[328.445521] Starting subtest: scaling-mode-none
[328.450507] Subtest scaling-mode-none: SKIP (0.001s)
[328.588384] [083/134] (699s left) kms_psr (pr-sprite-render)
[328.771530] Subtest pr-sprite-render: SKIP (0.000s)
[328.841059] [084/134] (699s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-pwrite)
[329.032220] Starting subtest: fbc-abgr161616f-draw-pwrite
[329.033913] Subtest fbc-abgr161616f-draw-pwrite: SKIP (0.000s)
[329.224655] [085/134] (698s left) kms_flip (2x-flip-vs-expired-vblank)
[329.408052] Starting subtest: 2x-flip-vs-expired-vblank
[329.423259] Subtest 2x-flip-vs-expired-vblank: SKIP (0.014s)
[329.579128] [086/134] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[329.766414] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[329.768154] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[329.944461] [087/134] (698s left) kms_content_protection (srm)
[330.196593] Starting subtest: srm
[330.229307] Starting dynamic subtest: pipe-A-DP-3
[451.729488] Dynamic subtest pipe-A-DP-3: FAIL (121.316s)
[451.730380] Subtest srm: FAIL (121.429s)
[451.961761] [088/134] (576s left) gem_userptr_blits (process-exit-busy)
[452.051001] Starting subtest: process-exit-busy
[452.067289] Subtest process-exit-busy: SUCCESS (0.016s)
[452.274459] [089/134] (576s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[452.475989] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[452.477659] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[452.677052] [090/134] (575s left) kms_color (invalid-degamma-lut-sizes)
[452.865511] Starting subtest: invalid-degamma-lut-sizes
[452.866401] Starting dynamic subtest: pipe-A
[452.948967] Dynamic subtest pipe-A: SUCCESS (0.083s)
[452.964146] Starting dynamic subtest: pipe-B
[452.965145] Dynamic subtest pipe-B: SUCCESS (0.001s)
[452.979641] Starting dynamic subtest: pipe-C
[452.980539] Dynamic subtest pipe-C: SUCCESS (0.001s)
[452.992838] Starting dynamic subtest: pipe-D
[452.993657] Dynamic subtest pipe-D: SUCCESS (0.001s)
[452.994558] Subtest invalid-degamma-lut-sizes: SUCCESS (0.090s)
[453.212997] [091/134] (575s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[453.401315] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[453.403074] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[453.600998] [092/134] (575s left) kms_pipe_crc_basic (nonblocking-crc)
[453.806779] Starting subtest: nonblocking-crc
[453.809084] Starting dynamic subtest: pipe-A-DP-3
[454.562301] Dynamic subtest pipe-A-DP-3: SUCCESS (0.754s)
[454.582807] Starting dynamic subtest: pipe-B-DP-3
[455.221680] Dynamic subtest pipe-B-DP-3: SUCCESS (0.653s)
[455.238287] Starting dynamic subtest: pipe-C-DP-3
[455.879638] Dynamic subtest pipe-C-DP-3: SUCCESS (0.656s)
[455.895197] Starting dynamic subtest: pipe-D-DP-3
[456.504553] Dynamic subtest pipe-D-DP-3: SUCCESS (0.622s)
[456.505514] Subtest nonblocking-crc: SUCCESS (2.698s)
[456.826330] [093/134] (571s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[457.028003] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[458.153142] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.124s)
[458.404886] [094/134] (570s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[458.602156] Starting subtest: 4-tiled-8bpp-rotate-0
[460.170508] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.567s)
[460.422859] [095/134] (568s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[460.614251] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[460.615979] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[460.773802] [096/134] (568s left) gem_exec_schedule (u-semaphore-codependency)
[460.866077] Starting subtest: u-semaphore-codependency
[460.905613] Subtest u-semaphore-codependency: SUCCESS (0.040s)
[461.367402] [097/134] (567s left) syncobj_timeline (wait-any-snapshot)
[461.451459] Starting subtest: wait-any-snapshot
[461.534792] Subtest wait-any-snapshot: SUCCESS (0.082s)
[461.703880] [098/134] (567s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[461.788355] Subtest no-spare-fences-busy: SKIP (0.000s)
[461.891926] [099/134] (567s left) kms_dsc (dsc-with-output-formats-with-bpc)
[462.077370] Starting subtest: dsc-with-output-formats-with-bpc
[462.101455] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s)
[462.235620] [100/134] (567s left) gem_userptr_blits (dmabuf-unsync)
[462.322074] Subtest dmabuf-unsync: SKIP (0.000s)
[462.510065] [101/134] (566s left) kms_prop_blob (blob-prop-core)
[462.593895] Starting subtest: blob-prop-core
[462.594794] Subtest blob-prop-core: SUCCESS (0.000s)
[462.771806] [102/134] (566s left) gem_exec_reloc (basic-gtt-cpu)
[462.860295] Subtest basic-gtt-cpu: SKIP (0.000s)
[462.957458] [103/134] (566s left) syncobj_timeline (invalid-query-bad-pad)
[463.034460] Starting subtest: invalid-query-bad-pad
[463.035381] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[463.245028] [104/134] (566s left) vgem_basic (dmabuf-export)
[463.303335] Starting subtest: dmabuf-export
[463.347512] Subtest dmabuf-export: SUCCESS (0.045s)
[463.525970] [105/134] (566s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-gtt)
[463.717237] Starting subtest: psr-abgr161616f-draw-mmap-gtt
[463.718961] Subtest psr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[463.906625] [106/134] (565s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[464.098034] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[464.099664] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[464.297360] [107/134] (565s left) gem_gpgpu_fill (basic)
[464.381318] Starting subtest: basic
[464.382287] Starting dynamic subtest: smem
[464.412241] Dynamic subtest smem: SUCCESS (0.030s)
[464.426051] Starting dynamic subtest: lmem0
[464.427175] Dynamic subtest lmem0: SUCCESS (0.012s)
[464.428269] Subtest basic: SUCCESS (0.044s)
[464.639989] [108/134] (565s left) gem_mmap_gtt (basic-copy)
[464.721382] Subtest basic-copy: SKIP (0.000s)
[464.798010] [109/134] (565s left) gen9_exec_parse (batch-invalid-length)
[464.881498] Subtest batch-invalid-length: SKIP (0.000s)
[464.964730] [110/134] (565s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[465.171632] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[465.173371] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[465.370581] [111/134] (564s left) gem_tiled_wc
[465.514986] [112/134] (564s left) gem_exec_capture (userptr)
[465.602358] Starting subtest: userptr
[466.563442] Subtest userptr: SUCCESS (0.962s)
[466.747810] [113/134] (563s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[466.930917] Starting subtest: flip-vs-dpms-off-vs-modeset
[466.935625] Starting dynamic subtest: A-DP3
[467.955126] Dynamic subtest A-DP3: SUCCESS (1.018s)
[467.983870] Starting dynamic subtest: B-DP3
[468.725776] Dynamic subtest B-DP3: SUCCESS (0.765s)
[468.750629] Starting dynamic subtest: C-DP3
[469.478156] Dynamic subtest C-DP3: SUCCESS (0.750s)
[469.502490] Starting dynamic subtest: D-DP3
[470.244656] Dynamic subtest D-DP3: SUCCESS (0.764s)
[470.248431] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.317s)
[470.581638] [114/134] (559s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[470.772371] Starting subtest: fbc-rgb565-draw-pwrite
[473.629653] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.857s)
[473.862657] [115/134] (556s left) gem_exec_whisper (basic-contexts-forked-all)
[473.951677] Starting subtest: basic-contexts-forked-all
[496.429733] Subtest basic-contexts-forked-all: SUCCESS (22.476s)
[496.711401] [116/134] (533s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[496.897517] Starting subtest: cursorB-vs-flipB-atomic
[496.899267] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[497.075397] [117/134] (533s left) gem_pread (exhaustion)
[497.151327] Subtest exhaustion: SKIP (0.000s)
[497.224608] [118/134] (533s left) gem_ctx_persistence (heartbeat-hostile)
[497.312454] Starting subtest: heartbeat-hostile
[497.314728] Subtest heartbeat-hostile: SKIP (0.000s)
[497.511052] [119/134] (533s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[497.708365] Starting subtest: extended-pageflip-modeset-hang-oldfb
[497.709248] Starting dynamic subtest: pipe-A
[505.523629] Dynamic subtest pipe-A: SUCCESS (7.813s)
[505.538213] Starting dynamic subtest: pipe-D
[513.346558] Dynamic subtest pipe-D: SUCCESS (7.820s)
[513.347495] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.639s)
[513.664641] [120/134] (517s left) gem_sync (basic-store-each)
[513.756985] Starting subtest: basic-store-each
[516.725737] Subtest basic-store-each: SUCCESS (2.968s)
[517.030523] [121/134] (514s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[517.227303] Starting subtest: psr-shrfb-scaledprimary
[517.229070] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[517.441414] [122/134] (513s left) dmabuf_sync_file (import-multiple-read-only)
[517.495128] Starting subtest: import-multiple-read-only
[517.499097] Subtest import-multiple-read-only: SUCCESS (0.004s)
[517.622390] [123/134] (513s left) kms_atomic_interruptible (universal-setplane-primary)
[517.808389] Starting subtest: universal-setplane-primary
[517.809281] Starting dynamic subtest: pipe-A-DP-3
[524.115129] Dynamic subtest pipe-A-DP-3: SUCCESS (6.305s)
[524.116044] Subtest universal-setplane-primary: SUCCESS (6.307s)
[524.400035] [124/134] (506s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[524.589497] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[524.591210] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[524.782444] [125/134] (506s left) kms_cursor_edge_walk (128x128-right-edge)
[524.967056] Starting subtest: 128x128-right-edge
[524.969503] Starting dynamic subtest: pipe-A-DP-3
[528.435044] Dynamic subtest pipe-A-DP-3: SUCCESS (3.467s)
[528.455068] Starting dynamic subtest: pipe-D-DP-3
[531.767139] Dynamic subtest pipe-D-DP-3: SUCCESS (3.328s)
[531.768212] Subtest 128x128-right-edge: SUCCESS (6.800s)
[531.998860] [126/134] (499s left) api_intel_allocator (two-level-inception)
[532.074392] Starting subtest: two-level-inception
[537.483874] Subtest two-level-inception: SUCCESS (5.409s)
[537.699446] [127/134] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[537.895381] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[537.897128] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[538.084409] [128/134] (493s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[538.167622] Starting subtest: wait-all-for-submit-delayed-submit
[538.271229] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[538.461948] [129/134] (493s left) gem_exec_schedule (pi-ringfull)
[538.667999] Starting subtest: pi-ringfull
[538.668997] Starting dynamic subtest: rcs0
[538.714591] Dynamic subtest rcs0: SUCCESS (0.046s)
[538.728991] Starting dynamic subtest: bcs0
[538.761077] Dynamic subtest bcs0: SUCCESS (0.045s)
[538.775160] Starting dynamic subtest: vcs0
[538.802683] Dynamic subtest vcs0: SUCCESS (0.040s)
[538.817069] Starting dynamic subtest: vcs1
[538.837728] Dynamic subtest vcs1: SUCCESS (0.034s)
[538.852273] Starting dynamic subtest: vecs0
[538.871053] Dynamic subtest vecs0: SUCCESS (0.032s)
[538.886045] Starting dynamic subtest: vecs1
[538.901802] Dynamic subtest vecs1: SUCCESS (0.030s)
[538.916649] Starting dynamic subtest: ccs0
[538.933043] Dynamic subtest ccs0: SUCCESS (0.030s)
[538.934037] Subtest pi-ringfull: SUCCESS (0.266s)
[539.246967] [130/134] (492s left) kms_async_flips (crc-atomic)
[539.435378] Starting subtest: crc-atomic
[539.664648] Starting dynamic subtest: pipe-A-DP-3
[542.074555] Dynamic subtest pipe-A-DP-3: SUCCESS (2.410s)
[542.323588] Starting dynamic subtest: pipe-B-DP-3
[544.542428] Dynamic subtest pipe-B-DP-3: SUCCESS (2.231s)
[544.734117] Starting dynamic subtest: pipe-C-DP-3
[546.953361] Dynamic subtest pipe-C-DP-3: SUCCESS (2.233s)
[547.165632] Starting dynamic subtest: pipe-D-DP-3
[549.377568] Dynamic subtest pipe-D-DP-3: SUCCESS (2.230s)
[549.378542] Subtest crc-atomic: SUCCESS (9.943s)
[549.875187] [131/134] (482s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[550.084119] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[550.141898] [132/134] (481s left) i915_suspend (fence-restore-tiled2untiled)
[550.234396] Starting subtest: fence-restore-tiled2untiled
[550.236128] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[550.421582] [133/134] (481s left) prime_busy (after)
[550.505498] Starting subtest: after
[550.508823] Starting dynamic subtest: rcs0
[550.562479] Dynamic subtest rcs0: SUCCESS (0.054s)
[550.577490] Starting dynamic subtest: bcs0
[550.619648] Dynamic subtest bcs0: SUCCESS (0.056s)
[550.644783] Starting dynamic subtest: vcs0
[550.660612] Dynamic subtest vcs0: SUCCESS (0.039s)
[550.685602] Starting dynamic subtest: vcs1
[550.700276] Dynamic subtest vcs1: SUCCESS (0.038s)
[550.719149] Starting dynamic subtest: vecs0
[550.739832] Dynamic subtest vecs0: SUCCESS (0.038s)
[550.755732] Starting dynamic subtest: vecs1
[550.778576] Dynamic subtest vecs1: SUCCESS (0.038s)
[550.794660] Starting dynamic subtest: ccs0
[550.819919] Dynamic subtest ccs0: SUCCESS (0.040s)
[550.933875] Subtest after: SUCCESS (0.424s)
[551.090690] [134/134] (481s left) prime_mmap (test_refcounting)
[551.169966] Starting subtest: test_refcounting
[551.170813] Starting dynamic subtest: test_refcounting-smem
[551.216473] Dynamic subtest test_refcounting-smem: SUCCESS (0.046s)
[551.230679] Starting dynamic subtest: test_refcounting-lmem0
[551.417304] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.191s)
[551.418375] Subtest test_refcounting: SUCCESS (0.239s)
[551.620388] Closing watchdogs
results: parsing output: 0/ for test: dumb_buffer
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_workarounds
results: parsing output: 5/ for test: kms_dp_linktrain_fallback
results: parsing output: 6/ for test: gem_create
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_partial_pwrite_pread
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: i915_pm_rc6_residency
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_sequence
results: parsing output: 26/ for test: sysfs_timeslice_duration
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_rmfb
results: parsing output: 30/ for test: template
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: gem_ctx_shared
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: sw_sync
results: parsing output: 36/ for test: i915_drm_fdinfo
results: parsing output: 37/ for test: i915_module_load
results: parsing output: 38/ for test: gem_exec_suspend
results: parsing output: 39/ for test: gem_close
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_invalid_mode
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: gem_basic
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gen7_exec_parse
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_psr2_sf
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: syncobj_eventfd
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_mmap_offset
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: gem_pxp
results: parsing output: 74/ for test: kms_3d
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_properties
results: parsing output: 80/ for test: gem_cs_tlb
results: parsing output: 81/ for test: kms_scaling_modes
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_content_protection
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_pipe_crc_basic
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: gem_fenced_exec_thrash
results: parsing output: 98/ for test: kms_dsc
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_prop_blob
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_gpgpu_fill
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_tiled_wc
results: parsing output: 111/ for test: gem_exec_capture
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_pread
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: gem_sync
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: dmabuf_sync_file
results: parsing output: 122/ for test: kms_atomic_interruptible
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_edge_walk
results: parsing output: 125/ for test: api_intel_allocator
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_async_flips
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: i915_suspend
results: parsing output: 132/ for test: prime_busy
results: parsing output: 133/ for test: prime_mmap
Done.