[58.381827] Initializing watchdogs
[58.381873]   /dev/watchdog0
[58.395118] [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.399764] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.401960] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.405179] [001/134] (960s left) dumb_buffer (map-uaf)
[58.486095] Starting subtest: map-uaf
[58.491077] Subtest map-uaf: SUCCESS (0.004s)
[58.604038] [002/134] (960s left) kms_cursor_crc (cursor-size-hints)
[58.741468] Starting subtest: cursor-size-hints
[58.743876] Starting dynamic subtest: pipe-A-eDP-1
[59.421201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.681s)
[59.427712] Starting dynamic subtest: pipe-D-eDP-1
[60.646934] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[60.649417] Subtest cursor-size-hints: SUCCESS (1.907s)
[61.465733] [003/134] (957s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[61.580482] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[61.585287] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[62.687449] [004/134] (956s left) syncobj_wait (single-wait-for-submit-signaled)
[62.745740] Starting subtest: single-wait-for-submit-signaled
[62.748071] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[62.853190] [005/134] (956s left) gem_workarounds (basic-read)
[62.930370] Starting subtest: basic-read
[62.939644] Subtest basic-read: SUCCESS (0.009s)
[63.069687] [006/134] (956s left) kms_dp_linktrain_fallback (dsc-fallback)
[63.167725] Starting subtest: dsc-fallback
[63.173850] Subtest dsc-fallback: SKIP (0.000s)
[63.250636] [007/134] (955s left) gem_create (create-invalid-size)
[63.305892] Starting subtest: create-invalid-size
[63.308216] Subtest create-invalid-size: SUCCESS (0.000s)
[63.512252] [008/134] (955s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[63.614669] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[63.619380] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[63.738032] [009/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[63.832513] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[70.345639] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.517s)
[70.516344] [010/134] (948s left) gem_partial_pwrite_pread (reads)
[70.584306] Subtest reads: SKIP (0.000s)
[70.641219] [011/134] (948s left) api_intel_bb (object-reloc-purge-cache)
[70.692774] Starting subtest: object-reloc-purge-cache
[70.699299] Subtest object-reloc-purge-cache: SKIP (0.004s)
[70.832060] [012/134] (948s left) gem_render_copy (y-tiled-to-vebox-linear)
[70.892828] Starting subtest: y-tiled-to-vebox-linear
[70.897470] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[71.083207] [013/134] (948s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[71.180655] Starting subtest: 2x-absolute-wf_vblank-interruptible
[71.191059] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[71.273858] [014/134] (948s left) gem_softpin (allocator-nopin)
[71.335631] Starting subtest: allocator-nopin
[71.461108] Subtest allocator-nopin: SUCCESS (0.123s)
[71.624691] [015/134] (947s left) kms_pm_rpm (drm-resources-equal)
[73.139027] Starting subtest: drm-resources-equal
[78.525928] Subtest drm-resources-equal: SUCCESS (5.388s)
[78.624103] [016/134] (940s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[78.708125] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[78.710341] Starting dynamic subtest: pipe-A
[79.043421] Dynamic subtest pipe-A: SUCCESS (0.338s)
[79.052196] Starting dynamic subtest: pipe-B
[80.434853] Dynamic subtest pipe-B: SUCCESS (1.390s)
[80.443205] Starting dynamic subtest: pipe-C
[81.865327] Dynamic subtest pipe-C: SUCCESS (1.430s)
[81.873708] Starting dynamic subtest: pipe-D
[83.297828] Dynamic subtest pipe-D: SUCCESS (1.432s)
[83.300029] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.593s)
[84.484051] [017/134] (935s left) gem_ctx_persistence (engines-hang)
[84.552450] Starting subtest: engines-hang
[84.554937] Starting dynamic subtest: rcs0
[84.640329] Dynamic subtest rcs0: SUCCESS (0.087s)
[84.650126] Starting dynamic subtest: bcs0
[84.741279] Dynamic subtest bcs0: SUCCESS (0.101s)
[84.751196] Starting dynamic subtest: vcs0
[84.869244] Dynamic subtest vcs0: SUCCESS (0.126s)
[84.879638] Starting dynamic subtest: vcs1
[84.946581] Dynamic subtest vcs1: SUCCESS (0.077s)
[84.955910] Starting dynamic subtest: vecs0
[85.097863] Dynamic subtest vecs0: SUCCESS (0.150s)
[85.107656] Starting dynamic subtest: ccs0
[85.212601] Dynamic subtest ccs0: SUCCESS (0.114s)
[85.215049] Subtest engines-hang: SUCCESS (0.661s)
[85.302191] [018/134] (934s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[85.406792] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[85.431862] Starting dynamic subtest: pipe-A-plane-0
[85.435604] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[85.442769] Starting dynamic subtest: pipe-A-plane-3
[85.446597] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[85.452778] Starting dynamic subtest: pipe-A-plane-5
[85.456549] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[86.561570] Starting dynamic subtest: pipe-B-plane-0
[86.565978] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[86.574260] Starting dynamic subtest: pipe-B-plane-3
[86.578847] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[86.587464] Starting dynamic subtest: pipe-B-plane-5
[86.592158] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[86.884759] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (1.475s)
[87.734098] [019/134] (931s left) i915_pm_rc6_residency (media-rc6-accuracy)
[87.796541] Starting subtest: media-rc6-accuracy
[87.801329] Subtest media-rc6-accuracy: SKIP (0.000s)
[87.890236] [020/134] (931s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[87.978587] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[87.982624] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[88.115270] [021/134] (931s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[88.214294] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[88.216622] Starting dynamic subtest: pipe-A-default-mode
[90.965706] Dynamic subtest pipe-A-default-mode: SUCCESS (2.748s)
[90.967740] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.750s)
[91.858401] [022/134] (927s left) kms_chamelium_hpd (vga-hpd-fast)
[92.251383] Subtest vga-hpd-fast: SKIP (0.000s)
[93.037742] [023/134] (926s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[93.094890] Starting subtest: etime-single-wait-all-for-submit-submitted
[93.202082] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[93.293613] [024/134] (926s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[93.383985] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[93.386316] Starting dynamic subtest: pipe-A-eDP-1
[93.395585] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.405086] Starting dynamic subtest: pipe-B-eDP-1
[93.414137] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.421066] Starting dynamic subtest: pipe-C-eDP-1
[93.429650] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.436120] Starting dynamic subtest: pipe-D-eDP-1
[93.444638] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[93.448757] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s)
[95.546743] [025/134] (924s left) kms_psr (psr-cursor-mmap-cpu)
[95.638204] Starting subtest: psr-cursor-mmap-cpu
[95.640495] Starting dynamic subtest: eDP-1
[97.328131] Dynamic subtest eDP-1: SUCCESS (1.691s)
[97.330394] Subtest psr-cursor-mmap-cpu: SUCCESS (1.692s)
[98.200505] [026/134] (921s left) kms_sequence (get-forked-busy)
[98.298344] Starting subtest: get-forked-busy
[98.300621] Starting dynamic subtest: pipe-A-eDP-1
[100.242997] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[100.251331] Starting dynamic subtest: pipe-B-eDP-1
[102.820684] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.575s)
[102.831578] Starting dynamic subtest: pipe-C-eDP-1
[105.425148] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.605s)
[105.433639] Starting dynamic subtest: pipe-D-eDP-1
[107.987690] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.560s)
[107.990239] Subtest get-forked-busy: SUCCESS (9.688s)
[108.869029] [027/134] (911s left) sysfs_timeslice_duration (invalid)
[108.941378] Starting subtest: invalid
[108.943782] Starting dynamic subtest: vecs0
[108.946142] Dynamic subtest vecs0: SUCCESS (0.000s)
[108.955237] Starting dynamic subtest: ccs0
[108.957341] Dynamic subtest ccs0: SUCCESS (0.000s)
[108.964237] Starting dynamic subtest: vcs0
[108.966385] Dynamic subtest vcs0: SUCCESS (0.000s)
[108.973196] Starting dynamic subtest: bcs0
[108.975372] Dynamic subtest bcs0: SUCCESS (0.000s)
[108.982084] Starting dynamic subtest: rcs0
[108.984215] Dynamic subtest rcs0: SUCCESS (0.000s)
[108.991091] Starting dynamic subtest: vcs1
[108.993187] Dynamic subtest vcs1: SUCCESS (0.000s)
[108.995230] Subtest invalid: SUCCESS (0.004s)
[109.069132] [028/134] (910s left) perf (i915-ref-count)
[109.138796] Starting subtest: i915-ref-count
[109.213222] Subtest i915-ref-count: SUCCESS (0.072s)
[109.265864] [029/134] (910s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[109.335654] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[109.338126] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[109.449469] [030/134] (910s left) kms_rmfb (close-fd)
[109.545872] Starting subtest: close-fd
[109.547965] Starting dynamic subtest: pipe-A-eDP-1
[109.653293] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[109.661216] Starting dynamic subtest: pipe-B-eDP-1
[110.819678] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s)
[110.826890] Starting dynamic subtest: pipe-C-eDP-1
[111.954244] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[111.962503] Starting dynamic subtest: pipe-D-eDP-1
[113.088044] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[113.090313] Subtest close-fd: SUCCESS (3.542s)
[114.307287] [031/134] (905s left) template (b)
[114.363429] Starting subtest: B
[114.365411] Subtest B: SUCCESS (0.000s)
[114.471640] [032/134] (905s left) kms_plane (pixel-format-linear-modifier)
[114.571193] Starting subtest: pixel-format-linear-modifier
[114.596692] Starting dynamic subtest: pipe-A-plane-0
[118.119168] Dynamic subtest pipe-A-plane-0: SUCCESS (3.522s)
[118.127923] Starting dynamic subtest: pipe-A-plane-3
[119.885339] Dynamic subtest pipe-A-plane-3: SUCCESS (1.766s)
[119.895711] Starting dynamic subtest: pipe-A-plane-5
[120.096300] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[121.180434] Starting dynamic subtest: pipe-B-plane-0
[124.718771] Dynamic subtest pipe-B-plane-0: SUCCESS (3.544s)
[124.729062] Starting dynamic subtest: pipe-B-plane-3
[126.430137] Dynamic subtest pipe-B-plane-3: SUCCESS (1.711s)
[126.437504] Starting dynamic subtest: pipe-B-plane-5
[126.651907] Dynamic subtest pipe-B-plane-5: SUCCESS (0.222s)
[126.971178] Subtest pixel-format-linear-modifier: SUCCESS (12.402s)
[127.789075] [033/134] (892s left) gem_ctx_shared (q-promotion)
[127.855241] Starting subtest: Q-promotion
[127.857572] Starting dynamic subtest: rcs0
[128.015672] Dynamic subtest rcs0: SUCCESS (0.159s)
[128.030383] Starting dynamic subtest: vcs0
[128.097721] Dynamic subtest vcs0: SUCCESS (0.082s)
[128.113032] Starting dynamic subtest: vcs1
[128.171059] Dynamic subtest vcs1: SUCCESS (0.073s)
[128.186938] Starting dynamic subtest: vecs0
[128.243727] Dynamic subtest vecs0: SUCCESS (0.072s)
[128.259048] Starting dynamic subtest: ccs0
[128.322410] Dynamic subtest ccs0: SUCCESS (0.078s)
[128.324801] Subtest Q-promotion: SUCCESS (0.467s)
[130.052693] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[130.056229] [034/134] (890s left) kms_cursor_crc (cursor-offscreen-max-size)
[130.355427] Starting subtest: cursor-offscreen-max-size
[130.362129] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[130.487297] [035/134] (889s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[130.586106] Starting subtest: fbc-psr-sprite-mmap-gtt
[130.588373] Starting dynamic subtest: eDP-1
[130.592413] Dynamic subtest eDP-1: SKIP (0.000s)
[130.596530] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[130.667154] [036/134] (889s left) sw_sync (sync_merge_invalid)
[130.703351] Starting subtest: sync_merge_invalid
[130.722437] Subtest sync_merge_invalid: SUCCESS (0.019s)
[130.800816] [037/134] (889s left) i915_drm_fdinfo (busy-idle-check-all)
[130.845683] Starting subtest: busy-idle-check-all
[130.847593] Starting dynamic subtest: rcs0
[130.852069] Dynamic subtest rcs0: SKIP (0.004s)
[130.863294] Starting dynamic subtest: bcs0
[130.867726] Dynamic subtest bcs0: SKIP (0.000s)
[130.875587] Starting dynamic subtest: vcs0
[130.879649] Dynamic subtest vcs0: SKIP (0.000s)
[130.886950] Starting dynamic subtest: vcs1
[130.891649] Dynamic subtest vcs1: SKIP (0.000s)
[130.900349] Starting dynamic subtest: vecs0
[130.904324] Dynamic subtest vecs0: SKIP (0.000s)
[130.910767] Starting dynamic subtest: ccs0
[130.914728] Dynamic subtest ccs0: SKIP (0.000s)
[130.918754] Subtest busy-idle-check-all: SKIP (0.008s)
[130.953455] [038/134] (889s left) i915_module_load (reload)
[130.990731] Starting subtest: reload
[135.927563] Subtest reload: SUCCESS (4.938s)
[135.971087] [039/134] (884s left) gem_exec_suspend (basic-s3)
[137.867557] Starting subtest: basic-S3
[137.870058] Starting dynamic subtest: smem
[158.298942] Dynamic subtest smem: SUCCESS (7.048s)
[158.301890] Subtest basic-S3: SUCCESS (7.050s)
[158.499559] [040/134] (861s left) gem_close (many-handles-one-vma)
[158.582454] Starting subtest: many-handles-one-vma
[158.605567] Subtest many-handles-one-vma: SUCCESS (0.024s)
[158.777840] [041/134] (861s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[158.874177] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[158.876437] Starting dynamic subtest: pipe-A-eDP-1
[158.902047] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[158.913439] Starting dynamic subtest: pipe-B-eDP-1
[158.933670] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[158.943203] Starting dynamic subtest: pipe-C-eDP-1
[158.966173] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[158.973937] Starting dynamic subtest: pipe-D-eDP-1
[158.998046] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[159.002410] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[161.144326] [042/134] (859s left) gem_exec_balancer (parallel-out-fence)
[161.408480] Starting subtest: parallel-out-fence
[162.550877] Subtest parallel-out-fence: SUCCESS (1.142s)
[162.680319] [043/134] (857s left) gem_exec_reloc (basic-gtt-read)
[162.746942] Subtest basic-gtt-read: SKIP (0.000s)
[162.838428] [044/134] (857s left) kms_invalid_mode (bad-vsync-start)
[162.940454] Starting subtest: bad-vsync-start
[162.942740] Starting dynamic subtest: pipe-A-eDP-1
[163.221637] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[163.230211] Starting dynamic subtest: pipe-B-eDP-1
[163.232448] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[163.239959] Starting dynamic subtest: pipe-C-eDP-1
[163.242082] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[163.249570] Starting dynamic subtest: pipe-D-eDP-1
[163.251488] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[163.253440] Subtest bad-vsync-start: SUCCESS (0.289s)
[164.078515] [045/134] (856s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[164.179042] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[164.183434] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[164.306573] [046/134] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[164.419700] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[164.423758] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[164.521932] [047/134] (856s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[164.634685] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[171.207121] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.575s)
[171.324667] [048/134] (849s left) perf_pmu (busy-idle)
[171.366980] Starting subtest: busy-idle
[171.369424] Starting dynamic subtest: rcs0
[172.076118] Dynamic subtest rcs0: SUCCESS (0.709s)
[172.085509] Starting dynamic subtest: bcs0
[172.757177] Dynamic subtest bcs0: SUCCESS (0.678s)
[172.768197] Starting dynamic subtest: vcs0
[174.297631] Dynamic subtest vcs0: SUCCESS (1.537s)
[174.309057] Starting dynamic subtest: vcs1
[176.282469] Dynamic subtest vcs1: SUCCESS (1.982s)
[176.293976] Starting dynamic subtest: vecs0
[178.266181] Dynamic subtest vecs0: SUCCESS (1.981s)
[178.277736] Starting dynamic subtest: ccs0
[178.942671] Dynamic subtest ccs0: SUCCESS (0.676s)
[178.945258] Subtest busy-idle: SUCCESS (7.577s)
[179.080370] [049/134] (841s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[179.217600] Starting subtest: short-flip-after-cursor-toggle
[180.134677] Subtest short-flip-after-cursor-toggle: SUCCESS (0.915s)
[180.960976] [050/134] (839s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[181.058286] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[181.060567] Starting dynamic subtest: pipe-A
[181.078534] Dynamic subtest pipe-A: SKIP (0.017s)
[181.088954] Starting dynamic subtest: pipe-B
[181.117000] Dynamic subtest pipe-B: SKIP (0.037s)
[181.126944] Starting dynamic subtest: pipe-C
[181.157255] Dynamic subtest pipe-C: SKIP (0.038s)
[181.165131] Starting dynamic subtest: pipe-D
[181.189185] Dynamic subtest pipe-D: SKIP (0.031s)
[181.192825] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.129s)
[181.288608] [051/134] (839s left) kms_vblank (ts-continuation-modeset)
[181.387190] Starting subtest: ts-continuation-modeset
[181.389507] Starting dynamic subtest: pipe-A-eDP-1
[182.907858] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.521s)
[182.922595] Starting dynamic subtest: pipe-D-eDP-1
[185.074552] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.161s)
[185.076431] Subtest ts-continuation-modeset: SUCCESS (3.687s)
[185.886866] [052/134] (835s left) gem_exec_fence (keep-in-fence)
[186.083927] Starting subtest: keep-in-fence
[186.086299] Starting dynamic subtest: rcs0
[186.170354] Dynamic subtest rcs0: SUCCESS (0.085s)
[186.180708] Starting dynamic subtest: bcs0
[186.224429] Dynamic subtest bcs0: SUCCESS (0.052s)
[186.236340] Starting dynamic subtest: vcs0
[188.315511] Dynamic subtest vcs0: SUCCESS (2.087s)
[188.326722] Starting dynamic subtest: vcs1
[190.298367] Dynamic subtest vcs1: SUCCESS (1.981s)
[190.309697] Starting dynamic subtest: vecs0
[192.282232] Dynamic subtest vecs0: SUCCESS (1.982s)
[192.293758] Starting dynamic subtest: ccs0
[192.519251] Dynamic subtest ccs0: SUCCESS (0.236s)
[192.522215] Subtest keep-in-fence: SUCCESS (6.436s)
[194.363270] [053/134] (826s left) gem_basic (create-close)
[194.425406] Starting subtest: create-close
[194.429889] Subtest create-close: SUCCESS (0.000s)
[194.547580] [054/134] (826s left) kms_chamelium_color (gamma)
[194.655325] Subtest gamma: SKIP (0.000s)
[194.697268] [055/134] (826s left) perf_pmu (init-sema)
[194.741809] Starting subtest: init-sema
[194.744201] Starting dynamic subtest: rcs0
[194.746578] Dynamic subtest rcs0: SUCCESS (0.002s)
[194.760053] Starting dynamic subtest: bcs0
[194.762073] Dynamic subtest bcs0: SUCCESS (0.000s)
[194.772832] Starting dynamic subtest: vcs0
[194.775149] Dynamic subtest vcs0: SUCCESS (0.001s)
[194.784909] Starting dynamic subtest: vcs1
[194.786981] Dynamic subtest vcs1: SUCCESS (0.000s)
[194.794947] Starting dynamic subtest: vecs0
[194.796784] Dynamic subtest vecs0: SUCCESS (0.001s)
[194.804742] Starting dynamic subtest: ccs0
[194.806803] Dynamic subtest ccs0: SUCCESS (0.000s)
[194.808839] Subtest init-sema: SUCCESS (0.010s)
[194.868615] [056/134] (826s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[194.953108] Starting subtest: fbc-pr-sprite-mmap-cpu
[194.957639] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[195.042878] [057/134] (826s left) kms_lease (lease-get)
[195.136862] Starting subtest: lease-get
[195.139479] Starting dynamic subtest: pipe-A-eDP-1
[195.141771] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[195.151328] Starting dynamic subtest: pipe-B-eDP-1
[195.153472] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[195.161557] Starting dynamic subtest: pipe-C-eDP-1
[195.163707] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[195.171906] Starting dynamic subtest: pipe-D-eDP-1
[195.174112] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[195.176309] Subtest lease-get: SUCCESS (0.014s)
[195.297744] [058/134] (825s left) gem_lmem_swapping (parallel-random-verify-ccs)
[195.349611] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[195.398131] [059/134] (825s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[195.475871] Starting subtest: y-tiled-ccs-to-x-tiled
[195.479622] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[195.670196] [060/134] (825s left) gem_exec_balancer (bonded-false-hang)
[195.923140] Starting subtest: bonded-false-hang
[195.928137] Subtest bonded-false-hang: SKIP (0.000s)
[196.074895] [061/134] (825s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[201.160520] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[201.165043] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[202.026067] [062/134] (819s left) gen7_exec_parse (basic-allowed)
[202.079564] Subtest basic-allowed: SKIP (0.000s)
[202.167633] [063/134] (819s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[202.261347] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[202.263630] Starting dynamic subtest: pipe-A-eDP-1
[202.283940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[202.297497] Starting dynamic subtest: pipe-B-eDP-1
[202.317419] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[202.328060] Starting dynamic subtest: pipe-C-eDP-1
[202.347209] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[202.356099] Starting dynamic subtest: pipe-D-eDP-1
[202.376434] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[202.378712] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[204.576235] [064/134] (816s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[209.632512] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[209.637143] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[210.505402] [065/134] (810s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[210.620733] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[210.624781] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[210.747910] [066/134] (810s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[210.864540] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[210.866800] Starting dynamic subtest: pipe-A-eDP-1
[211.019114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.147s)
[211.030502] Starting dynamic subtest: pipe-B-eDP-1
[211.049814] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[211.058726] Starting dynamic subtest: pipe-C-eDP-1
[211.078816] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[211.087032] Starting dynamic subtest: pipe-D-eDP-1
[211.106429] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[211.108285] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.180s)
[213.363370] [067/134] (808s left) kms_flip (flip-vs-panning)
[213.466317] Starting subtest: flip-vs-panning
[213.468551] Starting dynamic subtest: A-eDP1
[222.173999] Dynamic subtest A-eDP1: SUCCESS (8.707s)
[222.184657] Starting dynamic subtest: B-eDP1
[230.894019] Dynamic subtest B-eDP1: SUCCESS (8.719s)
[230.903743] Starting dynamic subtest: C-eDP1
[239.619686] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[239.629109] Starting dynamic subtest: D-eDP1
[248.347319] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[248.351731] Subtest flip-vs-panning: SUCCESS (34.884s)
[249.619861] [068/134] (771s left) syncobj_eventfd (timeline-wait)
[249.676878] Starting subtest: timeline-wait
[249.685881] Subtest timeline-wait: SUCCESS (0.011s)
[249.774906] [069/134] (771s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[249.882459] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[249.886690] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[250.007698] [070/134] (771s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[250.119239] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[250.121472] Starting dynamic subtest: A-eDP1
[253.735047] Dynamic subtest A-eDP1: SUCCESS (3.614s)
[253.744006] Starting dynamic subtest: B-eDP1
[256.938981] Dynamic subtest B-eDP1: SUCCESS (3.200s)
[256.947792] Starting dynamic subtest: C-eDP1
[260.046115] Dynamic subtest C-eDP1: SUCCESS (3.108s)
[260.059275] Starting dynamic subtest: D-eDP1
[263.142310] Dynamic subtest D-eDP1: SUCCESS (3.092s)
[263.144220] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.022s)
[263.952634] [071/134] (757s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[264.070598] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[265.160915] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.090s)
[265.293585] [072/134] (756s left) gem_mmap_offset (oob-read)
[265.341175] Starting subtest: oob-read
[265.342933] Subtest oob-read: SUCCESS (0.000s)
[265.459405] [073/134] (756s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[265.555549] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[265.557501] Starting dynamic subtest: pipe-A-default-mode
[265.872554] Dynamic subtest pipe-A-default-mode: SKIP (0.315s)
[265.877078] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.316s)
[266.678930] [074/134] (755s left) gem_pxp (regular-baseline-src-copy-readible)
[266.808228] Starting subtest: regular-baseline-src-copy-readible
[266.868416] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s)
[267.022237] [075/134] (754s left) kms_3d (basic)
[267.082679] Starting subtest: basic
[269.085917] Subtest basic: SUCCESS (2.003s)
[269.572999] [076/134] (752s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[269.669307] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[269.673351] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[269.809568] [077/134] (752s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[269.914667] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[269.919035] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[270.046583] [078/134] (751s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[270.152564] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[270.156981] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[270.294161] [079/134] (751s left) gem_exec_schedule (fairslice-all)
[270.384475] Starting subtest: fairslice-all
[272.435584] Subtest fairslice-all: SUCCESS (2.058s)
[274.384044] [080/134] (747s left) kms_properties (plane-properties-atomic)
[274.487573] Starting subtest: plane-properties-atomic
[274.489823] Starting dynamic subtest: pipe-A-eDP-1
[275.037278] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[275.047268] Starting dynamic subtest: pipe-B-eDP-1
[276.336236] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.301s)
[276.345061] Starting dynamic subtest: pipe-C-eDP-1
[277.632647] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.294s)
[277.642444] Starting dynamic subtest: pipe-D-eDP-1
[278.924824] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.292s)
[278.927203] Subtest plane-properties-atomic: SUCCESS (4.441s)
[279.789332] [081/134] (742s left) gem_cs_tlb (engines)
[279.851441] Starting subtest: engines
[279.853797] Starting dynamic subtest: rcs0
[282.007759] Dynamic subtest rcs0: SUCCESS (2.152s)
[282.017592] Starting dynamic subtest: bcs0
[284.159866] Dynamic subtest bcs0: SUCCESS (2.151s)
[284.168701] Starting dynamic subtest: vcs0
[286.340971] Dynamic subtest vcs0: SUCCESS (2.151s)
[286.353282] Starting dynamic subtest: vcs1
[288.464226] Dynamic subtest vcs1: SUCCESS (2.152s)
[288.474423] Starting dynamic subtest: vecs0
[290.616791] Dynamic subtest vecs0: SUCCESS (2.151s)
[290.626409] Starting dynamic subtest: ccs0
[292.771933] Dynamic subtest ccs0: SUCCESS (2.154s)
[292.773839] Subtest engines: SUCCESS (12.917s)
[292.931131] [082/134] (729s left) kms_scaling_modes (scaling-mode-none)
[293.034178] Starting subtest: scaling-mode-none
[293.036489] Starting dynamic subtest: pipe-A-eDP-1
[293.129371] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s)
[293.144344] Starting dynamic subtest: pipe-B-eDP-1
[293.174713] Dynamic subtest pipe-B-eDP-1: SKIP (0.043s)
[293.186884] Starting dynamic subtest: pipe-C-eDP-1
[293.207942] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[293.219513] Starting dynamic subtest: pipe-D-eDP-1
[293.250373] Dynamic subtest pipe-D-eDP-1: SKIP (0.039s)
[293.254804] Subtest scaling-mode-none: SKIP (0.216s)
[293.404048] [083/134] (728s left) kms_psr (pr-sprite-render)
[293.501365] Starting subtest: pr-sprite-render
[293.505841] Subtest pr-sprite-render: SKIP (0.000s)
[293.594809] [084/134] (728s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-pwrite)
[293.688816] Starting subtest: fbc-abgr161616f-draw-pwrite
[293.693086] Subtest fbc-abgr161616f-draw-pwrite: SKIP (0.000s)
[293.808004] [085/134] (728s left) kms_flip (2x-flip-vs-expired-vblank)
[293.907062] Starting subtest: 2x-flip-vs-expired-vblank
[293.916085] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[294.007745] [086/134] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[294.105626] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[294.108971] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[294.246235] [087/134] (728s left) kms_content_protection (srm)
[294.394802] Starting subtest: srm
[294.400660] Subtest srm: SKIP (0.002s)
[294.546790] [088/134] (727s left) gem_userptr_blits (process-exit-busy)
[294.637407] Starting subtest: process-exit-busy
[294.651208] Subtest process-exit-busy: SUCCESS (0.016s)
[294.813245] [089/134] (727s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[294.918782] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[294.922321] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[295.036991] [090/134] (727s left) kms_color (invalid-degamma-lut-sizes)
[295.122310] Starting subtest: invalid-degamma-lut-sizes
[295.124184] Starting dynamic subtest: pipe-A
[295.409194] Dynamic subtest pipe-A: SUCCESS (0.287s)
[295.418342] Starting dynamic subtest: pipe-B
[295.420440] Dynamic subtest pipe-B: SUCCESS (0.000s)
[295.429119] Starting dynamic subtest: pipe-C
[295.431301] Dynamic subtest pipe-C: SUCCESS (0.000s)
[295.439919] Starting dynamic subtest: pipe-D
[295.442124] Dynamic subtest pipe-D: SUCCESS (0.000s)
[295.443996] Subtest invalid-degamma-lut-sizes: SUCCESS (0.291s)
[296.204082] [091/134] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[296.306768] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[296.311043] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[296.436709] [092/134] (726s left) kms_pipe_crc_basic (nonblocking-crc)
[296.532256] Starting subtest: nonblocking-crc
[296.534552] Starting dynamic subtest: pipe-A-eDP-1
[297.292034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.758s)
[297.302430] Starting dynamic subtest: pipe-B-eDP-1
[298.647378] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.354s)
[298.657299] Starting dynamic subtest: pipe-C-eDP-1
[300.036282] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s)
[300.045853] Starting dynamic subtest: pipe-D-eDP-1
[301.416623] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.382s)
[301.419054] Subtest nonblocking-crc: SUCCESS (4.886s)
[302.306922] [093/134] (720s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[302.410629] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[303.157605] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.748s)
[303.339895] [094/134] (719s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[303.447287] Starting subtest: 4-tiled-8bpp-rotate-0
[304.649989] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.202s)
[304.819876] [095/134] (717s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[304.927370] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[304.930920] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[305.054945] [096/134] (717s left) gem_exec_schedule (u-semaphore-codependency)
[305.126017] Starting subtest: u-semaphore-codependency
[305.135335] Subtest u-semaphore-codependency: SUCCESS (0.015s)
[305.515106] [097/134] (717s left) syncobj_timeline (wait-any-snapshot)
[305.579328] Starting subtest: wait-any-snapshot
[305.657898] Subtest wait-any-snapshot: SUCCESS (0.081s)
[305.761568] [098/134] (717s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[305.818248] Subtest no-spare-fences-busy: SKIP (0.000s)
[305.881399] [099/134] (716s left) kms_dsc (dsc-with-output-formats-with-bpc)
[305.971435] Starting subtest: dsc-with-output-formats-with-bpc
[306.029537] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[306.090242] [100/134] (716s left) gem_userptr_blits (dmabuf-unsync)
[306.156222] Subtest dmabuf-unsync: SKIP (0.000s)
[306.295971] [101/134] (716s left) kms_prop_blob (blob-prop-core)
[306.351822] Starting subtest: blob-prop-core
[306.354140] Subtest blob-prop-core: SUCCESS (0.000s)
[306.477850] [102/134] (716s left) gem_exec_reloc (basic-gtt-cpu)
[306.533069] Subtest basic-gtt-cpu: SKIP (0.000s)
[306.617304] [103/134] (716s left) syncobj_timeline (invalid-query-bad-pad)
[306.667372] Starting subtest: invalid-query-bad-pad
[306.669111] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[306.801565] [104/134] (716s left) vgem_basic (dmabuf-export)
[306.849190] Starting subtest: dmabuf-export
[306.895989] Subtest dmabuf-export: SUCCESS (0.048s)
[307.014010] [105/134] (716s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-gtt)
[307.112602] Starting subtest: psr-abgr161616f-draw-mmap-gtt
[307.116186] Subtest psr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[307.243371] [106/134] (715s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[307.349364] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[307.352937] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[307.456579] [107/134] (715s left) gem_gpgpu_fill (basic)
[307.521027] Starting subtest: basic
[307.523280] Starting dynamic subtest: smem
[307.528077] Dynamic subtest smem: SUCCESS (0.008s)
[307.529998] Subtest basic: SUCCESS (0.008s)
[307.692042] [108/134] (715s left) gem_mmap_gtt (basic-copy)
[307.756299] Subtest basic-copy: SKIP (0.000s)
[307.817678] [109/134] (715s left) gen9_exec_parse (batch-invalid-length)
[307.884069] Subtest batch-invalid-length: SKIP (0.000s)
[307.960827] [110/134] (715s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[308.063029] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[308.066854] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[308.193146] [111/134] (715s left) gem_tiled_wc
[308.326080] [112/134] (715s left) gem_exec_capture (userptr)
[308.382817] Starting subtest: userptr
[309.226084] Subtest userptr: SUCCESS (0.839s)
[309.372978] [113/134] (714s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[309.470442] Starting subtest: flip-vs-dpms-off-vs-modeset
[309.472789] Starting dynamic subtest: A-eDP1
[313.135333] Dynamic subtest A-eDP1: SUCCESS (3.661s)
[313.144880] Starting dynamic subtest: B-eDP1
[316.412809] Dynamic subtest B-eDP1: SUCCESS (3.278s)
[316.422906] Starting dynamic subtest: C-eDP1
[319.725073] Dynamic subtest C-eDP1: SUCCESS (3.313s)
[319.734463] Starting dynamic subtest: D-eDP1
[323.028689] Dynamic subtest D-eDP1: SUCCESS (3.300s)
[323.030969] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.559s)
[323.905982] [114/134] (699s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[324.017934] Starting subtest: fbc-rgb565-draw-pwrite
[328.448890] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.434s)
[329.616142] [115/134] (693s left) gem_exec_whisper (basic-contexts-forked-all)
[329.685635] Starting subtest: basic-contexts-forked-all
[350.223522] Subtest basic-contexts-forked-all: SUCCESS (20.538s)
[350.423466] [116/134] (673s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[350.546211] Starting subtest: cursorB-vs-flipB-atomic
[350.550836] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[350.704244] [117/134] (672s left) gem_pread (exhaustion)
[350.769072] Subtest exhaustion: SKIP (0.000s)
[350.843540] [118/134] (672s left) gem_ctx_persistence (heartbeat-hostile)
[350.891975] Starting subtest: heartbeat-hostile
[350.896515] Subtest heartbeat-hostile: SKIP (0.000s)
[351.017776] [119/134] (672s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[351.122066] Starting subtest: extended-pageflip-modeset-hang-oldfb
[351.124382] Starting dynamic subtest: pipe-A
[359.021920] Dynamic subtest pipe-A: SUCCESS (7.899s)
[359.033628] Starting dynamic subtest: pipe-D
[367.655705] Dynamic subtest pipe-D: SUCCESS (8.631s)
[367.658065] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.536s)
[368.513054] [120/134] (655s left) gem_sync (basic-store-each)
[368.592381] Starting subtest: basic-store-each
[370.856538] Subtest basic-store-each: SUCCESS (2.274s)
[371.055918] [121/134] (652s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[371.157741] Starting subtest: psr-shrfb-scaledprimary
[376.834044] Subtest psr-shrfb-scaledprimary: SUCCESS (5.679s)
[376.985314] [122/134] (646s left) dmabuf_sync_file (import-multiple-read-only)
[377.033437] Starting subtest: import-multiple-read-only
[377.035743] Subtest import-multiple-read-only: SUCCESS (0.003s)
[377.104232] [123/134] (646s left) kms_atomic_interruptible (universal-setplane-primary)
[377.202288] Starting subtest: universal-setplane-primary
[377.204606] Starting dynamic subtest: pipe-A-eDP-1
[384.595428] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.393s)
[384.597754] Subtest universal-setplane-primary: SUCCESS (7.395s)
[385.411542] [124/134] (638s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[385.514961] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[392.076078] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.563s)
[392.240463] [125/134] (631s left) kms_cursor_edge_walk (128x128-right-edge)
[392.336298] Starting subtest: 128x128-right-edge
[392.338586] Starting dynamic subtest: pipe-A-eDP-1
[395.810439] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.472s)
[395.820957] Starting dynamic subtest: pipe-D-eDP-1
[399.002013] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.191s)
[399.004356] Subtest 128x128-right-edge: SUCCESS (6.666s)
[399.808599] [126/134] (624s left) api_intel_allocator (two-level-inception)
[399.868736] Starting subtest: two-level-inception
[405.266702] Subtest two-level-inception: SUCCESS (5.399s)
[405.411248] [127/134] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[405.517319] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[405.521498] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[405.657667] [128/134] (618s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[405.727406] Starting subtest: wait-all-for-submit-delayed-submit
[405.828729] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[405.919322] [129/134] (618s left) gem_exec_schedule (pi-ringfull)
[406.122821] Starting subtest: pi-ringfull
[406.125068] Starting dynamic subtest: rcs0
[406.170266] Dynamic subtest rcs0: SUCCESS (0.050s)
[406.180965] Starting dynamic subtest: bcs0
[406.226120] Dynamic subtest bcs0: SUCCESS (0.055s)
[406.237510] Starting dynamic subtest: vcs0
[406.269716] Dynamic subtest vcs0: SUCCESS (0.042s)
[406.283183] Starting dynamic subtest: vcs1
[406.308764] Dynamic subtest vcs1: SUCCESS (0.037s)
[406.318296] Starting dynamic subtest: vecs0
[406.342369] Dynamic subtest vecs0: SUCCESS (0.032s)
[406.355437] Starting dynamic subtest: ccs0
[406.373816] Dynamic subtest ccs0: SUCCESS (0.030s)
[406.376092] Subtest pi-ringfull: SUCCESS (0.255s)
[406.630823] [130/134] (617s left) kms_async_flips (crc-atomic)
[406.755395] Starting subtest: crc-atomic
[407.129274] Starting dynamic subtest: pipe-A-eDP-1
[410.064089] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.933s)
[410.439302] Starting dynamic subtest: pipe-B-eDP-1
[413.369059] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.939s)
[413.745943] Starting dynamic subtest: pipe-C-eDP-1
[416.642667] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.907s)
[417.009717] Starting dynamic subtest: pipe-D-eDP-1
[419.850269] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.847s)
[419.852624] Subtest crc-atomic: SUCCESS (13.094s)
[421.047317] [131/134] (603s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[426.089120] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[426.091598] Starting dynamic subtest: pipe-A-eDP-1
[432.525630] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.436s)
[432.538032] Starting dynamic subtest: pipe-B-eDP-1
[439.051240] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.522s)
[439.053579] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.962s)
[439.920152] [132/134] (584s left) i915_suspend (fence-restore-tiled2untiled)
[439.990742] Starting subtest: fence-restore-tiled2untiled
[439.995249] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[440.108811] [133/134] (584s left) prime_busy (after)
[440.166766] Starting subtest: after
[440.172856] Starting dynamic subtest: rcs0
[440.219069] Dynamic subtest rcs0: SUCCESS (0.049s)
[440.230182] Starting dynamic subtest: bcs0
[440.296856] Dynamic subtest bcs0: SUCCESS (0.076s)
[440.307690] Starting dynamic subtest: vcs0
[440.336201] Dynamic subtest vcs0: SUCCESS (0.039s)
[440.345435] Starting dynamic subtest: vcs1
[440.375723] Dynamic subtest vcs1: SUCCESS (0.039s)
[440.384928] Starting dynamic subtest: vecs0
[440.415832] Dynamic subtest vecs0: SUCCESS (0.039s)
[440.425278] Starting dynamic subtest: ccs0
[440.456337] Dynamic subtest ccs0: SUCCESS (0.040s)
[440.564241] Subtest after: SUCCESS (0.396s)
[440.663007] [134/134] (583s left) prime_mmap (test_refcounting)
[440.723317] Starting subtest: test_refcounting
[440.725537] Starting dynamic subtest: test_refcounting-smem
[440.753966] Dynamic subtest test_refcounting-smem: SUCCESS (0.032s)
[440.756685] Subtest test_refcounting: SUCCESS (0.033s)
[440.888889] 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.