[56.652836] Initializing watchdogs
[56.652902]   /dev/watchdog0
[56.666849] [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]
[56.671942] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.674128] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.677696] [001/134] (960s left) dumb_buffer (map-uaf)
[56.764251] Starting subtest: map-uaf
[56.769001] Subtest map-uaf: SUCCESS (0.005s)
[56.900534] [002/134] (960s left) kms_cursor_crc (cursor-size-hints)
[57.046045] Starting subtest: cursor-size-hints
[57.048478] Starting dynamic subtest: pipe-A-eDP-1
[57.725940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.673s)
[57.732798] Starting dynamic subtest: pipe-D-eDP-1
[58.988482] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s)
[58.990862] Subtest cursor-size-hints: SUCCESS (1.926s)
[59.813169] [003/134] (957s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[59.911888] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[59.916492] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[61.036132] [004/134] (956s left) syncobj_wait (single-wait-for-submit-signaled)
[61.084081] Starting subtest: single-wait-for-submit-signaled
[61.086357] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[61.195842] [005/134] (956s left) gem_workarounds (basic-read)
[61.252776] Starting subtest: basic-read
[61.262597] Subtest basic-read: SUCCESS (0.010s)
[61.383542] [006/134] (955s left) kms_dp_linktrain_fallback (dsc-fallback)
[61.487068] Starting subtest: dsc-fallback
[61.493689] Subtest dsc-fallback: SKIP (0.000s)
[61.574874] [007/134] (955s left) gem_create (create-invalid-size)
[61.632380] Starting subtest: create-invalid-size
[61.634715] Subtest create-invalid-size: SUCCESS (0.000s)
[61.830668] [008/134] (955s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[61.921681] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[61.926061] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[62.036824] [009/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[62.154182] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[68.759756] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.588s)
[68.919231] [010/134] (948s left) gem_partial_pwrite_pread (reads)
[68.989150] Subtest reads: SKIP (0.000s)
[69.053985] [011/134] (948s left) api_intel_bb (object-reloc-purge-cache)
[69.114819] Starting subtest: object-reloc-purge-cache
[69.119396] Subtest object-reloc-purge-cache: SKIP (0.002s)
[69.244832] [012/134] (948s left) gem_render_copy (y-tiled-to-vebox-linear)
[69.306312] Starting subtest: y-tiled-to-vebox-linear
[69.310631] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[69.497528] [013/134] (948s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[69.591766] Starting subtest: 2x-absolute-wf_vblank-interruptible
[69.606829] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.013s)
[69.691685] [014/134] (947s left) gem_softpin (allocator-nopin)
[69.750835] Starting subtest: allocator-nopin
[69.865702] Subtest allocator-nopin: SUCCESS (0.112s)
[70.026362] [015/134] (947s left) kms_pm_rpm (drm-resources-equal)
[72.057245] Starting subtest: drm-resources-equal
[77.052150] Subtest drm-resources-equal: SUCCESS (4.993s)
[77.162381] [016/134] (940s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[77.261341] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[77.263614] Starting dynamic subtest: pipe-A
[77.599363] Dynamic subtest pipe-A: SUCCESS (0.338s)
[77.619644] Starting dynamic subtest: pipe-B
[78.979098] Dynamic subtest pipe-B: SUCCESS (1.378s)
[78.987295] Starting dynamic subtest: pipe-C
[80.423080] Dynamic subtest pipe-C: SUCCESS (1.442s)
[80.432993] Starting dynamic subtest: pipe-D
[81.845384] Dynamic subtest pipe-D: SUCCESS (1.421s)
[81.847643] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.580s)
[83.022844] [017/134] (934s left) gem_ctx_persistence (engines-hang)
[83.086089] Starting subtest: engines-hang
[83.088625] Starting dynamic subtest: rcs0
[83.232945] Dynamic subtest rcs0: SUCCESS (0.146s)
[83.242985] Starting dynamic subtest: bcs0
[83.347212] Dynamic subtest bcs0: SUCCESS (0.113s)
[83.356161] Starting dynamic subtest: vcs0
[83.460980] Dynamic subtest vcs0: SUCCESS (0.113s)
[83.469819] Starting dynamic subtest: vcs1
[83.538539] Dynamic subtest vcs1: SUCCESS (0.077s)
[83.547212] Starting dynamic subtest: vecs0
[83.693970] Dynamic subtest vecs0: SUCCESS (0.154s)
[83.704034] Starting dynamic subtest: ccs0
[83.810895] Dynamic subtest ccs0: SUCCESS (0.116s)
[83.813777] Subtest engines-hang: SUCCESS (0.725s)
[83.900271] [018/134] (933s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[83.993481] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[84.019259] Starting dynamic subtest: pipe-A-plane-0
[84.023110] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[84.032302] Starting dynamic subtest: pipe-A-plane-3
[84.036066] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[84.043161] Starting dynamic subtest: pipe-A-plane-5
[84.046601] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[85.096669] Starting dynamic subtest: pipe-B-plane-0
[85.105980] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[85.113183] Starting dynamic subtest: pipe-B-plane-3
[85.117444] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[85.124424] Starting dynamic subtest: pipe-B-plane-5
[85.128033] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[85.421103] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (1.425s)
[86.275912] [019/134] (931s left) i915_pm_rc6_residency (media-rc6-accuracy)
[86.338863] Starting subtest: media-rc6-accuracy
[86.343401] Subtest media-rc6-accuracy: SKIP (0.000s)
[86.456291] [020/134] (931s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[86.548355] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[86.552650] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[86.673196] [021/134] (931s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[86.778958] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[86.781746] Starting dynamic subtest: pipe-A-default-mode
[89.514447] Dynamic subtest pipe-A-default-mode: SUCCESS (2.731s)
[89.516448] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.733s)
[90.387174] [022/134] (927s left) kms_chamelium_hpd (vga-hpd-fast)
[90.770717] Subtest vga-hpd-fast: SKIP (0.000s)
[91.584442] [023/134] (926s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[91.642927] Starting subtest: etime-single-wait-all-for-submit-submitted
[91.744433] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[91.825912] [024/134] (926s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[91.922702] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[91.924996] Starting dynamic subtest: pipe-A-eDP-1
[91.934195] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[91.943358] Starting dynamic subtest: pipe-B-eDP-1
[91.952384] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[91.960040] Starting dynamic subtest: pipe-C-eDP-1
[91.968633] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[91.975404] Starting dynamic subtest: pipe-D-eDP-1
[91.983846] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[91.987984] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[94.189636] [025/134] (923s left) kms_psr (psr-cursor-mmap-cpu)
[94.284695] Starting subtest: psr-cursor-mmap-cpu
[94.286910] Starting dynamic subtest: eDP-1
[95.980832] Dynamic subtest eDP-1: SUCCESS (1.697s)
[95.983191] Subtest psr-cursor-mmap-cpu: SUCCESS (1.697s)
[96.866312] [026/134] (921s left) kms_sequence (get-forked-busy)
[96.970126] Starting subtest: get-forked-busy
[96.972475] Starting dynamic subtest: pipe-A-eDP-1
[98.905804] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[98.916585] Starting dynamic subtest: pipe-B-eDP-1
[101.488740] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.578s)
[101.497912] Starting dynamic subtest: pipe-C-eDP-1
[104.097224] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.606s)
[104.105798] Starting dynamic subtest: pipe-D-eDP-1
[106.712429] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.613s)
[106.714737] Subtest get-forked-busy: SUCCESS (9.739s)
[107.516114] [027/134] (910s left) sysfs_timeslice_duration (invalid)
[107.577614] Starting subtest: invalid
[107.580094] Starting dynamic subtest: vecs0
[107.582557] Dynamic subtest vecs0: SUCCESS (0.000s)
[107.591675] Starting dynamic subtest: ccs0
[107.593639] Dynamic subtest ccs0: SUCCESS (0.000s)
[107.600426] Starting dynamic subtest: vcs0
[107.602427] Dynamic subtest vcs0: SUCCESS (0.000s)
[107.609343] Starting dynamic subtest: bcs0
[107.611317] Dynamic subtest bcs0: SUCCESS (0.000s)
[107.618065] Starting dynamic subtest: rcs0
[107.620056] Dynamic subtest rcs0: SUCCESS (0.000s)
[107.627256] Starting dynamic subtest: vcs1
[107.629495] Dynamic subtest vcs1: SUCCESS (0.000s)
[107.631759] Subtest invalid: SUCCESS (0.004s)
[107.707979] [028/134] (910s left) perf (i915-ref-count)
[107.790258] Starting subtest: i915-ref-count
[107.859783] Subtest i915-ref-count: SUCCESS (0.067s)
[107.916019] [029/134] (910s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[107.987729] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[107.990022] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[108.160817] [030/134] (910s left) kms_rmfb (close-fd)
[108.268508] Starting subtest: close-fd
[108.270663] Starting dynamic subtest: pipe-A-eDP-1
[108.375915] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[108.385051] Starting dynamic subtest: pipe-B-eDP-1
[109.554434] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.176s)
[109.566339] Starting dynamic subtest: pipe-C-eDP-1
[110.689895] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.135s)
[110.698145] Starting dynamic subtest: pipe-D-eDP-1
[111.830974] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[111.832992] Subtest close-fd: SUCCESS (3.561s)
[113.042959] [031/134] (905s left) template (b)
[113.106580] Starting subtest: B
[113.108627] Subtest B: SUCCESS (0.000s)
[113.230604] [032/134] (905s left) kms_plane (pixel-format-linear-modifier)
[113.332210] Starting subtest: pixel-format-linear-modifier
[113.360386] Starting dynamic subtest: pipe-A-plane-0
[116.838090] Dynamic subtest pipe-A-plane-0: SUCCESS (3.478s)
[116.846222] Starting dynamic subtest: pipe-A-plane-3
[118.582957] Dynamic subtest pipe-A-plane-3: SUCCESS (1.744s)
[118.591823] Starting dynamic subtest: pipe-A-plane-5
[118.805359] Dynamic subtest pipe-A-plane-5: SUCCESS (0.222s)
[119.915816] Starting dynamic subtest: pipe-B-plane-0
[123.520529] Dynamic subtest pipe-B-plane-0: SUCCESS (3.611s)
[123.532350] Starting dynamic subtest: pipe-B-plane-3
[125.198496] Dynamic subtest pipe-B-plane-3: SUCCESS (1.676s)
[125.206068] Starting dynamic subtest: pipe-B-plane-5
[125.409478] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s)
[125.737999] Subtest pixel-format-linear-modifier: SUCCESS (12.401s)
[126.613501] [033/134] (891s left) gem_ctx_shared (q-promotion)
[126.685895] Starting subtest: Q-promotion
[126.688337] Starting dynamic subtest: rcs0
[126.854486] Dynamic subtest rcs0: SUCCESS (0.167s)
[126.868071] Starting dynamic subtest: vcs0
[126.934715] Dynamic subtest vcs0: SUCCESS (0.081s)
[126.949561] Starting dynamic subtest: vcs1
[127.013052] Dynamic subtest vcs1: SUCCESS (0.077s)
[127.027182] Starting dynamic subtest: vecs0
[127.090649] Dynamic subtest vecs0: SUCCESS (0.077s)
[127.106712] Starting dynamic subtest: ccs0
[127.171657] Dynamic subtest ccs0: SUCCESS (0.080s)
[127.174307] Subtest Q-promotion: SUCCESS (0.485s)
[129.032508] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[129.035863] [034/134] (889s left) kms_cursor_crc (cursor-offscreen-max-size)
[129.390159] Starting subtest: cursor-offscreen-max-size
[129.396918] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[129.552655] [035/134] (888s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[129.659658] Starting subtest: fbc-psr-sprite-mmap-gtt
[129.661736] Starting dynamic subtest: eDP-1
[129.665668] Dynamic subtest eDP-1: SKIP (0.000s)
[129.669614] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[129.742418] [036/134] (888s left) sw_sync (sync_merge_invalid)
[129.777995] Starting subtest: sync_merge_invalid
[129.806366] Subtest sync_merge_invalid: SUCCESS (0.028s)
[129.886577] [037/134] (888s left) i915_drm_fdinfo (busy-idle-check-all)
[129.927265] Starting subtest: busy-idle-check-all
[129.929597] Starting dynamic subtest: rcs0
[129.933993] Dynamic subtest rcs0: SKIP (0.004s)
[129.941782] Starting dynamic subtest: bcs0
[129.946290] Dynamic subtest bcs0: SKIP (0.000s)
[129.953750] Starting dynamic subtest: vcs0
[129.957861] Dynamic subtest vcs0: SKIP (0.000s)
[129.964973] Starting dynamic subtest: vcs1
[129.969091] Dynamic subtest vcs1: SKIP (0.000s)
[129.976165] Starting dynamic subtest: vecs0
[129.980186] Dynamic subtest vecs0: SKIP (0.000s)
[129.987019] Starting dynamic subtest: ccs0
[129.990474] Dynamic subtest ccs0: SKIP (0.000s)
[129.993818] Subtest busy-idle-check-all: SKIP (0.008s)
[130.027888] [038/134] (888s left) i915_module_load (reload)
[130.060062] Starting subtest: reload
[135.047400] Subtest reload: SUCCESS (4.987s)
[135.095054] [039/134] (883s left) gem_exec_suspend (basic-s3)
[136.835596] Starting subtest: basic-S3
[136.838037] Starting dynamic subtest: smem
[157.693413] Dynamic subtest smem: SUCCESS (7.008s)
[157.696679] Subtest basic-S3: SUCCESS (7.011s)
[157.911266] [040/134] (860s left) gem_close (many-handles-one-vma)
[157.999226] Starting subtest: many-handles-one-vma
[158.022110] Subtest many-handles-one-vma: SUCCESS (0.025s)
[158.171168] [041/134] (860s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[158.273016] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[158.275398] Starting dynamic subtest: pipe-A-eDP-1
[158.300538] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[158.311239] Starting dynamic subtest: pipe-B-eDP-1
[158.335159] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[158.342962] Starting dynamic subtest: pipe-C-eDP-1
[158.367570] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[158.375089] Starting dynamic subtest: pipe-D-eDP-1
[158.399437] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[158.403873] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[160.526358] [042/134] (858s left) gem_exec_balancer (parallel-out-fence)
[160.800846] Starting subtest: parallel-out-fence
[161.996512] Subtest parallel-out-fence: SUCCESS (1.172s)
[162.115936] [043/134] (856s left) gem_exec_reloc (basic-gtt-read)
[162.180162] Subtest basic-gtt-read: SKIP (0.000s)
[162.276639] [044/134] (856s left) kms_invalid_mode (bad-vsync-start)
[162.364874] Starting subtest: bad-vsync-start
[162.367240] Starting dynamic subtest: pipe-A-eDP-1
[162.653512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[162.662686] Starting dynamic subtest: pipe-B-eDP-1
[162.664638] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[162.672465] Starting dynamic subtest: pipe-C-eDP-1
[162.674422] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[162.682861] Starting dynamic subtest: pipe-D-eDP-1
[162.685137] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[162.687308] Subtest bad-vsync-start: SUCCESS (0.291s)
[163.510989] [045/134] (855s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[163.626621] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[163.631114] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[163.773478] [046/134] (855s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[163.884623] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[163.888631] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[164.014287] [047/134] (854s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[164.115360] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[170.723187] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.550s)
[170.887091] [048/134] (848s left) perf_pmu (busy-idle)
[170.932506] Starting subtest: busy-idle
[170.934799] Starting dynamic subtest: rcs0
[171.654903] Dynamic subtest rcs0: SUCCESS (0.720s)
[171.666435] Starting dynamic subtest: bcs0
[172.330886] Dynamic subtest bcs0: SUCCESS (0.670s)
[172.342637] Starting dynamic subtest: vcs0
[173.691761] Dynamic subtest vcs0: SUCCESS (1.351s)
[173.703780] Starting dynamic subtest: vcs1
[175.675457] Dynamic subtest vcs1: SUCCESS (1.974s)
[175.687923] Starting dynamic subtest: vecs0
[177.724040] Dynamic subtest vecs0: SUCCESS (2.040s)
[177.736558] Starting dynamic subtest: ccs0
[178.389647] Dynamic subtest ccs0: SUCCESS (0.662s)
[178.392320] Subtest busy-idle: SUCCESS (7.431s)
[178.511079] [049/134] (840s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[178.639259] Starting subtest: short-flip-after-cursor-toggle
[179.558447] Subtest short-flip-after-cursor-toggle: SUCCESS (0.915s)
[180.372839] [050/134] (838s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[180.461460] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[180.463643] Starting dynamic subtest: pipe-A
[180.483338] Dynamic subtest pipe-A: SKIP (0.017s)
[180.501337] Starting dynamic subtest: pipe-B
[180.519218] Dynamic subtest pipe-B: SKIP (0.036s)
[180.532497] Starting dynamic subtest: pipe-C
[180.558000] Dynamic subtest pipe-C: SKIP (0.036s)
[180.567003] Starting dynamic subtest: pipe-D
[180.589138] Dynamic subtest pipe-D: SKIP (0.031s)
[180.593191] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.124s)
[180.726505] [051/134] (838s left) kms_vblank (ts-continuation-modeset)
[180.819610] Starting subtest: ts-continuation-modeset
[180.821786] Starting dynamic subtest: pipe-A-eDP-1
[182.341168] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.519s)
[182.356164] Starting dynamic subtest: pipe-D-eDP-1
[184.515103] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.168s)
[184.517295] Subtest ts-continuation-modeset: SUCCESS (3.691s)
[185.320866] [052/134] (833s left) gem_exec_fence (keep-in-fence)
[185.509234] Starting subtest: keep-in-fence
[185.511397] Starting dynamic subtest: rcs0
[185.585981] Dynamic subtest rcs0: SUCCESS (0.079s)
[185.597392] Starting dynamic subtest: bcs0
[185.639363] Dynamic subtest bcs0: SUCCESS (0.051s)
[185.650280] Starting dynamic subtest: vcs0
[187.761524] Dynamic subtest vcs0: SUCCESS (2.066s)
[187.772663] Starting dynamic subtest: vcs1
[189.693887] Dynamic subtest vcs1: SUCCESS (1.982s)
[189.705620] Starting dynamic subtest: vecs0
[191.791233] Dynamic subtest vecs0: SUCCESS (2.043s)
[191.802388] Starting dynamic subtest: ccs0
[191.967736] Dynamic subtest ccs0: SUCCESS (0.227s)
[191.970395] Subtest keep-in-fence: SUCCESS (6.461s)
[193.806212] [053/134] (825s left) gem_basic (create-close)
[193.874613] Starting subtest: create-close
[193.879001] Subtest create-close: SUCCESS (0.000s)
[194.001975] [054/134] (825s left) kms_chamelium_color (gamma)
[194.118431] Subtest gamma: SKIP (0.000s)
[194.168070] [055/134] (825s left) perf_pmu (init-sema)
[194.216570] Starting subtest: init-sema
[194.218839] Starting dynamic subtest: rcs0
[194.221151] Dynamic subtest rcs0: SUCCESS (0.002s)
[194.231188] Starting dynamic subtest: bcs0
[194.233033] Dynamic subtest bcs0: SUCCESS (0.000s)
[194.241465] Starting dynamic subtest: vcs0
[194.243484] Dynamic subtest vcs0: SUCCESS (0.001s)
[194.253562] Starting dynamic subtest: vcs1
[194.255413] Dynamic subtest vcs1: SUCCESS (0.001s)
[194.263424] Starting dynamic subtest: vecs0
[194.265232] Dynamic subtest vecs0: SUCCESS (0.000s)
[194.273602] Starting dynamic subtest: ccs0
[194.275704] Dynamic subtest ccs0: SUCCESS (0.000s)
[194.277764] Subtest init-sema: SUCCESS (0.008s)
[194.355050] [056/134] (824s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[194.443846] Starting subtest: fbc-pr-sprite-mmap-cpu
[194.448199] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[194.527944] [057/134] (824s left) kms_lease (lease-get)
[194.625731] Starting subtest: lease-get
[194.627995] Starting dynamic subtest: pipe-A-eDP-1
[194.630400] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[194.645502] Starting dynamic subtest: pipe-B-eDP-1
[194.647529] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[194.658714] Starting dynamic subtest: pipe-C-eDP-1
[194.660794] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[194.670984] Starting dynamic subtest: pipe-D-eDP-1
[194.672782] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[194.674561] Subtest lease-get: SUCCESS (0.009s)
[194.763146] [058/134] (824s left) gem_lmem_swapping (parallel-random-verify-ccs)
[194.806126] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[194.859895] [059/134] (824s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[194.919954] Starting subtest: y-tiled-ccs-to-x-tiled
[194.923746] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[195.115805] [060/134] (824s left) gem_exec_balancer (bonded-false-hang)
[195.385323] Starting subtest: bonded-false-hang
[195.390754] Subtest bonded-false-hang: SKIP (0.000s)
[195.513875] [061/134] (824s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[200.522568] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[200.527303] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.003s)
[201.379887] [062/134] (818s left) gen7_exec_parse (basic-allowed)
[201.443803] Subtest basic-allowed: SKIP (0.000s)
[201.538257] [063/134] (818s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[201.634190] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[201.636473] Starting dynamic subtest: pipe-A-eDP-1
[201.656764] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[201.668057] Starting dynamic subtest: pipe-B-eDP-1
[201.687643] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[201.696239] Starting dynamic subtest: pipe-C-eDP-1
[201.715396] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[201.724005] Starting dynamic subtest: pipe-D-eDP-1
[201.743175] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[201.745381] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[204.150073] [064/134] (815s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[209.212883] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[209.217283] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[210.085210] [065/134] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[210.192559] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[210.197049] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[210.326432] [066/134] (809s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[210.424650] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[210.426866] Starting dynamic subtest: pipe-A-eDP-1
[210.578535] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[210.589435] Starting dynamic subtest: pipe-B-eDP-1
[210.608034] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[210.617031] Starting dynamic subtest: pipe-C-eDP-1
[210.637099] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[210.646326] Starting dynamic subtest: pipe-D-eDP-1
[210.665046] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[210.667123] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.183s)
[212.845848] [067/134] (806s left) kms_flip (flip-vs-panning)
[212.942743] Starting subtest: flip-vs-panning
[212.945051] Starting dynamic subtest: A-eDP1
[221.638570] Dynamic subtest A-eDP1: SUCCESS (8.693s)
[221.651051] Starting dynamic subtest: B-eDP1
[230.362858] Dynamic subtest B-eDP1: SUCCESS (8.718s)
[230.374430] Starting dynamic subtest: C-eDP1
[239.091619] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[239.101687] Starting dynamic subtest: D-eDP1
[247.820946] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[247.825325] Subtest flip-vs-panning: SUCCESS (34.869s)
[249.090940] [068/134] (770s left) syncobj_eventfd (timeline-wait)
[249.151486] Starting subtest: timeline-wait
[249.159826] Subtest timeline-wait: SUCCESS (0.010s)
[249.290547] [069/134] (770s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[249.391330] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[249.395583] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[249.517490] [070/134] (770s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[249.614412] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[249.616539] Starting dynamic subtest: A-eDP1
[253.228971] Dynamic subtest A-eDP1: SUCCESS (3.610s)
[253.238095] Starting dynamic subtest: B-eDP1
[256.431265] Dynamic subtest B-eDP1: SUCCESS (3.203s)
[256.440769] Starting dynamic subtest: C-eDP1
[259.529059] Dynamic subtest C-eDP1: SUCCESS (3.098s)
[259.539048] Starting dynamic subtest: D-eDP1
[262.637589] Dynamic subtest D-eDP1: SUCCESS (3.109s)
[262.642525] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.030s)
[263.455124] [071/134] (756s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[263.566299] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[264.589491] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.023s)
[264.733186] [072/134] (755s left) gem_mmap_offset (oob-read)
[264.803491] Starting subtest: oob-read
[264.805472] Subtest oob-read: SUCCESS (0.000s)
[264.927345] [073/134] (755s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[265.036499] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[265.038357] Starting dynamic subtest: pipe-A-default-mode
[265.353891] Dynamic subtest pipe-A-default-mode: SKIP (0.314s)
[265.358385] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.316s)
[266.174407] [074/134] (753s left) gem_pxp (regular-baseline-src-copy-readible)
[266.301781] Starting subtest: regular-baseline-src-copy-readible
[266.367051] Subtest regular-baseline-src-copy-readible: SUCCESS (0.067s)
[266.528531] [075/134] (753s left) kms_3d (basic)
[266.590655] Starting subtest: basic
[268.687709] Subtest basic: SUCCESS (2.099s)
[269.179606] [076/134] (750s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[269.277248] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[269.280944] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[269.400716] [077/134] (750s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[269.497691] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[269.501761] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[269.632492] [078/134] (750s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[269.747314] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[269.751579] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[269.858593] [079/134] (750s left) gem_exec_schedule (fairslice-all)
[269.946517] Starting subtest: fairslice-all
[271.996860] Subtest fairslice-all: SUCCESS (2.058s)
[273.749726] [080/134] (746s left) kms_properties (plane-properties-atomic)
[273.851882] Starting subtest: plane-properties-atomic
[273.854128] Starting dynamic subtest: pipe-A-eDP-1
[274.401745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s)
[274.410979] Starting dynamic subtest: pipe-B-eDP-1
[275.634986] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.232s)
[275.647154] Starting dynamic subtest: pipe-C-eDP-1
[276.929372] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.293s)
[276.939127] Starting dynamic subtest: pipe-D-eDP-1
[278.235419] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.304s)
[278.237679] Subtest plane-properties-atomic: SUCCESS (4.383s)
[279.103111] [081/134] (741s left) gem_cs_tlb (engines)
[279.171575] Starting subtest: engines
[279.173824] Starting dynamic subtest: rcs0
[281.389491] Dynamic subtest rcs0: SUCCESS (2.152s)
[281.400907] Starting dynamic subtest: bcs0
[283.479130] Dynamic subtest bcs0: SUCCESS (2.151s)
[283.489976] Starting dynamic subtest: vcs0
[285.683035] Dynamic subtest vcs0: SUCCESS (2.151s)
[285.692553] Starting dynamic subtest: vcs1
[287.798174] Dynamic subtest vcs1: SUCCESS (2.152s)
[287.807397] Starting dynamic subtest: vecs0
[289.989946] Dynamic subtest vecs0: SUCCESS (2.152s)
[290.002161] Starting dynamic subtest: ccs0
[292.144739] Dynamic subtest ccs0: SUCCESS (2.154s)
[292.146886] Subtest engines: SUCCESS (12.917s)
[292.256059] [082/134] (728s left) kms_scaling_modes (scaling-mode-none)
[292.364909] Starting subtest: scaling-mode-none
[292.367278] Starting dynamic subtest: pipe-A-eDP-1
[292.465767] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[292.477641] Starting dynamic subtest: pipe-B-eDP-1
[292.499635] Dynamic subtest pipe-B-eDP-1: SKIP (0.031s)
[292.508839] Starting dynamic subtest: pipe-C-eDP-1
[292.533334] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[292.545720] Starting dynamic subtest: pipe-D-eDP-1
[292.566806] Dynamic subtest pipe-D-eDP-1: SKIP (0.033s)
[292.571124] Subtest scaling-mode-none: SKIP (0.203s)
[292.728642] [083/134] (727s left) kms_psr (pr-sprite-render)
[292.833848] Starting subtest: pr-sprite-render
[292.838209] Subtest pr-sprite-render: SKIP (0.000s)
[292.918268] [084/134] (727s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-pwrite)
[293.019614] Starting subtest: fbc-abgr161616f-draw-pwrite
[293.023841] Subtest fbc-abgr161616f-draw-pwrite: SKIP (0.000s)
[293.136611] [085/134] (727s left) kms_flip (2x-flip-vs-expired-vblank)
[293.238021] Starting subtest: 2x-flip-vs-expired-vblank
[293.248059] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[293.367375] [086/134] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[293.469849] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[293.473195] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[293.601766] [087/134] (727s left) kms_content_protection (srm)
[293.751464] Starting subtest: srm
[293.758188] Subtest srm: SKIP (0.002s)
[293.907133] [088/134] (726s left) gem_userptr_blits (process-exit-busy)
[293.981346] Starting subtest: process-exit-busy
[293.991016] Subtest process-exit-busy: SUCCESS (0.012s)
[294.148493] [089/134] (726s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[294.248535] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[294.252249] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[294.368592] [090/134] (726s left) kms_color (invalid-degamma-lut-sizes)
[294.462069] Starting subtest: invalid-degamma-lut-sizes
[294.464031] Starting dynamic subtest: pipe-A
[294.753777] Dynamic subtest pipe-A: SUCCESS (0.293s)
[294.762733] Starting dynamic subtest: pipe-B
[294.764944] Dynamic subtest pipe-B: SUCCESS (0.000s)
[294.773668] Starting dynamic subtest: pipe-C
[294.775819] Dynamic subtest pipe-C: SUCCESS (0.000s)
[294.784596] Starting dynamic subtest: pipe-D
[294.786721] Dynamic subtest pipe-D: SUCCESS (0.000s)
[294.789016] Subtest invalid-degamma-lut-sizes: SUCCESS (0.297s)
[295.641174] [091/134] (725s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[295.748620] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[295.752675] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[295.882350] [092/134] (724s left) kms_pipe_crc_basic (nonblocking-crc)
[295.979875] Starting subtest: nonblocking-crc
[295.982089] Starting dynamic subtest: pipe-A-eDP-1
[296.725528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.746s)
[296.735742] Starting dynamic subtest: pipe-B-eDP-1
[298.167489] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.440s)
[298.177293] Starting dynamic subtest: pipe-C-eDP-1
[299.521185] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.351s)
[299.531307] Starting dynamic subtest: pipe-D-eDP-1
[300.921837] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.396s)
[300.924087] Subtest nonblocking-crc: SUCCESS (4.939s)
[301.815496] [093/134] (719s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[301.915271] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[302.683910] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.770s)
[302.884401] [094/134] (718s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[302.990119] Starting subtest: 4-tiled-8bpp-rotate-0
[304.193719] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.203s)
[304.342253] [095/134] (716s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[304.436215] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[304.439772] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[304.566455] [096/134] (716s left) gem_exec_schedule (u-semaphore-codependency)
[304.636526] Starting subtest: u-semaphore-codependency
[304.648684] Subtest u-semaphore-codependency: SUCCESS (0.018s)
[305.026779] [097/134] (716s left) syncobj_timeline (wait-any-snapshot)
[305.077419] Starting subtest: wait-any-snapshot
[305.160027] Subtest wait-any-snapshot: SUCCESS (0.082s)
[305.260854] [098/134] (715s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[305.312290] Subtest no-spare-fences-busy: SKIP (0.000s)
[305.392929] [099/134] (715s left) kms_dsc (dsc-with-output-formats-with-bpc)
[305.488259] Starting subtest: dsc-with-output-formats-with-bpc
[305.546384] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[305.587172] [100/134] (715s left) gem_userptr_blits (dmabuf-unsync)
[305.660374] Subtest dmabuf-unsync: SKIP (0.000s)
[305.792992] [101/134] (715s left) kms_prop_blob (blob-prop-core)
[305.863537] Starting subtest: blob-prop-core
[305.865778] Subtest blob-prop-core: SUCCESS (0.000s)
[305.965852] [102/134] (715s left) gem_exec_reloc (basic-gtt-cpu)
[306.028868] Subtest basic-gtt-cpu: SKIP (0.000s)
[306.125486] [103/134] (715s left) syncobj_timeline (invalid-query-bad-pad)
[306.182263] Starting subtest: invalid-query-bad-pad
[306.184273] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[306.304254] [104/134] (715s left) vgem_basic (dmabuf-export)
[306.343494] Starting subtest: dmabuf-export
[306.390265] Subtest dmabuf-export: SUCCESS (0.049s)
[306.513722] [105/134] (714s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-gtt)
[306.618020] Starting subtest: psr-abgr161616f-draw-mmap-gtt
[306.621445] Subtest psr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[306.750518] [106/134] (714s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[306.846774] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[306.850151] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[306.969460] [107/134] (714s left) gem_gpgpu_fill (basic)
[307.021337] Starting subtest: basic
[307.023427] Starting dynamic subtest: smem
[307.028026] Dynamic subtest smem: SUCCESS (0.008s)
[307.030086] Subtest basic: SUCCESS (0.009s)
[307.188900] [108/134] (714s left) gem_mmap_gtt (basic-copy)
[307.256783] Subtest basic-copy: SKIP (0.000s)
[307.323883] [109/134] (714s left) gen9_exec_parse (batch-invalid-length)
[307.394187] Subtest batch-invalid-length: SKIP (0.000s)
[307.477380] [110/134] (714s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[307.579872] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[307.583646] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[307.718867] [111/134] (713s left) gem_tiled_wc
[307.859298] [112/134] (713s left) gem_exec_capture (userptr)
[307.919490] Starting subtest: userptr
[308.757758] Subtest userptr: SUCCESS (0.836s)
[308.903870] [113/134] (712s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[308.999951] Starting subtest: flip-vs-dpms-off-vs-modeset
[309.002212] Starting dynamic subtest: A-eDP1
[312.635361] Dynamic subtest A-eDP1: SUCCESS (3.634s)
[312.645270] Starting dynamic subtest: B-eDP1
[315.932379] Dynamic subtest B-eDP1: SUCCESS (3.294s)
[315.943300] Starting dynamic subtest: C-eDP1
[319.218734] Dynamic subtest C-eDP1: SUCCESS (3.287s)
[319.229641] Starting dynamic subtest: D-eDP1
[322.540936] Dynamic subtest D-eDP1: SUCCESS (3.317s)
[322.543148] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.540s)
[323.412164] [114/134] (698s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[323.513319] Starting subtest: fbc-rgb565-draw-pwrite
[328.108265] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.597s)
[329.326824] [115/134] (692s left) gem_exec_whisper (basic-contexts-forked-all)
[329.384816] Starting subtest: basic-contexts-forked-all
[349.608791] Subtest basic-contexts-forked-all: SUCCESS (20.215s)
[349.815918] [116/134] (672s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[349.946398] Starting subtest: cursorB-vs-flipB-atomic
[349.950826] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[350.116009] [117/134] (671s left) gem_pread (exhaustion)
[350.179558] Subtest exhaustion: SKIP (0.000s)
[350.250181] [118/134] (671s left) gem_ctx_persistence (heartbeat-hostile)
[350.310028] Starting subtest: heartbeat-hostile
[350.314423] Subtest heartbeat-hostile: SKIP (0.000s)
[350.439539] [119/134] (671s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[350.537851] Starting subtest: extended-pageflip-modeset-hang-oldfb
[350.540107] Starting dynamic subtest: pipe-A
[358.445040] Dynamic subtest pipe-A: SUCCESS (7.902s)
[358.458828] Starting dynamic subtest: pipe-D
[367.087474] Dynamic subtest pipe-D: SUCCESS (8.641s)
[367.089898] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.547s)
[367.919405] [120/134] (654s left) gem_sync (basic-store-each)
[367.998593] Starting subtest: basic-store-each
[370.440992] Subtest basic-store-each: SUCCESS (2.451s)
[370.648847] [121/134] (651s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[370.753514] Starting subtest: psr-shrfb-scaledprimary
[376.488629] Subtest psr-shrfb-scaledprimary: SUCCESS (5.735s)
[376.630787] [122/134] (645s left) dmabuf_sync_file (import-multiple-read-only)
[376.674905] Starting subtest: import-multiple-read-only
[376.677249] Subtest import-multiple-read-only: SUCCESS (0.003s)
[376.747472] [123/134] (645s left) kms_atomic_interruptible (universal-setplane-primary)
[376.855840] Starting subtest: universal-setplane-primary
[376.858120] Starting dynamic subtest: pipe-A-eDP-1
[384.308522] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.452s)
[384.310846] Subtest universal-setplane-primary: SUCCESS (7.454s)
[385.120990] [124/134] (637s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[385.237052] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[391.876038] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.644s)
[392.038040] [125/134] (630s left) kms_cursor_edge_walk (128x128-right-edge)
[392.134603] Starting subtest: 128x128-right-edge
[392.136868] Starting dynamic subtest: pipe-A-eDP-1
[395.646456] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.511s)
[395.656590] Starting dynamic subtest: pipe-D-eDP-1
[398.811307] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.166s)
[398.813577] Subtest 128x128-right-edge: SUCCESS (6.681s)
[399.626964] [126/134] (622s left) api_intel_allocator (two-level-inception)
[399.688000] Starting subtest: two-level-inception
[405.136282] Subtest two-level-inception: SUCCESS (5.398s)
[405.240071] [127/134] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[405.353982] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[405.358381] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[405.498796] [128/134] (616s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[405.561514] Starting subtest: wait-all-for-submit-delayed-submit
[405.663022] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[405.753729] [129/134] (616s left) gem_exec_schedule (pi-ringfull)
[405.937691] Starting subtest: pi-ringfull
[405.939780] Starting dynamic subtest: rcs0
[405.992513] Dynamic subtest rcs0: SUCCESS (0.056s)
[406.002813] Starting dynamic subtest: bcs0
[406.044890] Dynamic subtest bcs0: SUCCESS (0.051s)
[406.059544] Starting dynamic subtest: vcs0
[406.088768] Dynamic subtest vcs0: SUCCESS (0.043s)
[406.098428] Starting dynamic subtest: vcs1
[406.127473] Dynamic subtest vcs1: SUCCESS (0.037s)
[406.137126] Starting dynamic subtest: vecs0
[406.162690] Dynamic subtest vecs0: SUCCESS (0.034s)
[406.174994] Starting dynamic subtest: ccs0
[406.194758] Dynamic subtest ccs0: SUCCESS (0.031s)
[406.196950] Subtest pi-ringfull: SUCCESS (0.259s)
[406.480035] [130/134] (616s left) kms_async_flips (crc-atomic)
[406.586784] Starting subtest: crc-atomic
[406.969089] Starting dynamic subtest: pipe-A-eDP-1
[409.893435] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.922s)
[410.275020] Starting dynamic subtest: pipe-B-eDP-1
[413.178850] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.912s)
[413.568564] Starting dynamic subtest: pipe-C-eDP-1
[416.454414] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.894s)
[416.833228] Starting dynamic subtest: pipe-D-eDP-1
[419.784897] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.963s)
[419.787289] Subtest crc-atomic: SUCCESS (13.203s)
[421.005576] [131/134] (601s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[425.975876] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[425.978310] Starting dynamic subtest: pipe-A-eDP-1
[432.443019] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.468s)
[432.453164] Starting dynamic subtest: pipe-B-eDP-1
[438.942888] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.495s)
[438.945268] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.967s)
[439.812250] [132/134] (582s left) i915_suspend (fence-restore-tiled2untiled)
[439.890012] Starting subtest: fence-restore-tiled2untiled
[439.894541] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[440.017311] [133/134] (582s left) prime_busy (after)
[440.091522] Starting subtest: after
[440.093861] Starting dynamic subtest: rcs0
[440.142764] Dynamic subtest rcs0: SUCCESS (0.050s)
[440.154573] Starting dynamic subtest: bcs0
[440.207336] Dynamic subtest bcs0: SUCCESS (0.064s)
[440.218128] Starting dynamic subtest: vcs0
[440.247629] Dynamic subtest vcs0: SUCCESS (0.039s)
[440.256897] Starting dynamic subtest: vcs1
[440.288225] Dynamic subtest vcs1: SUCCESS (0.040s)
[440.297089] Starting dynamic subtest: vecs0
[440.328864] Dynamic subtest vecs0: SUCCESS (0.040s)
[440.338625] Starting dynamic subtest: ccs0
[440.370054] Dynamic subtest ccs0: SUCCESS (0.040s)
[440.478271] Subtest after: SUCCESS (0.387s)
[440.566496] [134/134] (582s left) prime_mmap (test_refcounting)
[440.635274] Starting subtest: test_refcounting
[440.637190] Starting dynamic subtest: test_refcounting-smem
[440.666165] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[440.668605] Subtest test_refcounting: SUCCESS (0.033s)
[440.797151] 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.