[89.192562] Initializing watchdogs
[89.192608]   /dev/watchdog0
[89.206510] [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]
[89.211128] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.213276] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.216346] [001/134] (960s left) dumb_buffer (map-uaf)
[89.301787] Starting subtest: map-uaf
[89.307210] Subtest map-uaf: SUCCESS (0.006s)
[89.426178] [002/134] (960s left) kms_cursor_crc (cursor-size-hints)
[89.574936] Starting subtest: cursor-size-hints
[89.576920] Starting dynamic subtest: pipe-A-eDP-1
[90.235498] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.662s)
[90.243699] Starting dynamic subtest: pipe-D-eDP-1
[91.444027] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.208s)
[91.446250] Subtest cursor-size-hints: SUCCESS (1.872s)
[92.252778] [003/134] (957s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[92.349960] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[92.355991] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[93.484808] [004/134] (956s left) syncobj_wait (single-wait-for-submit-signaled)
[93.544294] Starting subtest: single-wait-for-submit-signaled
[93.546261] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[93.661930] [005/134] (956s left) gem_workarounds (basic-read)
[93.736818] Starting subtest: basic-read
[93.747292] Subtest basic-read: SUCCESS (0.010s)
[93.900987] [006/134] (956s left) kms_dp_linktrain_fallback (dsc-fallback)
[93.994120] Starting subtest: dsc-fallback
[94.000644] Subtest dsc-fallback: SKIP (0.000s)
[94.073819] [007/134] (955s left) gem_create (create-invalid-size)
[94.136877] Starting subtest: create-invalid-size
[94.139320] Subtest create-invalid-size: SUCCESS (0.000s)
[94.344747] [008/134] (955s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[94.439252] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[94.443781] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[94.557927] [009/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[94.660720] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[101.270190] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.625s)
[101.450625] [010/134] (948s left) gem_partial_pwrite_pread (reads)
[101.513073] Subtest reads: SKIP (0.000s)
[101.566846] [011/134] (948s left) api_intel_bb (object-reloc-purge-cache)
[101.625885] Starting subtest: object-reloc-purge-cache
[101.630510] Subtest object-reloc-purge-cache: SKIP (0.002s)
[101.755929] [012/134] (948s left) gem_render_copy (y-tiled-to-vebox-linear)
[101.815883] Starting subtest: y-tiled-to-vebox-linear
[101.820489] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[102.004245] [013/134] (948s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[102.102806] Starting subtest: 2x-absolute-wf_vblank-interruptible
[102.113453] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[102.194073] [014/134] (948s left) gem_softpin (allocator-nopin)
[102.249021] Starting subtest: allocator-nopin
[102.354430] Subtest allocator-nopin: SUCCESS (0.104s)
[102.504215] [015/134] (947s left) kms_pm_rpm (drm-resources-equal)
[104.032727] Starting subtest: drm-resources-equal
[109.382059] Subtest drm-resources-equal: SUCCESS (5.349s)
[109.492994] [016/134] (940s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[109.581940] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[109.584291] Starting dynamic subtest: pipe-A
[109.917465] Dynamic subtest pipe-A: SUCCESS (0.337s)
[109.925856] Starting dynamic subtest: pipe-B
[111.314285] Dynamic subtest pipe-B: SUCCESS (1.396s)
[111.333055] Starting dynamic subtest: pipe-C
[112.732576] Dynamic subtest pipe-C: SUCCESS (1.417s)
[112.743956] Starting dynamic subtest: pipe-D
[114.162040] Dynamic subtest pipe-D: SUCCESS (1.428s)
[114.164354] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.582s)
[115.327149] [017/134] (934s left) gem_ctx_persistence (engines-hang)
[115.387771] Starting subtest: engines-hang
[115.389690] Starting dynamic subtest: rcs0
[115.513771] Dynamic subtest rcs0: SUCCESS (0.128s)
[115.523686] Starting dynamic subtest: bcs0
[115.637239] Dynamic subtest bcs0: SUCCESS (0.122s)
[115.647243] Starting dynamic subtest: vcs0
[115.713712] Dynamic subtest vcs0: SUCCESS (0.076s)
[115.723030] Starting dynamic subtest: vcs1
[115.883357] Dynamic subtest vcs1: SUCCESS (0.168s)
[115.894083] Starting dynamic subtest: vecs0
[116.005058] Dynamic subtest vecs0: SUCCESS (0.121s)
[116.015048] Starting dynamic subtest: ccs0
[116.132399] Dynamic subtest ccs0: SUCCESS (0.126s)
[116.135193] Subtest engines-hang: SUCCESS (0.747s)
[116.231598] [018/134] (934s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[116.331681] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[116.360042] Starting dynamic subtest: pipe-A-plane-0
[116.363697] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[116.369895] Starting dynamic subtest: pipe-A-plane-3
[116.373702] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[116.380549] Starting dynamic subtest: pipe-A-plane-5
[116.384445] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[117.516970] Starting dynamic subtest: pipe-B-plane-0
[117.521161] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[117.528289] Starting dynamic subtest: pipe-B-plane-3
[117.532916] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[117.539955] Starting dynamic subtest: pipe-B-plane-5
[117.544588] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[117.826523] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (1.489s)
[118.698379] [019/134] (931s left) i915_pm_rc6_residency (media-rc6-accuracy)
[118.753678] Starting subtest: media-rc6-accuracy
[118.758169] Subtest media-rc6-accuracy: SKIP (0.000s)
[118.871824] [020/134] (931s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[118.974720] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[118.979147] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[119.115430] [021/134] (931s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[119.214857] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[119.217058] Starting dynamic subtest: pipe-A-default-mode
[121.908585] Dynamic subtest pipe-A-default-mode: SUCCESS (2.694s)
[121.910973] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.695s)
[122.790929] [022/134] (927s left) kms_chamelium_hpd (vga-hpd-fast)
[123.188015] Subtest vga-hpd-fast: SKIP (0.000s)
[123.991463] [023/134] (926s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[124.053052] Starting subtest: etime-single-wait-all-for-submit-submitted
[124.160346] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[124.246694] [024/134] (926s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[124.347049] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[124.349216] Starting dynamic subtest: pipe-A-eDP-1
[124.358144] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[124.366700] Starting dynamic subtest: pipe-B-eDP-1
[124.375335] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[124.382190] Starting dynamic subtest: pipe-C-eDP-1
[124.390563] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[124.397318] Starting dynamic subtest: pipe-D-eDP-1
[124.405839] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[124.410178] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s)
[126.589590] [025/134] (924s left) kms_psr (psr-cursor-mmap-cpu)
[126.689216] Starting subtest: psr-cursor-mmap-cpu
[126.691434] Starting dynamic subtest: eDP-1
[128.389933] Dynamic subtest eDP-1: SUCCESS (1.701s)
[128.392239] Subtest psr-cursor-mmap-cpu: SUCCESS (1.702s)
[129.253387] [026/134] (921s left) kms_sequence (get-forked-busy)
[129.358309] Starting subtest: get-forked-busy
[129.360592] Starting dynamic subtest: pipe-A-eDP-1
[131.292082] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[131.301586] Starting dynamic subtest: pipe-B-eDP-1
[133.933770] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.640s)
[133.941053] Starting dynamic subtest: pipe-C-eDP-1
[136.579448] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.645s)
[136.588347] Starting dynamic subtest: pipe-D-eDP-1
[139.188771] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.608s)
[139.190615] Subtest get-forked-busy: SUCCESS (9.831s)
[139.998588] [027/134] (910s left) sysfs_timeslice_duration (invalid)
[140.056813] Starting subtest: invalid
[140.059178] Starting dynamic subtest: vecs0
[140.061482] Dynamic subtest vecs0: SUCCESS (0.000s)
[140.069742] Starting dynamic subtest: ccs0
[140.071618] Dynamic subtest ccs0: SUCCESS (0.000s)
[140.078270] Starting dynamic subtest: vcs0
[140.080117] Dynamic subtest vcs0: SUCCESS (0.000s)
[140.086611] Starting dynamic subtest: bcs0
[140.088468] Dynamic subtest bcs0: SUCCESS (0.000s)
[140.095049] Starting dynamic subtest: rcs0
[140.096823] Dynamic subtest rcs0: SUCCESS (0.000s)
[140.103600] Starting dynamic subtest: vcs1
[140.105684] Dynamic subtest vcs1: SUCCESS (0.000s)
[140.107748] Subtest invalid: SUCCESS (0.004s)
[140.177641] [028/134] (910s left) perf (i915-ref-count)
[140.249781] Starting subtest: i915-ref-count
[140.324534] Subtest i915-ref-count: SUCCESS (0.073s)
[140.376980] [029/134] (910s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[140.428836] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[140.431144] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[140.531910] [030/134] (910s left) kms_rmfb (close-fd)
[140.625104] Starting subtest: close-fd
[140.627382] Starting dynamic subtest: pipe-A-eDP-1
[140.735154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[140.744179] Starting dynamic subtest: pipe-B-eDP-1
[141.956302] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.220s)
[141.964613] Starting dynamic subtest: pipe-C-eDP-1
[143.071221] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[143.082129] Starting dynamic subtest: pipe-D-eDP-1
[144.201935] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[144.204153] Subtest close-fd: SUCCESS (3.577s)
[145.427886] [031/134] (905s left) template (b)
[145.487892] Starting subtest: B
[145.490237] Subtest B: SUCCESS (0.000s)
[145.618944] [032/134] (905s left) kms_plane (pixel-format-linear-modifier)
[145.709740] Starting subtest: pixel-format-linear-modifier
[145.735414] Starting dynamic subtest: pipe-A-plane-0
[149.179291] Dynamic subtest pipe-A-plane-0: SUCCESS (3.444s)
[149.188330] Starting dynamic subtest: pipe-A-plane-3
[150.857056] Dynamic subtest pipe-A-plane-3: SUCCESS (1.677s)
[150.864752] Starting dynamic subtest: pipe-A-plane-5
[151.068214] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[152.203698] Starting dynamic subtest: pipe-B-plane-0
[155.719073] Dynamic subtest pipe-B-plane-0: SUCCESS (3.522s)
[155.726462] Starting dynamic subtest: pipe-B-plane-3
[157.364071] Dynamic subtest pipe-B-plane-3: SUCCESS (1.644s)
[157.371695] Starting dynamic subtest: pipe-B-plane-5
[157.574969] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[157.891552] Subtest pixel-format-linear-modifier: SUCCESS (12.182s)
[158.700580] [033/134] (892s left) gem_ctx_shared (q-promotion)
[158.768596] Starting subtest: Q-promotion
[158.771094] Starting dynamic subtest: rcs0
[158.949872] Dynamic subtest rcs0: SUCCESS (0.180s)
[158.963794] Starting dynamic subtest: vcs0
[159.032350] Dynamic subtest vcs0: SUCCESS (0.083s)
[159.045628] Starting dynamic subtest: vcs1
[159.128049] Dynamic subtest vcs1: SUCCESS (0.095s)
[159.143426] Starting dynamic subtest: vecs0
[159.201783] Dynamic subtest vecs0: SUCCESS (0.072s)
[159.216975] Starting dynamic subtest: ccs0
[159.281119] Dynamic subtest ccs0: SUCCESS (0.078s)
[159.283695] Subtest Q-promotion: SUCCESS (0.513s)
[161.014394] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[161.017835] [034/134] (889s left) kms_cursor_crc (cursor-offscreen-max-size)
[161.313663] Starting subtest: cursor-offscreen-max-size
[161.320158] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[161.463988] [035/134] (889s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[161.563870] Starting subtest: fbc-psr-sprite-mmap-gtt
[161.566059] Starting dynamic subtest: eDP-1
[161.570061] Dynamic subtest eDP-1: SKIP (0.000s)
[161.573950] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[161.647394] [036/134] (889s left) sw_sync (sync_merge_invalid)
[161.687603] Starting subtest: sync_merge_invalid
[161.716266] Subtest sync_merge_invalid: SUCCESS (0.029s)
[161.807800] [037/134] (889s left) i915_drm_fdinfo (busy-idle-check-all)
[161.842951] Starting subtest: busy-idle-check-all
[161.845241] Starting dynamic subtest: rcs0
[161.849653] Dynamic subtest rcs0: SKIP (0.004s)
[161.860909] Starting dynamic subtest: bcs0
[161.865428] Dynamic subtest bcs0: SKIP (0.000s)
[161.874831] Starting dynamic subtest: vcs0
[161.879061] Dynamic subtest vcs0: SKIP (0.000s)
[161.886213] Starting dynamic subtest: vcs1
[161.890074] Dynamic subtest vcs1: SKIP (0.000s)
[161.896979] Starting dynamic subtest: vecs0
[161.901072] Dynamic subtest vecs0: SKIP (0.000s)
[161.907631] Starting dynamic subtest: ccs0
[161.911587] Dynamic subtest ccs0: SKIP (0.000s)
[161.915552] Subtest busy-idle-check-all: SKIP (0.008s)
[161.950315] [038/134] (889s left) i915_module_load (reload)
[161.987941] Starting subtest: reload
[165.430747] Subtest reload: SUCCESS (3.445s)
[165.475606] [039/134] (885s left) gem_exec_suspend (basic-s3)
[166.855208] Starting subtest: basic-S3
[166.857339] Starting dynamic subtest: smem
[188.023702] Dynamic subtest smem: SUCCESS (7.101s)
[188.026466] Subtest basic-S3: SUCCESS (7.104s)
[188.215845] [040/134] (862s left) gem_close (many-handles-one-vma)
[188.284507] Starting subtest: many-handles-one-vma
[188.308432] Subtest many-handles-one-vma: SUCCESS (0.025s)
[188.450538] [041/134] (862s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[188.537553] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[188.539829] Starting dynamic subtest: pipe-A-eDP-1
[188.563785] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[188.574053] Starting dynamic subtest: pipe-B-eDP-1
[188.596650] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[188.603787] Starting dynamic subtest: pipe-C-eDP-1
[188.625663] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[188.632985] Starting dynamic subtest: pipe-D-eDP-1
[188.656599] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[188.660644] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[190.755716] [042/134] (860s left) gem_exec_balancer (parallel-out-fence)
[191.027442] Starting subtest: parallel-out-fence
[192.163194] Subtest parallel-out-fence: SUCCESS (1.157s)
[192.307363] [043/134] (859s left) gem_exec_reloc (basic-gtt-read)
[192.364146] Subtest basic-gtt-read: SKIP (0.000s)
[192.435628] [044/134] (858s left) kms_invalid_mode (bad-vsync-start)
[192.526906] Starting subtest: bad-vsync-start
[192.529178] Starting dynamic subtest: pipe-A-eDP-1
[192.826342] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.304s)
[192.835411] Starting dynamic subtest: pipe-B-eDP-1
[192.837756] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[192.846693] Starting dynamic subtest: pipe-C-eDP-1
[192.848832] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[192.855984] Starting dynamic subtest: pipe-D-eDP-1
[192.857832] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[192.859652] Subtest bad-vsync-start: SUCCESS (0.309s)
[193.658310] [045/134] (857s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[193.757025] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[193.761187] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[193.892037] [046/134] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[193.981341] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[193.985435] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[194.110644] [047/134] (857s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[194.204071] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[200.707830] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.564s)
[200.835554] [048/134] (850s left) perf_pmu (busy-idle)
[200.879897] Starting subtest: busy-idle
[200.881884] Starting dynamic subtest: rcs0
[201.596916] Dynamic subtest rcs0: SUCCESS (0.721s)
[201.608270] Starting dynamic subtest: bcs0
[202.267471] Dynamic subtest bcs0: SUCCESS (0.672s)
[202.277151] Starting dynamic subtest: vcs0
[204.024000] Dynamic subtest vcs0: SUCCESS (1.761s)
[204.035374] Starting dynamic subtest: vcs1
[206.007420] Dynamic subtest vcs1: SUCCESS (1.987s)
[206.018295] Starting dynamic subtest: vecs0
[207.991850] Dynamic subtest vecs0: SUCCESS (1.987s)
[208.002503] Starting dynamic subtest: ccs0
[208.662191] Dynamic subtest ccs0: SUCCESS (0.671s)
[208.664847] Subtest busy-idle: SUCCESS (7.812s)
[208.796651] [049/134] (842s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[208.924050] Starting subtest: short-flip-after-cursor-toggle
[209.839089] Subtest short-flip-after-cursor-toggle: SUCCESS (0.917s)
[210.692620] [050/134] (840s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[210.793848] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[210.796025] Starting dynamic subtest: pipe-A
[210.816121] Dynamic subtest pipe-A: SKIP (0.017s)
[210.839086] Starting dynamic subtest: pipe-B
[210.898282] Dynamic subtest pipe-B: SKIP (0.079s)
[210.916190] Starting dynamic subtest: pipe-C
[210.935883] Dynamic subtest pipe-C: SKIP (0.036s)
[210.955036] Starting dynamic subtest: pipe-D
[210.969787] Dynamic subtest pipe-D: SKIP (0.033s)
[210.974206] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.169s)
[211.094116] [051/134] (840s left) kms_vblank (ts-continuation-modeset)
[211.212712] Starting subtest: ts-continuation-modeset
[211.215010] Starting dynamic subtest: pipe-A-eDP-1
[212.750921] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.540s)
[212.765229] Starting dynamic subtest: pipe-D-eDP-1
[214.926415] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.176s)
[214.928670] Subtest ts-continuation-modeset: SUCCESS (3.720s)
[215.725719] [052/134] (835s left) gem_exec_fence (keep-in-fence)
[215.913773] Starting subtest: keep-in-fence
[215.915930] Starting dynamic subtest: rcs0
[215.993911] Dynamic subtest rcs0: SUCCESS (0.083s)
[216.007335] Starting dynamic subtest: bcs0
[216.048977] Dynamic subtest bcs0: SUCCESS (0.052s)
[216.059269] Starting dynamic subtest: vcs0
[218.039720] Dynamic subtest vcs0: SUCCESS (1.990s)
[218.051491] Starting dynamic subtest: vcs1
[220.023558] Dynamic subtest vcs1: SUCCESS (1.983s)
[220.034788] Starting dynamic subtest: vecs0
[222.007428] Dynamic subtest vecs0: SUCCESS (1.983s)
[222.019090] Starting dynamic subtest: ccs0
[222.253483] Dynamic subtest ccs0: SUCCESS (0.244s)
[222.256214] Subtest keep-in-fence: SUCCESS (6.350s)
[224.088954] [053/134] (827s left) gem_basic (create-close)
[224.147463] Starting subtest: create-close
[224.152046] Subtest create-close: SUCCESS (0.000s)
[224.260446] [054/134] (827s left) kms_chamelium_color (gamma)
[224.355786] Subtest gamma: SKIP (0.000s)
[224.430509] [055/134] (827s left) perf_pmu (init-sema)
[224.468445] Starting subtest: init-sema
[224.470924] Starting dynamic subtest: rcs0
[224.473366] Dynamic subtest rcs0: SUCCESS (0.002s)
[224.488129] Starting dynamic subtest: bcs0
[224.490133] Dynamic subtest bcs0: SUCCESS (0.000s)
[224.497975] Starting dynamic subtest: vcs0
[224.499912] Dynamic subtest vcs0: SUCCESS (0.001s)
[224.507454] Starting dynamic subtest: vcs1
[224.509381] Dynamic subtest vcs1: SUCCESS (0.000s)
[224.516981] Starting dynamic subtest: vecs0
[224.518903] Dynamic subtest vecs0: SUCCESS (0.000s)
[224.526952] Starting dynamic subtest: ccs0
[224.529227] Dynamic subtest ccs0: SUCCESS (0.000s)
[224.531508] Subtest init-sema: SUCCESS (0.008s)
[224.607234] [056/134] (827s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[224.713855] Starting subtest: fbc-pr-sprite-mmap-cpu
[224.717950] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[224.800283] [057/134] (827s left) kms_lease (lease-get)
[224.887745] Starting subtest: lease-get
[224.890026] Starting dynamic subtest: pipe-A-eDP-1
[224.892367] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[224.901307] Starting dynamic subtest: pipe-B-eDP-1
[224.903525] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[224.911985] Starting dynamic subtest: pipe-C-eDP-1
[224.913858] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[224.921389] Starting dynamic subtest: pipe-D-eDP-1
[224.923247] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[224.925117] Subtest lease-get: SUCCESS (0.009s)
[225.027221] [058/134] (826s left) gem_lmem_swapping (parallel-random-verify-ccs)
[225.068441] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[225.117775] [059/134] (826s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[225.169646] Starting subtest: y-tiled-ccs-to-x-tiled
[225.173526] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[225.363717] [060/134] (826s left) gem_exec_balancer (bonded-false-hang)
[225.619561] Starting subtest: bonded-false-hang
[225.624236] Subtest bonded-false-hang: SKIP (0.000s)
[225.731507] [061/134] (826s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[230.766911] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[230.771561] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.003s)
[231.630238] [062/134] (820s left) gen7_exec_parse (basic-allowed)
[231.694821] Subtest basic-allowed: SKIP (0.000s)
[231.766432] [063/134] (820s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[231.856873] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[231.859208] Starting dynamic subtest: pipe-A-eDP-1
[231.879530] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[231.893932] Starting dynamic subtest: pipe-B-eDP-1
[231.914643] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[231.924733] Starting dynamic subtest: pipe-C-eDP-1
[231.944564] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[231.953640] Starting dynamic subtest: pipe-D-eDP-1
[231.972915] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[231.974845] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[234.188275] [064/134] (818s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[239.164067] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[239.168553] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[240.029696] [065/134] (812s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[240.139179] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[240.143598] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[240.269028] [066/134] (812s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[240.372464] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[240.374718] Starting dynamic subtest: pipe-A-eDP-1
[240.518671] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.137s)
[240.529044] Starting dynamic subtest: pipe-B-eDP-1
[240.549020] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[240.557793] Starting dynamic subtest: pipe-C-eDP-1
[240.577253] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[240.585109] Starting dynamic subtest: pipe-D-eDP-1
[240.604397] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[240.606299] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.171s)
[242.865283] [067/134] (809s left) kms_flip (flip-vs-panning)
[242.969728] Starting subtest: flip-vs-panning
[242.972033] Starting dynamic subtest: A-eDP1
[251.671417] Dynamic subtest A-eDP1: SUCCESS (8.674s)
[251.680235] Starting dynamic subtest: B-eDP1
[260.446320] Dynamic subtest B-eDP1: SUCCESS (8.706s)
[260.456190] Starting dynamic subtest: C-eDP1
[269.122827] Dynamic subtest C-eDP1: SUCCESS (8.652s)
[269.132933] Starting dynamic subtest: D-eDP1
[277.791959] Dynamic subtest D-eDP1: SUCCESS (8.658s)
[277.796288] Subtest flip-vs-panning: SUCCESS (34.697s)
[278.965878] [068/134] (773s left) syncobj_eventfd (timeline-wait)
[279.023365] Starting subtest: timeline-wait
[279.031964] Subtest timeline-wait: SUCCESS (0.010s)
[279.155520] [069/134] (773s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[279.255309] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[279.259324] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[279.380727] [070/134] (773s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[279.484309] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[279.486564] Starting dynamic subtest: A-eDP1
[283.074574] Dynamic subtest A-eDP1: SUCCESS (3.587s)
[283.084554] Starting dynamic subtest: B-eDP1
[286.262343] Dynamic subtest B-eDP1: SUCCESS (3.184s)
[286.276531] Starting dynamic subtest: C-eDP1
[289.371208] Dynamic subtest C-eDP1: SUCCESS (3.109s)
[289.385320] Starting dynamic subtest: D-eDP1
[292.487937] Dynamic subtest D-eDP1: SUCCESS (3.115s)
[292.489856] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.002s)
[293.293827] [071/134] (759s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[293.401001] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[294.492443] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.093s)
[294.659694] [072/134] (757s left) gem_mmap_offset (oob-read)
[294.723444] Starting subtest: oob-read
[294.725354] Subtest oob-read: SUCCESS (0.000s)
[294.843586] [073/134] (757s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[294.944073] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[294.945901] Starting dynamic subtest: pipe-A-default-mode
[295.258332] Dynamic subtest pipe-A-default-mode: SKIP (0.312s)
[295.262848] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.314s)
[296.131491] [074/134] (756s left) gem_pxp (regular-baseline-src-copy-readible)
[296.264636] Starting subtest: regular-baseline-src-copy-readible
[296.321684] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[296.473578] [075/134] (756s left) kms_3d (basic)
[296.540870] Starting subtest: basic
[298.545328] Subtest basic: SUCCESS (2.007s)
[299.057134] [076/134] (753s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[299.163826] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[299.168204] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[299.311866] [077/134] (753s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[299.416417] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[299.420848] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[299.534091] [078/134] (753s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[299.642279] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[299.646681] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[299.768784] [079/134] (753s left) gem_exec_schedule (fairslice-all)
[299.855142] Starting subtest: fairslice-all
[301.906676] Subtest fairslice-all: SUCCESS (2.057s)
[302.215818] [080/134] (750s left) kms_properties (plane-properties-atomic)
[302.308684] Starting subtest: plane-properties-atomic
[302.310827] Starting dynamic subtest: pipe-A-eDP-1
[302.857274] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[302.867411] Starting dynamic subtest: pipe-B-eDP-1
[304.091726] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.234s)
[304.104998] Starting dynamic subtest: pipe-C-eDP-1
[305.390217] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.296s)
[305.399283] Starting dynamic subtest: pipe-D-eDP-1
[306.672928] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.282s)
[306.675338] Subtest plane-properties-atomic: SUCCESS (4.366s)
[307.571449] [081/134] (745s left) gem_cs_tlb (engines)
[307.627300] Starting subtest: engines
[307.629653] Starting dynamic subtest: rcs0
[309.782766] Dynamic subtest rcs0: SUCCESS (2.152s)
[309.794240] Starting dynamic subtest: bcs0
[311.935061] Dynamic subtest bcs0: SUCCESS (2.151s)
[311.943839] Starting dynamic subtest: vcs0
[314.088754] Dynamic subtest vcs0: SUCCESS (2.152s)
[314.097606] Starting dynamic subtest: vcs1
[316.242896] Dynamic subtest vcs1: SUCCESS (2.153s)
[316.251124] Starting dynamic subtest: vecs0
[318.395277] Dynamic subtest vecs0: SUCCESS (2.151s)
[318.405107] Starting dynamic subtest: ccs0
[320.550225] Dynamic subtest ccs0: SUCCESS (2.153s)
[320.552516] Subtest engines: SUCCESS (12.916s)
[320.704722] [082/134] (732s left) kms_scaling_modes (scaling-mode-none)
[320.807323] Starting subtest: scaling-mode-none
[320.809191] Starting dynamic subtest: pipe-A-eDP-1
[320.901500] Dynamic subtest pipe-A-eDP-1: SKIP (0.093s)
[320.912652] Starting dynamic subtest: pipe-B-eDP-1
[320.934054] Dynamic subtest pipe-B-eDP-1: SKIP (0.031s)
[320.942781] Starting dynamic subtest: pipe-C-eDP-1
[320.975592] Dynamic subtest pipe-C-eDP-1: SKIP (0.039s)
[320.990132] Starting dynamic subtest: pipe-D-eDP-1
[321.015305] Dynamic subtest pipe-D-eDP-1: SKIP (0.038s)
[321.019263] Subtest scaling-mode-none: SKIP (0.208s)
[321.174416] [083/134] (731s left) kms_psr (pr-sprite-render)
[321.279582] Starting subtest: pr-sprite-render
[321.283858] Subtest pr-sprite-render: SKIP (0.000s)
[321.363992] [084/134] (731s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-pwrite)
[321.459762] Starting subtest: fbc-abgr161616f-draw-pwrite
[321.463677] Subtest fbc-abgr161616f-draw-pwrite: SKIP (0.000s)
[321.570788] [085/134] (731s left) kms_flip (2x-flip-vs-expired-vblank)
[321.665314] Starting subtest: 2x-flip-vs-expired-vblank
[321.676240] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[321.818408] [086/134] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[321.923801] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[321.927111] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[322.028503] [087/134] (731s left) kms_content_protection (srm)
[322.172456] Starting subtest: srm
[322.178594] Subtest srm: SKIP (0.002s)
[322.344869] [088/134] (730s left) gem_userptr_blits (process-exit-busy)
[322.419108] Starting subtest: process-exit-busy
[322.432302] Subtest process-exit-busy: SUCCESS (0.014s)
[322.584178] [089/134] (730s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[322.676844] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[322.680369] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[322.788608] [090/134] (730s left) kms_color (invalid-degamma-lut-sizes)
[322.876664] Starting subtest: invalid-degamma-lut-sizes
[322.878386] Starting dynamic subtest: pipe-A
[323.168429] Dynamic subtest pipe-A: SUCCESS (0.290s)
[323.177247] Starting dynamic subtest: pipe-B
[323.179389] Dynamic subtest pipe-B: SUCCESS (0.000s)
[323.187624] Starting dynamic subtest: pipe-C
[323.189778] Dynamic subtest pipe-C: SUCCESS (0.000s)
[323.197956] Starting dynamic subtest: pipe-D
[323.200148] Dynamic subtest pipe-D: SUCCESS (0.000s)
[323.202433] Subtest invalid-degamma-lut-sizes: SUCCESS (0.294s)
[323.991859] [091/134] (729s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[324.100946] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[324.105482] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[324.227964] [092/134] (729s left) kms_pipe_crc_basic (nonblocking-crc)
[324.326802] Starting subtest: nonblocking-crc
[324.329075] Starting dynamic subtest: pipe-A-eDP-1
[325.101759] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.774s)
[325.110547] Starting dynamic subtest: pipe-B-eDP-1
[326.543209] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[326.554341] Starting dynamic subtest: pipe-C-eDP-1
[327.878691] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.332s)
[327.887408] Starting dynamic subtest: pipe-D-eDP-1
[329.282140] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.404s)
[329.284572] Subtest nonblocking-crc: SUCCESS (4.956s)
[330.167576] [093/134] (723s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[330.261478] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[331.019162] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.759s)
[331.215437] [094/134] (722s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[331.320471] Starting subtest: 4-tiled-8bpp-rotate-0
[332.490916] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.170s)
[332.660913] [095/134] (720s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[332.770269] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[332.773514] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[332.909215] [096/134] (720s left) gem_exec_schedule (u-semaphore-codependency)
[332.986799] Starting subtest: u-semaphore-codependency
[332.995343] Subtest u-semaphore-codependency: SUCCESS (0.014s)
[333.377801] [097/134] (720s left) syncobj_timeline (wait-any-snapshot)
[333.437449] Starting subtest: wait-any-snapshot
[333.519237] Subtest wait-any-snapshot: SUCCESS (0.081s)
[333.613035] [098/134] (720s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[333.679920] Subtest no-spare-fences-busy: SKIP (0.000s)
[333.779801] [099/134] (719s left) kms_dsc (dsc-with-output-formats-with-bpc)
[333.888574] Starting subtest: dsc-with-output-formats-with-bpc
[333.946069] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[333.984667] [100/134] (719s left) gem_userptr_blits (dmabuf-unsync)
[334.048425] Subtest dmabuf-unsync: SKIP (0.000s)
[334.196635] [101/134] (719s left) kms_prop_blob (blob-prop-core)
[334.252205] Starting subtest: blob-prop-core
[334.254095] Subtest blob-prop-core: SUCCESS (0.000s)
[334.371718] [102/134] (719s left) gem_exec_reloc (basic-gtt-cpu)
[334.437854] Subtest basic-gtt-cpu: SKIP (0.000s)
[334.517754] [103/134] (719s left) syncobj_timeline (invalid-query-bad-pad)
[334.583876] Starting subtest: invalid-query-bad-pad
[334.585923] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[334.703882] [104/134] (719s left) vgem_basic (dmabuf-export)
[334.746512] Starting subtest: dmabuf-export
[334.798766] Subtest dmabuf-export: SUCCESS (0.053s)
[334.933195] [105/134] (718s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-gtt)
[335.030932] Starting subtest: psr-abgr161616f-draw-mmap-gtt
[335.034557] Subtest psr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[335.153044] [106/134] (718s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[335.250128] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[335.253724] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[335.384580] [107/134] (718s left) gem_gpgpu_fill (basic)
[335.453276] Starting subtest: basic
[335.456106] Starting dynamic subtest: smem
[335.460680] Dynamic subtest smem: SUCCESS (0.007s)
[335.462454] Subtest basic: SUCCESS (0.008s)
[335.639564] [108/134] (718s left) gem_mmap_gtt (basic-copy)
[335.686635] Subtest basic-copy: SKIP (0.000s)
[335.756513] [109/134] (718s left) gen9_exec_parse (batch-invalid-length)
[335.821989] Subtest batch-invalid-length: SKIP (0.000s)
[335.910060] [110/134] (718s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[336.017215] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[336.020824] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[336.137160] [111/134] (718s left) gem_tiled_wc
[336.258920] [112/134] (717s left) gem_exec_capture (userptr)
[336.330225] Starting subtest: userptr
[337.170272] Subtest userptr: SUCCESS (0.838s)
[337.319507] [113/134] (716s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[337.413077] Starting subtest: flip-vs-dpms-off-vs-modeset
[337.415543] Starting dynamic subtest: A-eDP1
[341.102063] Dynamic subtest A-eDP1: SUCCESS (3.686s)
[341.111787] Starting dynamic subtest: B-eDP1
[344.391413] Dynamic subtest B-eDP1: SUCCESS (3.285s)
[344.401344] Starting dynamic subtest: C-eDP1
[347.703921] Dynamic subtest C-eDP1: SUCCESS (3.312s)
[347.713057] Starting dynamic subtest: D-eDP1
[350.996093] Dynamic subtest D-eDP1: SUCCESS (3.293s)
[350.998411] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.584s)
[351.876032] [114/134] (702s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[351.974384] Starting subtest: fbc-rgb565-draw-pwrite
[356.398303] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.429s)
[357.581998] [115/134] (696s left) gem_exec_whisper (basic-contexts-forked-all)
[357.646448] Starting subtest: basic-contexts-forked-all
[377.848455] Subtest basic-contexts-forked-all: SUCCESS (20.199s)
[378.040280] [116/134] (676s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[378.163044] Starting subtest: cursorB-vs-flipB-atomic
[378.167475] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[378.318266] [117/134] (676s left) gem_pread (exhaustion)
[378.380002] Subtest exhaustion: SKIP (0.000s)
[378.447842] [118/134] (675s left) gem_ctx_persistence (heartbeat-hostile)
[378.512722] Starting subtest: heartbeat-hostile
[378.517119] Subtest heartbeat-hostile: SKIP (0.000s)
[378.632225] [119/134] (675s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[378.727796] Starting subtest: extended-pageflip-modeset-hang-oldfb
[378.730027] Starting dynamic subtest: pipe-A
[386.631310] Dynamic subtest pipe-A: SUCCESS (7.900s)
[386.643439] Starting dynamic subtest: pipe-D
[395.220164] Dynamic subtest pipe-D: SUCCESS (8.587s)
[395.222654] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.492s)
[396.058679] [120/134] (658s left) gem_sync (basic-store-each)
[396.152894] Starting subtest: basic-store-each
[398.425780] Subtest basic-store-each: SUCCESS (2.279s)
[398.631479] [121/134] (655s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[398.732294] Starting subtest: psr-shrfb-scaledprimary
[404.392265] Subtest psr-shrfb-scaledprimary: SUCCESS (5.661s)
[404.552260] [122/134] (650s left) dmabuf_sync_file (import-multiple-read-only)
[404.603841] Starting subtest: import-multiple-read-only
[404.606079] Subtest import-multiple-read-only: SUCCESS (0.003s)
[404.660660] [123/134] (649s left) kms_atomic_interruptible (universal-setplane-primary)
[404.766487] Starting subtest: universal-setplane-primary
[404.768683] Starting dynamic subtest: pipe-A-eDP-1
[412.147171] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.377s)
[412.149362] Subtest universal-setplane-primary: SUCCESS (7.379s)
[412.965715] [124/134] (641s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[413.059243] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[419.621957] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.564s)
[419.776076] [125/134] (634s left) kms_cursor_edge_walk (128x128-right-edge)
[419.859479] Starting subtest: 128x128-right-edge
[419.861733] Starting dynamic subtest: pipe-A-eDP-1
[423.282522] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.421s)
[423.292281] Starting dynamic subtest: pipe-D-eDP-1
[426.487005] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.201s)
[426.488998] Subtest 128x128-right-edge: SUCCESS (6.625s)
[427.361380] [126/134] (627s left) api_intel_allocator (two-level-inception)
[427.419924] Starting subtest: two-level-inception
[432.819449] Subtest two-level-inception: SUCCESS (5.398s)
[432.954183] [127/134] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[433.061142] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[433.065396] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[433.184118] [128/134] (621s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[433.248338] Starting subtest: wait-all-for-submit-delayed-submit
[433.350923] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[433.461949] [129/134] (621s left) gem_exec_schedule (pi-ringfull)
[433.646654] Starting subtest: pi-ringfull
[433.649005] Starting dynamic subtest: rcs0
[433.690453] Dynamic subtest rcs0: SUCCESS (0.046s)
[433.700815] Starting dynamic subtest: bcs0
[433.751206] Dynamic subtest bcs0: SUCCESS (0.060s)
[433.762266] Starting dynamic subtest: vcs0
[433.791072] Dynamic subtest vcs0: SUCCESS (0.039s)
[433.800555] Starting dynamic subtest: vcs1
[433.826841] Dynamic subtest vcs1: SUCCESS (0.034s)
[433.836402] Starting dynamic subtest: vecs0
[433.860654] Dynamic subtest vecs0: SUCCESS (0.033s)
[433.870224] Starting dynamic subtest: ccs0
[433.891602] Dynamic subtest ccs0: SUCCESS (0.029s)
[433.893705] Subtest pi-ringfull: SUCCESS (0.249s)
[434.164884] [130/134] (620s left) kms_async_flips (crc-atomic)
[434.268405] Starting subtest: crc-atomic
[434.642253] Starting dynamic subtest: pipe-A-eDP-1
[437.534139] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.889s)
[437.908779] Starting dynamic subtest: pipe-B-eDP-1
[440.847999] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.947s)
[441.227091] Starting dynamic subtest: pipe-C-eDP-1
[444.120718] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.903s)
[444.487430] Starting dynamic subtest: pipe-D-eDP-1
[447.338175] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.860s)
[447.340523] Subtest crc-atomic: SUCCESS (13.067s)
[448.573293] [131/134] (606s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[453.656132] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[453.658517] Starting dynamic subtest: pipe-A-eDP-1
[460.108954] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.452s)
[460.120343] Starting dynamic subtest: pipe-B-eDP-1
[466.608949] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.493s)
[466.611148] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.951s)
[467.477784] [132/134] (587s left) i915_suspend (fence-restore-tiled2untiled)
[467.549901] Starting subtest: fence-restore-tiled2untiled
[467.554257] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[467.689330] [133/134] (587s left) prime_busy (after)
[467.757058] Starting subtest: after
[467.762349] Starting dynamic subtest: rcs0
[467.807849] Dynamic subtest rcs0: SUCCESS (0.046s)
[467.819647] Starting dynamic subtest: bcs0
[467.882963] Dynamic subtest bcs0: SUCCESS (0.074s)
[467.893326] Starting dynamic subtest: vcs0
[467.925090] Dynamic subtest vcs0: SUCCESS (0.041s)
[467.934711] Starting dynamic subtest: vcs1
[467.965366] Dynamic subtest vcs1: SUCCESS (0.039s)
[467.974655] Starting dynamic subtest: vecs0
[468.005214] Dynamic subtest vecs0: SUCCESS (0.039s)
[468.014714] Starting dynamic subtest: ccs0
[468.045770] Dynamic subtest ccs0: SUCCESS (0.040s)
[468.154140] Subtest after: SUCCESS (0.395s)
[468.243028] [134/134] (586s left) prime_mmap (test_refcounting)
[468.301379] Starting subtest: test_refcounting
[468.303663] Starting dynamic subtest: test_refcounting-smem
[468.329515] Dynamic subtest test_refcounting-smem: SUCCESS (0.029s)
[468.331921] Subtest test_refcounting: SUCCESS (0.030s)
[468.479689] 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.