[58.838546] Initializing watchdogs
[58.838595]   /dev/watchdog0
[58.852647] [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]
[58.856750] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.858955] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.862482] [001/134] (960s left) dumb_buffer (map-uaf)
[58.940842] Starting subtest: map-uaf
[58.945586] Subtest map-uaf: SUCCESS (0.005s)
[59.058074] [002/134] (960s left) kms_cursor_crc (cursor-size-hints)
[59.206240] Starting subtest: cursor-size-hints
[59.208901] Starting dynamic subtest: pipe-A-eDP-1
[59.871795] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.663s)
[59.879960] Starting dynamic subtest: pipe-D-eDP-1
[61.087951] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.210s)
[61.090456] Subtest cursor-size-hints: SUCCESS (1.875s)
[61.904879] [003/134] (957s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[62.007065] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[62.011688] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[63.145422] [004/134] (956s left) syncobj_wait (single-wait-for-submit-signaled)
[63.211693] Starting subtest: single-wait-for-submit-signaled
[63.214249] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[63.333985] [005/134] (956s left) gem_workarounds (basic-read)
[63.409091] Starting subtest: basic-read
[63.419283] Subtest basic-read: SUCCESS (0.010s)
[63.589655] [006/134] (955s left) kms_dp_linktrain_fallback (dsc-fallback)
[63.676916] Starting subtest: dsc-fallback
[63.683349] Subtest dsc-fallback: SKIP (0.000s)
[63.759152] [007/134] (955s left) gem_create (create-invalid-size)
[63.807738] Starting subtest: create-invalid-size
[63.810028] Subtest create-invalid-size: SUCCESS (0.000s)
[63.999227] [008/134] (955s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[64.100724] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[64.104830] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[64.223864] [009/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[64.329364] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[70.902813] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.570s)
[71.060029] [010/134] (948s left) gem_partial_pwrite_pread (reads)
[71.120457] Subtest reads: SKIP (0.000s)
[71.194608] [011/134] (948s left) api_intel_bb (object-reloc-purge-cache)
[71.246088] Starting subtest: object-reloc-purge-cache
[71.250696] Subtest object-reloc-purge-cache: SKIP (0.002s)
[71.394180] [012/134] (948s left) gem_render_copy (y-tiled-to-vebox-linear)
[71.461264] Starting subtest: y-tiled-to-vebox-linear
[71.465379] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[71.667611] [013/134] (948s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[71.766630] Starting subtest: 2x-absolute-wf_vblank-interruptible
[71.777941] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[71.874874] [014/134] (947s left) gem_softpin (allocator-nopin)
[71.933119] Starting subtest: allocator-nopin
[72.027704] Subtest allocator-nopin: SUCCESS (0.094s)
[72.150464] [015/134] (947s left) kms_pm_rpm (drm-resources-equal)
[74.087319] Starting subtest: drm-resources-equal
[79.092699] Subtest drm-resources-equal: SUCCESS (5.005s)
[79.200145] [016/134] (940s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[79.298507] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[79.300781] Starting dynamic subtest: pipe-A
[79.634839] Dynamic subtest pipe-A: SUCCESS (0.338s)
[79.643671] Starting dynamic subtest: pipe-B
[81.008050] Dynamic subtest pipe-B: SUCCESS (1.372s)
[81.017087] Starting dynamic subtest: pipe-C
[82.440512] Dynamic subtest pipe-C: SUCCESS (1.432s)
[82.448215] Starting dynamic subtest: pipe-D
[83.874504] Dynamic subtest pipe-D: SUCCESS (1.432s)
[83.876878] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.576s)
[85.053218] [017/134] (934s left) gem_ctx_persistence (engines-hang)
[85.134846] Starting subtest: engines-hang
[85.137416] Starting dynamic subtest: rcs0
[85.298820] Dynamic subtest rcs0: SUCCESS (0.163s)
[85.310384] Starting dynamic subtest: bcs0
[85.413523] Dynamic subtest bcs0: SUCCESS (0.114s)
[85.423856] Starting dynamic subtest: vcs0
[85.529306] Dynamic subtest vcs0: SUCCESS (0.114s)
[85.539567] Starting dynamic subtest: vcs1
[85.643952] Dynamic subtest vcs1: SUCCESS (0.114s)
[85.654226] Starting dynamic subtest: vecs0
[85.759338] Dynamic subtest vecs0: SUCCESS (0.114s)
[85.769906] Starting dynamic subtest: ccs0
[85.869218] Dynamic subtest ccs0: SUCCESS (0.109s)
[85.871898] Subtest engines-hang: SUCCESS (0.734s)
[85.955540] [018/134] (934s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[86.058540] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[86.084351] Starting dynamic subtest: pipe-A-plane-0
[86.088037] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[86.094328] Starting dynamic subtest: pipe-A-plane-3
[86.098028] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[86.105260] Starting dynamic subtest: pipe-A-plane-5
[86.109104] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[87.221985] Starting dynamic subtest: pipe-B-plane-0
[87.226119] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[87.233699] Starting dynamic subtest: pipe-B-plane-3
[87.237998] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[87.244488] Starting dynamic subtest: pipe-B-plane-5
[87.248844] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[87.531215] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (1.469s)
[88.405205] [019/134] (931s left) i915_pm_rc6_residency (media-rc6-accuracy)
[88.465987] Starting subtest: media-rc6-accuracy
[88.470267] Subtest media-rc6-accuracy: SKIP (0.000s)
[88.582212] [020/134] (931s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[88.688553] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[88.692635] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[88.788823] [021/134] (931s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[88.889345] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[88.891645] Starting dynamic subtest: pipe-A-default-mode
[91.618498] Dynamic subtest pipe-A-default-mode: SUCCESS (2.727s)
[91.620916] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.728s)
[92.509602] [022/134] (927s left) kms_chamelium_hpd (vga-hpd-fast)
[92.891938] Subtest vga-hpd-fast: SKIP (0.000s)
[93.677815] [023/134] (926s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[93.740233] Starting subtest: etime-single-wait-all-for-submit-submitted
[93.849342] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[93.937616] [024/134] (926s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[94.035245] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[94.037462] Starting dynamic subtest: pipe-A-eDP-1
[94.046223] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[94.054255] Starting dynamic subtest: pipe-B-eDP-1
[94.063016] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[94.070455] Starting dynamic subtest: pipe-C-eDP-1
[94.078429] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[94.084832] Starting dynamic subtest: pipe-D-eDP-1
[94.092837] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[94.096669] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s)
[96.293183] [025/134] (923s left) kms_psr (psr-cursor-mmap-cpu)
[96.391077] Starting subtest: psr-cursor-mmap-cpu
[96.393399] Starting dynamic subtest: eDP-1
[98.078621] Dynamic subtest eDP-1: SUCCESS (1.687s)
[98.080934] Subtest psr-cursor-mmap-cpu: SUCCESS (1.687s)
[98.943745] [026/134] (921s left) kms_sequence (get-forked-busy)
[99.045047] Starting subtest: get-forked-busy
[99.047384] Starting dynamic subtest: pipe-A-eDP-1
[100.980246] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[100.987398] Starting dynamic subtest: pipe-B-eDP-1
[103.556852] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.577s)
[103.565148] Starting dynamic subtest: pipe-C-eDP-1
[106.173412] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[106.181796] Starting dynamic subtest: pipe-D-eDP-1
[108.794606] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[108.796608] Subtest get-forked-busy: SUCCESS (9.748s)
[109.615130] [027/134] (910s left) sysfs_timeslice_duration (invalid)
[109.683049] Starting subtest: invalid
[109.685558] Starting dynamic subtest: vecs0
[109.687867] Dynamic subtest vecs0: SUCCESS (0.000s)
[109.695652] Starting dynamic subtest: ccs0
[109.697579] Dynamic subtest ccs0: SUCCESS (0.000s)
[109.703961] Starting dynamic subtest: vcs0
[109.705908] Dynamic subtest vcs0: SUCCESS (0.000s)
[109.712271] Starting dynamic subtest: bcs0
[109.714147] Dynamic subtest bcs0: SUCCESS (0.000s)
[109.720475] Starting dynamic subtest: rcs0
[109.722389] Dynamic subtest rcs0: SUCCESS (0.000s)
[109.728572] Starting dynamic subtest: vcs1
[109.730501] Dynamic subtest vcs1: SUCCESS (0.000s)
[109.732860] Subtest invalid: SUCCESS (0.004s)
[109.808951] [028/134] (910s left) perf (i915-ref-count)
[109.893471] Starting subtest: i915-ref-count
[109.955077] Subtest i915-ref-count: SUCCESS (0.060s)
[110.005589] [029/134] (910s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[110.060239] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[110.062847] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[110.178958] [030/134] (910s left) kms_rmfb (close-fd)
[110.280237] Starting subtest: close-fd
[110.282201] Starting dynamic subtest: pipe-A-eDP-1
[110.387171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[110.396000] Starting dynamic subtest: pipe-B-eDP-1
[111.543271] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.156s)
[111.552921] Starting dynamic subtest: pipe-C-eDP-1
[112.674057] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s)
[112.682748] Starting dynamic subtest: pipe-D-eDP-1
[113.811045] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[113.813398] Subtest close-fd: SUCCESS (3.533s)
[115.029279] [031/134] (905s left) template (b)
[115.100374] Starting subtest: B
[115.102701] Subtest B: SUCCESS (0.000s)
[115.196461] [032/134] (905s left) kms_plane (pixel-format-linear-modifier)
[115.281203] Starting subtest: pixel-format-linear-modifier
[115.306796] Starting dynamic subtest: pipe-A-plane-0
[118.773271] Dynamic subtest pipe-A-plane-0: SUCCESS (3.467s)
[118.783048] Starting dynamic subtest: pipe-A-plane-3
[120.484532] Dynamic subtest pipe-A-plane-3: SUCCESS (1.711s)
[120.492828] Starting dynamic subtest: pipe-A-plane-5
[120.684644] Dynamic subtest pipe-A-plane-5: SUCCESS (0.200s)
[121.809155] Starting dynamic subtest: pipe-B-plane-0
[125.269361] Dynamic subtest pipe-B-plane-0: SUCCESS (3.467s)
[125.276160] Starting dynamic subtest: pipe-B-plane-3
[126.915811] Dynamic subtest pipe-B-plane-3: SUCCESS (1.644s)
[126.927875] Starting dynamic subtest: pipe-B-plane-5
[127.125460] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s)
[127.438128] Subtest pixel-format-linear-modifier: SUCCESS (12.157s)
[128.291362] [033/134] (892s left) gem_ctx_shared (q-promotion)
[128.361046] Starting subtest: Q-promotion
[128.363211] Starting dynamic subtest: rcs0
[128.524195] Dynamic subtest rcs0: SUCCESS (0.164s)
[128.537973] Starting dynamic subtest: vcs0
[128.600402] Dynamic subtest vcs0: SUCCESS (0.077s)
[128.616097] Starting dynamic subtest: vcs1
[128.683555] Dynamic subtest vcs1: SUCCESS (0.081s)
[128.698792] Starting dynamic subtest: vecs0
[128.758061] Dynamic subtest vecs0: SUCCESS (0.074s)
[128.772516] Starting dynamic subtest: ccs0
[128.836998] Dynamic subtest ccs0: SUCCESS (0.078s)
[128.839441] Subtest Q-promotion: SUCCESS (0.478s)
[130.002037] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[130.005803] [034/134] (890s left) kms_cursor_crc (cursor-offscreen-max-size)
[130.311878] Starting subtest: cursor-offscreen-max-size
[130.318250] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[130.482254] [035/134] (890s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[130.577240] Starting subtest: fbc-psr-sprite-mmap-gtt
[130.579486] Starting dynamic subtest: eDP-1
[130.583584] Dynamic subtest eDP-1: SKIP (0.000s)
[130.587708] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.002s)
[130.647280] [036/134] (890s left) sw_sync (sync_merge_invalid)
[130.686748] Starting subtest: sync_merge_invalid
[130.708350] Subtest sync_merge_invalid: SUCCESS (0.022s)
[130.798702] [037/134] (889s left) i915_drm_fdinfo (busy-idle-check-all)
[130.835997] Starting subtest: busy-idle-check-all
[130.838194] Starting dynamic subtest: rcs0
[130.842651] Dynamic subtest rcs0: SKIP (0.003s)
[130.851230] Starting dynamic subtest: bcs0
[130.855303] Dynamic subtest bcs0: SKIP (0.000s)
[130.862610] Starting dynamic subtest: vcs0
[130.866591] Dynamic subtest vcs0: SKIP (0.000s)
[130.873289] Starting dynamic subtest: vcs1
[130.877261] Dynamic subtest vcs1: SKIP (0.000s)
[130.883905] Starting dynamic subtest: vecs0
[130.887791] Dynamic subtest vecs0: SKIP (0.000s)
[130.894265] Starting dynamic subtest: ccs0
[130.898139] Dynamic subtest ccs0: SKIP (0.000s)
[130.902044] Subtest busy-idle-check-all: SKIP (0.008s)
[130.936561] [038/134] (889s left) i915_module_load (reload)
[130.969279] Starting subtest: reload
[135.941919] Subtest reload: SUCCESS (4.973s)
[135.986165] [039/134] (884s left) gem_exec_suspend (basic-s3)
[137.857472] Starting subtest: basic-S3
[137.859854] Starting dynamic subtest: smem
[158.748581] Dynamic subtest smem: SUCCESS (6.967s)
[158.751871] Subtest basic-S3: SUCCESS (6.969s)
[158.958770] [040/134] (861s left) gem_close (many-handles-one-vma)
[159.045715] Starting subtest: many-handles-one-vma
[159.071499] Subtest many-handles-one-vma: SUCCESS (0.025s)
[159.197424] [041/134] (861s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[159.294023] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[159.296441] Starting dynamic subtest: pipe-A-eDP-1
[159.322121] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[159.341135] Starting dynamic subtest: pipe-B-eDP-1
[159.365734] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[159.382753] Starting dynamic subtest: pipe-C-eDP-1
[159.407375] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[159.424083] Starting dynamic subtest: pipe-D-eDP-1
[159.449343] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[159.454021] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[161.555357] [042/134] (859s left) gem_exec_balancer (parallel-out-fence)
[161.832860] Starting subtest: parallel-out-fence
[163.082891] Subtest parallel-out-fence: SUCCESS (1.238s)
[163.207864] [043/134] (857s left) gem_exec_reloc (basic-gtt-read)
[163.273224] Subtest basic-gtt-read: SKIP (0.000s)
[163.337990] [044/134] (857s left) kms_invalid_mode (bad-vsync-start)
[163.426587] Starting subtest: bad-vsync-start
[163.429048] Starting dynamic subtest: pipe-A-eDP-1
[163.713630] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[163.722511] Starting dynamic subtest: pipe-B-eDP-1
[163.724817] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[163.732407] Starting dynamic subtest: pipe-C-eDP-1
[163.734812] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[163.742576] Starting dynamic subtest: pipe-D-eDP-1
[163.744900] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[163.747220] Subtest bad-vsync-start: SUCCESS (0.289s)
[164.602964] [045/134] (856s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[164.697223] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[164.701800] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[164.823020] [046/134] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[164.923116] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[164.927363] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[165.051198] [047/134] (856s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[165.149990] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[171.704088] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.520s)
[171.850080] [048/134] (849s left) perf_pmu (busy-idle)
[171.897888] Starting subtest: busy-idle
[171.899854] Starting dynamic subtest: rcs0
[172.613171] Dynamic subtest rcs0: SUCCESS (0.713s)
[172.625083] Starting dynamic subtest: bcs0
[173.286490] Dynamic subtest bcs0: SUCCESS (0.669s)
[173.298165] Starting dynamic subtest: vcs0
[174.809555] Dynamic subtest vcs0: SUCCESS (1.516s)
[174.820843] Starting dynamic subtest: vcs1
[176.794572] Dynamic subtest vcs1: SUCCESS (1.977s)
[176.806726] Starting dynamic subtest: vecs0
[178.779554] Dynamic subtest vecs0: SUCCESS (1.978s)
[178.791097] Starting dynamic subtest: ccs0
[179.450260] Dynamic subtest ccs0: SUCCESS (0.669s)
[179.452728] Subtest busy-idle: SUCCESS (7.538s)
[179.571204] [049/134] (841s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[179.706967] Starting subtest: short-flip-after-cursor-toggle
[180.635787] Subtest short-flip-after-cursor-toggle: SUCCESS (0.927s)
[181.520985] [050/134] (839s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[181.635750] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[181.638084] Starting dynamic subtest: pipe-A
[181.658773] Dynamic subtest pipe-A: SKIP (0.017s)
[181.668177] Starting dynamic subtest: pipe-B
[181.691241] Dynamic subtest pipe-B: SKIP (0.033s)
[181.699950] Starting dynamic subtest: pipe-C
[181.725731] Dynamic subtest pipe-C: SKIP (0.033s)
[181.734382] Starting dynamic subtest: pipe-D
[181.756322] Dynamic subtest pipe-D: SKIP (0.029s)
[181.760696] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.115s)
[181.889139] [051/134] (839s left) kms_vblank (ts-continuation-modeset)
[181.982201] Starting subtest: ts-continuation-modeset
[181.984055] Starting dynamic subtest: pipe-A-eDP-1
[183.463740] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.479s)
[183.477969] Starting dynamic subtest: pipe-D-eDP-1
[185.631399] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.165s)
[185.633727] Subtest ts-continuation-modeset: SUCCESS (3.648s)
[186.456545] [052/134] (834s left) gem_exec_fence (keep-in-fence)
[186.632678] Starting subtest: keep-in-fence
[186.635237] Starting dynamic subtest: rcs0
[186.709040] Dynamic subtest rcs0: SUCCESS (0.076s)
[186.720978] Starting dynamic subtest: bcs0
[186.762355] Dynamic subtest bcs0: SUCCESS (0.052s)
[186.774965] Starting dynamic subtest: vcs0
[188.827600] Dynamic subtest vcs0: SUCCESS (2.060s)
[188.839247] Starting dynamic subtest: vcs1
[190.810503] Dynamic subtest vcs1: SUCCESS (1.980s)
[190.823068] Starting dynamic subtest: vecs0
[192.794251] Dynamic subtest vecs0: SUCCESS (1.981s)
[192.805882] Starting dynamic subtest: ccs0
[193.030252] Dynamic subtest ccs0: SUCCESS (0.235s)
[193.032785] Subtest keep-in-fence: SUCCESS (6.397s)
[194.996308] [053/134] (826s left) gem_basic (create-close)
[195.066531] Starting subtest: create-close
[195.071000] Subtest create-close: SUCCESS (0.000s)
[195.193289] [054/134] (826s left) kms_chamelium_color (gamma)
[195.284812] Subtest gamma: SKIP (0.000s)
[195.329435] [055/134] (826s left) perf_pmu (init-sema)
[195.372313] Starting subtest: init-sema
[195.374653] Starting dynamic subtest: rcs0
[195.376907] Dynamic subtest rcs0: SUCCESS (0.002s)
[195.386710] Starting dynamic subtest: bcs0
[195.388994] Dynamic subtest bcs0: SUCCESS (0.000s)
[195.399544] Starting dynamic subtest: vcs0
[195.401758] Dynamic subtest vcs0: SUCCESS (0.000s)
[195.410274] Starting dynamic subtest: vcs1
[195.412437] Dynamic subtest vcs1: SUCCESS (0.000s)
[195.420894] Starting dynamic subtest: vecs0
[195.423073] Dynamic subtest vecs0: SUCCESS (0.000s)
[195.431549] Starting dynamic subtest: ccs0
[195.433822] Dynamic subtest ccs0: SUCCESS (0.000s)
[195.436013] Subtest init-sema: SUCCESS (0.009s)
[195.497425] [056/134] (826s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[195.595087] Starting subtest: fbc-pr-sprite-mmap-cpu
[195.599035] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[195.679744] [057/134] (825s left) kms_lease (lease-get)
[195.779002] Starting subtest: lease-get
[195.781373] Starting dynamic subtest: pipe-A-eDP-1
[195.783598] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[195.794186] Starting dynamic subtest: pipe-B-eDP-1
[195.796260] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[195.804313] Starting dynamic subtest: pipe-C-eDP-1
[195.806379] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[195.814411] Starting dynamic subtest: pipe-D-eDP-1
[195.816442] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[195.818474] Subtest lease-get: SUCCESS (0.010s)
[195.917555] [058/134] (825s left) gem_lmem_swapping (parallel-random-verify-ccs)
[195.958859] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[196.005252] [059/134] (825s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[196.069933] Starting subtest: y-tiled-ccs-to-x-tiled
[196.073877] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[196.277461] [060/134] (825s left) gem_exec_balancer (bonded-false-hang)
[196.535947] Starting subtest: bonded-false-hang
[196.541094] Subtest bonded-false-hang: SKIP (0.000s)
[196.662497] [061/134] (825s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[201.689799] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[201.694480] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[202.544575] [062/134] (819s left) gen7_exec_parse (basic-allowed)
[202.609156] Subtest basic-allowed: SKIP (0.000s)
[202.698058] [063/134] (819s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[202.789950] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[202.792194] Starting dynamic subtest: pipe-A-eDP-1
[202.811371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[202.822189] Starting dynamic subtest: pipe-B-eDP-1
[202.840441] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[202.848726] Starting dynamic subtest: pipe-C-eDP-1
[202.867273] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[202.875544] Starting dynamic subtest: pipe-D-eDP-1
[202.895075] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[202.897001] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[205.095664] [064/134] (816s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[210.083387] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[210.087989] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[210.930295] [065/134] (810s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[211.027521] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[211.031502] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[211.153626] [066/134] (810s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[211.249788] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[211.251708] Starting dynamic subtest: pipe-A-eDP-1
[211.397691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s)
[211.407108] Starting dynamic subtest: pipe-B-eDP-1
[211.426434] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[211.434788] Starting dynamic subtest: pipe-C-eDP-1
[211.454209] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[211.462265] Starting dynamic subtest: pipe-D-eDP-1
[211.480776] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[211.482634] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.178s)
[213.718857] [067/134] (808s left) kms_flip (flip-vs-panning)
[213.824344] Starting subtest: flip-vs-panning
[213.826663] Starting dynamic subtest: A-eDP1
[222.510322] Dynamic subtest A-eDP1: SUCCESS (8.685s)
[222.519302] Starting dynamic subtest: B-eDP1
[231.237372] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[231.247958] Starting dynamic subtest: C-eDP1
[239.962425] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[239.970856] Starting dynamic subtest: D-eDP1
[248.693182] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[248.697312] Subtest flip-vs-panning: SUCCESS (34.869s)
[249.896013] [068/134] (772s left) syncobj_eventfd (timeline-wait)
[249.954413] Starting subtest: timeline-wait
[249.962803] Subtest timeline-wait: SUCCESS (0.011s)
[250.095693] [069/134] (771s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[250.200967] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[250.205391] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[250.337563] [070/134] (771s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[250.450759] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[250.453211] Starting dynamic subtest: A-eDP1
[253.997409] Dynamic subtest A-eDP1: SUCCESS (3.544s)
[254.015999] Starting dynamic subtest: B-eDP1
[257.191875] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[257.201219] Starting dynamic subtest: C-eDP1
[260.312319] Dynamic subtest C-eDP1: SUCCESS (3.117s)
[260.322591] Starting dynamic subtest: D-eDP1
[263.415884] Dynamic subtest D-eDP1: SUCCESS (3.103s)
[263.418185] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.966s)
[264.224701] [071/134] (757s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[264.327281] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[265.284069] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.956s)
[265.428471] [072/134] (756s left) gem_mmap_offset (oob-read)
[265.486184] Starting subtest: oob-read
[265.488476] Subtest oob-read: SUCCESS (0.000s)
[265.617572] [073/134] (756s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[265.706450] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[265.708229] Starting dynamic subtest: pipe-A-default-mode
[266.020346] Dynamic subtest pipe-A-default-mode: SKIP (0.313s)
[266.024841] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.314s)
[266.871595] [074/134] (755s left) gem_pxp (regular-baseline-src-copy-readible)
[267.001337] Starting subtest: regular-baseline-src-copy-readible
[267.057607] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[267.209517] [075/134] (755s left) kms_3d (basic)
[267.270742] Starting subtest: basic
[269.232794] Subtest basic: SUCCESS (1.964s)
[269.768555] [076/134] (752s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[269.879314] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[269.883349] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[269.991005] [077/134] (752s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[270.082601] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[270.086635] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[270.186453] [078/134] (752s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[270.285777] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[270.290408] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[270.418376] [079/134] (752s left) gem_exec_schedule (fairslice-all)
[270.497309] Starting subtest: fairslice-all
[272.542989] Subtest fairslice-all: SUCCESS (2.055s)
[273.836238] [080/134] (748s left) kms_properties (plane-properties-atomic)
[273.942925] Starting subtest: plane-properties-atomic
[273.944825] Starting dynamic subtest: pipe-A-eDP-1
[274.487489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[274.497858] Starting dynamic subtest: pipe-B-eDP-1
[275.720243] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.231s)
[275.730050] Starting dynamic subtest: pipe-C-eDP-1
[277.007081] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.284s)
[277.016958] Starting dynamic subtest: pipe-D-eDP-1
[278.302672] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[278.304977] Subtest plane-properties-atomic: SUCCESS (4.361s)
[279.194138] [081/134] (743s left) gem_cs_tlb (engines)
[279.260607] Starting subtest: engines
[279.262857] Starting dynamic subtest: rcs0
[281.415421] Dynamic subtest rcs0: SUCCESS (2.151s)
[281.427369] Starting dynamic subtest: bcs0
[283.567563] Dynamic subtest bcs0: SUCCESS (2.150s)
[283.578450] Starting dynamic subtest: vcs0
[285.720386] Dynamic subtest vcs0: SUCCESS (2.152s)
[285.728875] Starting dynamic subtest: vcs1
[287.875039] Dynamic subtest vcs1: SUCCESS (2.153s)
[287.886049] Starting dynamic subtest: vecs0
[290.025839] Dynamic subtest vecs0: SUCCESS (2.151s)
[290.035015] Starting dynamic subtest: ccs0
[292.180121] Dynamic subtest ccs0: SUCCESS (2.153s)
[292.182260] Subtest engines: SUCCESS (12.915s)
[292.325615] [082/134] (730s left) kms_scaling_modes (scaling-mode-none)
[292.432317] Starting subtest: scaling-mode-none
[292.434544] Starting dynamic subtest: pipe-A-eDP-1
[292.529676] Dynamic subtest pipe-A-eDP-1: SKIP (0.094s)
[292.541263] Starting dynamic subtest: pipe-B-eDP-1
[292.564629] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s)
[292.573798] Starting dynamic subtest: pipe-C-eDP-1
[292.602590] Dynamic subtest pipe-C-eDP-1: SKIP (0.036s)
[292.611836] Starting dynamic subtest: pipe-D-eDP-1
[292.636665] Dynamic subtest pipe-D-eDP-1: SKIP (0.033s)
[292.640932] Subtest scaling-mode-none: SKIP (0.203s)
[292.788726] [083/134] (729s left) kms_psr (pr-sprite-render)
[292.879344] Starting subtest: pr-sprite-render
[292.883360] Subtest pr-sprite-render: SKIP (0.000s)
[292.964589] [084/134] (729s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-pwrite)
[293.060687] Starting subtest: fbc-abgr161616f-draw-pwrite
[293.065084] Subtest fbc-abgr161616f-draw-pwrite: SKIP (0.000s)
[293.189001] [085/134] (729s left) kms_flip (2x-flip-vs-expired-vblank)
[293.289374] Starting subtest: 2x-flip-vs-expired-vblank
[293.297753] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[293.431635] [086/134] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[293.536877] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[293.540345] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[293.665428] [087/134] (729s left) kms_content_protection (srm)
[293.802729] Starting subtest: srm
[293.809238] Subtest srm: SKIP (0.002s)
[293.947391] [088/134] (728s left) gem_userptr_blits (process-exit-busy)
[294.011438] Starting subtest: process-exit-busy
[294.023733] Subtest process-exit-busy: SUCCESS (0.015s)
[294.188040] [089/134] (728s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[294.294801] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[294.298267] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[294.411343] [090/134] (728s left) kms_color (invalid-degamma-lut-sizes)
[294.501328] Starting subtest: invalid-degamma-lut-sizes
[294.503169] Starting dynamic subtest: pipe-A
[294.792912] Dynamic subtest pipe-A: SUCCESS (0.292s)
[294.802453] Starting dynamic subtest: pipe-B
[294.804714] Dynamic subtest pipe-B: SUCCESS (0.000s)
[294.813399] Starting dynamic subtest: pipe-C
[294.815616] Dynamic subtest pipe-C: SUCCESS (0.000s)
[294.824625] Starting dynamic subtest: pipe-D
[294.826897] Dynamic subtest pipe-D: SUCCESS (0.000s)
[294.829177] Subtest invalid-degamma-lut-sizes: SUCCESS (0.296s)
[295.599730] [091/134] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[295.712486] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[295.716549] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[295.844597] [092/134] (727s left) kms_pipe_crc_basic (nonblocking-crc)
[295.944083] Starting subtest: nonblocking-crc
[295.946291] Starting dynamic subtest: pipe-A-eDP-1
[296.690743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[296.701418] Starting dynamic subtest: pipe-B-eDP-1
[298.192782] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.504s)
[298.202657] Starting dynamic subtest: pipe-C-eDP-1
[299.590351] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[299.600452] Starting dynamic subtest: pipe-D-eDP-1
[301.015941] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.422s)
[301.018356] Subtest nonblocking-crc: SUCCESS (5.071s)
[301.882661] [093/134] (721s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[301.986881] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[302.755650] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.770s)
[302.952006] [094/134] (720s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[303.046043] Starting subtest: 4-tiled-8bpp-rotate-0
[304.225687] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.180s)
[304.374943] [095/134] (718s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[304.477299] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[304.480842] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[304.599308] [096/134] (718s left) gem_exec_schedule (u-semaphore-codependency)
[304.671386] Starting subtest: u-semaphore-codependency
[304.681972] Subtest u-semaphore-codependency: SUCCESS (0.015s)
[305.040403] [097/134] (718s left) syncobj_timeline (wait-any-snapshot)
[305.097974] Starting subtest: wait-any-snapshot
[305.177916] Subtest wait-any-snapshot: SUCCESS (0.082s)
[305.278545] [098/134] (718s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[305.349975] Subtest no-spare-fences-busy: SKIP (0.000s)
[305.426640] [099/134] (717s left) kms_dsc (dsc-with-output-formats-with-bpc)
[305.516217] Starting subtest: dsc-with-output-formats-with-bpc
[305.573318] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[305.611947] [100/134] (717s left) gem_userptr_blits (dmabuf-unsync)
[305.682693] Subtest dmabuf-unsync: SKIP (0.000s)
[305.838763] [101/134] (717s left) kms_prop_blob (blob-prop-core)
[305.907760] Starting subtest: blob-prop-core
[305.910164] Subtest blob-prop-core: SUCCESS (0.000s)
[306.040023] [102/134] (717s left) gem_exec_reloc (basic-gtt-cpu)
[306.096119] Subtest basic-gtt-cpu: SKIP (0.000s)
[306.164389] [103/134] (717s left) syncobj_timeline (invalid-query-bad-pad)
[306.225305] Starting subtest: invalid-query-bad-pad
[306.227306] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[306.380196] [104/134] (717s left) vgem_basic (dmabuf-export)
[306.428125] Starting subtest: dmabuf-export
[306.474152] Subtest dmabuf-export: SUCCESS (0.048s)
[306.598837] [105/134] (716s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-gtt)
[306.700276] Starting subtest: psr-abgr161616f-draw-mmap-gtt
[306.703615] Subtest psr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[306.832630] [106/134] (716s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[306.917637] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[306.921287] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[307.056133] [107/134] (716s left) gem_gpgpu_fill (basic)
[307.117098] Starting subtest: basic
[307.119381] Starting dynamic subtest: smem
[307.123835] Dynamic subtest smem: SUCCESS (0.008s)
[307.125824] Subtest basic: SUCCESS (0.008s)
[307.275578] [108/134] (716s left) gem_mmap_gtt (basic-copy)
[307.324978] Subtest basic-copy: SKIP (0.000s)
[307.386365] [109/134] (716s left) gen9_exec_parse (batch-invalid-length)
[307.453711] Subtest batch-invalid-length: SKIP (0.000s)
[307.533256] [110/134] (716s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[307.628459] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[307.631969] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[307.736998] [111/134] (716s left) gem_tiled_wc
[307.863288] [112/134] (716s left) gem_exec_capture (userptr)
[307.924574] Starting subtest: userptr
[308.765782] Subtest userptr: SUCCESS (0.841s)
[308.898790] [113/134] (715s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[309.000004] Starting subtest: flip-vs-dpms-off-vs-modeset
[309.002398] Starting dynamic subtest: A-eDP1
[312.617234] Dynamic subtest A-eDP1: SUCCESS (3.614s)
[312.627018] Starting dynamic subtest: B-eDP1
[315.912636] Dynamic subtest B-eDP1: SUCCESS (3.293s)
[315.921769] Starting dynamic subtest: C-eDP1
[319.215517] Dynamic subtest C-eDP1: SUCCESS (3.301s)
[319.224930] Starting dynamic subtest: D-eDP1
[322.500840] Dynamic subtest D-eDP1: SUCCESS (3.286s)
[322.503341] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.502s)
[323.386548] [114/134] (700s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[323.504092] Starting subtest: fbc-rgb565-draw-pwrite
[328.043118] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.542s)
[329.187701] [115/134] (694s left) gem_exec_whisper (basic-contexts-forked-all)
[329.258517] Starting subtest: basic-contexts-forked-all
[349.622342] Subtest basic-contexts-forked-all: SUCCESS (20.361s)
[349.820509] [116/134] (674s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[349.953633] Starting subtest: cursorB-vs-flipB-atomic
[349.958254] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[350.111174] [117/134] (673s left) gem_pread (exhaustion)
[350.162534] Subtest exhaustion: SKIP (0.000s)
[350.229466] [118/134] (673s left) gem_ctx_persistence (heartbeat-hostile)
[350.285262] Starting subtest: heartbeat-hostile
[350.289361] Subtest heartbeat-hostile: SKIP (0.000s)
[350.432256] [119/134] (673s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[350.537022] Starting subtest: extended-pageflip-modeset-hang-oldfb
[350.539150] Starting dynamic subtest: pipe-A
[358.451538] Dynamic subtest pipe-A: SUCCESS (7.914s)
[358.460925] Starting dynamic subtest: pipe-D
[367.044985] Dynamic subtest pipe-D: SUCCESS (8.590s)
[367.047292] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.509s)
[367.880608] [120/134] (656s left) gem_sync (basic-store-each)
[367.954563] Starting subtest: basic-store-each
[370.324981] Subtest basic-store-each: SUCCESS (2.380s)
[370.532279] [121/134] (653s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[370.624872] Starting subtest: psr-shrfb-scaledprimary
[376.334176] Subtest psr-shrfb-scaledprimary: SUCCESS (5.712s)
[376.482557] [122/134] (647s left) dmabuf_sync_file (import-multiple-read-only)
[376.524854] Starting subtest: import-multiple-read-only
[376.527053] Subtest import-multiple-read-only: SUCCESS (0.003s)
[376.606784] [123/134] (647s left) kms_atomic_interruptible (universal-setplane-primary)
[376.722417] Starting subtest: universal-setplane-primary
[376.724798] Starting dynamic subtest: pipe-A-eDP-1
[384.151523] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.428s)
[384.153938] Subtest universal-setplane-primary: SUCCESS (7.430s)
[384.985720] [124/134] (639s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[385.099846] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[391.631936] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.533s)
[391.791525] [125/134] (632s left) kms_cursor_edge_walk (128x128-right-edge)
[391.896302] Starting subtest: 128x128-right-edge
[391.898504] Starting dynamic subtest: pipe-A-eDP-1
[395.413686] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.517s)
[395.423531] Starting dynamic subtest: pipe-D-eDP-1
[398.597276] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.183s)
[398.599575] Subtest 128x128-right-edge: SUCCESS (6.703s)
[399.474307] [126/134] (624s left) api_intel_allocator (two-level-inception)
[399.532655] Starting subtest: two-level-inception
[404.929769] Subtest two-level-inception: SUCCESS (5.397s)
[405.078852] [127/134] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[405.203101] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[405.207511] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[405.331306] [128/134] (619s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[405.411993] Starting subtest: wait-all-for-submit-delayed-submit
[405.516351] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[405.633014] [129/134] (618s left) gem_exec_schedule (pi-ringfull)
[405.837584] Starting subtest: pi-ringfull
[405.839999] Starting dynamic subtest: rcs0
[405.882712] Dynamic subtest rcs0: SUCCESS (0.048s)
[405.893336] Starting dynamic subtest: bcs0
[405.945045] Dynamic subtest bcs0: SUCCESS (0.061s)
[405.957477] Starting dynamic subtest: vcs0
[405.988512] Dynamic subtest vcs0: SUCCESS (0.042s)
[405.998473] Starting dynamic subtest: vcs1
[406.027730] Dynamic subtest vcs1: SUCCESS (0.038s)
[406.037522] Starting dynamic subtest: vecs0
[406.063112] Dynamic subtest vecs0: SUCCESS (0.034s)
[406.072915] Starting dynamic subtest: ccs0
[406.098860] Dynamic subtest ccs0: SUCCESS (0.035s)
[406.101079] Subtest pi-ringfull: SUCCESS (0.265s)
[406.377065] [130/134] (618s left) kms_async_flips (crc-atomic)
[406.501495] Starting subtest: crc-atomic
[406.873639] Starting dynamic subtest: pipe-A-eDP-1
[409.835154] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.959s)
[410.214269] Starting dynamic subtest: pipe-B-eDP-1
[413.155506] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.951s)
[413.527761] Starting dynamic subtest: pipe-C-eDP-1
[416.424490] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.906s)
[416.789218] Starting dynamic subtest: pipe-D-eDP-1
[419.633063] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.852s)
[419.635389] Subtest crc-atomic: SUCCESS (13.133s)
[420.877630] [131/134] (603s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[425.941217] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[425.943460] Starting dynamic subtest: pipe-A-eDP-1
[432.407652] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.463s)
[432.417477] Starting dynamic subtest: pipe-B-eDP-1
[438.930803] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.521s)
[438.933053] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.989s)
[439.778229] [132/134] (584s left) i915_suspend (fence-restore-tiled2untiled)
[439.846858] Starting subtest: fence-restore-tiled2untiled
[439.851515] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[439.969798] [133/134] (584s left) prime_busy (after)
[440.027512] Starting subtest: after
[440.032682] Starting dynamic subtest: rcs0
[440.073434] Dynamic subtest rcs0: SUCCESS (0.043s)
[440.084887] Starting dynamic subtest: bcs0
[440.129094] Dynamic subtest bcs0: SUCCESS (0.054s)
[440.139572] Starting dynamic subtest: vcs0
[440.167604] Dynamic subtest vcs0: SUCCESS (0.039s)
[440.176655] Starting dynamic subtest: vcs1
[440.207828] Dynamic subtest vcs1: SUCCESS (0.039s)
[440.217201] Starting dynamic subtest: vecs0
[440.248179] Dynamic subtest vecs0: SUCCESS (0.039s)
[440.257244] Starting dynamic subtest: ccs0
[440.288233] Dynamic subtest ccs0: SUCCESS (0.039s)
[440.396657] Subtest after: SUCCESS (0.368s)
[440.495347] [134/134] (584s left) prime_mmap (test_refcounting)
[440.544822] Starting subtest: test_refcounting
[440.546688] Starting dynamic subtest: test_refcounting-smem
[440.572561] Dynamic subtest test_refcounting-smem: SUCCESS (0.029s)
[440.574960] Subtest test_refcounting: SUCCESS (0.030s)
[440.687143] 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.