[57.581017] Initializing watchdogs
[57.581066]   /dev/watchdog0
[57.594852] [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]
[57.599176] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.601365] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.604781] [001/133] (960s left) kms_cursor_crc (cursor-random-512x512)
[57.909805] Starting subtest: cursor-random-512x512
[57.914453] Subtest cursor-random-512x512: SKIP (0.001s)
[58.075186] [002/133] (960s left) gem_eio (context-create)
[58.243080] Starting subtest: context-create
[58.452860] Subtest context-create: SUCCESS (0.209s)
[58.595823] [003/133] (959s left) kms_frontbuffer_tracking (psr-2p-rte)
[58.685487] Starting subtest: psr-2p-rte
[58.689127] Subtest psr-2p-rte: SKIP (0.000s)
[58.777956] [004/133] (959s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[58.867088] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[58.869097] Starting dynamic subtest: pipe-A-eDP-1
[59.133968] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.241s)
[59.141628] Starting dynamic subtest: pipe-B-eDP-1
[60.403784] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s)
[60.411470] Starting dynamic subtest: pipe-C-eDP-1
[61.665073] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.266s)
[61.672054] Starting dynamic subtest: pipe-D-eDP-1
[62.894735] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[62.896758] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.002s)
[64.019169] [005/133] (954s left) gem_exec_gttfill (all-engines)
[64.073686] Starting subtest: all-engines
[87.049299] Subtest all-engines: SUCCESS (22.981s)
[87.238428] [006/133] (931s left) gen7_exec_parse (basic-rejected)
[87.347719] Subtest basic-rejected: SKIP (0.000s)
[87.425933] [007/133] (930s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[87.482614] Subtest tiled-to-tiled: SKIP (0.000s)
[87.557027] [008/133] (930s left) syncobj_wait (multi-wait-submitted)
[87.620300] Starting subtest: multi-wait-submitted
[87.728347] Subtest multi-wait-submitted: SUCCESS (0.106s)
[87.801119] [009/133] (930s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[87.862681] Starting subtest: y-tiled-ccs-to-x-tiled
[87.867219] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[88.041710] [010/133] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[88.149949] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[95.107954] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.960s)
[95.244210] [011/133] (923s left) gem_exec_balancer (fairslice)
[95.316740] Starting subtest: fairslice
[98.219839] Subtest fairslice: SUCCESS (2.901s)
[98.545953] [012/133] (919s left) gem_ctx_param (invalid-size-get)
[98.600765] Starting subtest: invalid-size-get
[98.603081] Subtest invalid-size-get: SUCCESS (0.001s)
[98.685818] [013/133] (919s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[98.804495] Starting subtest: short-flip-after-cursor-toggle
[99.753521] Subtest short-flip-after-cursor-toggle: SUCCESS (0.949s)
[100.572920] [014/133] (918s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[100.671747] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[100.674056] Starting dynamic subtest: pipe-A-eDP-1
[100.683184] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.692645] Starting dynamic subtest: pipe-B-eDP-1
[100.701710] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.709432] Starting dynamic subtest: pipe-C-eDP-1
[100.718069] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.725500] Starting dynamic subtest: pipe-D-eDP-1
[100.734133] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.738511] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[102.939431] [015/133] (915s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[103.030859] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[103.033149] Starting dynamic subtest: pipe-A
[103.145217] Dynamic subtest pipe-A: SKIP (0.111s)
[103.158090] Starting dynamic subtest: pipe-B
[104.334853] Dynamic subtest pipe-B: SKIP (1.187s)
[104.343943] Starting dynamic subtest: pipe-C
[105.525293] Dynamic subtest pipe-C: SUCCESS (1.197s)
[105.533969] Starting dynamic subtest: pipe-D
[106.751328] Dynamic subtest pipe-D: SUCCESS (1.225s)
[106.753713] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.722s)
[107.947795] [016/133] (910s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[108.060831] Starting subtest: plane-lut1d-post-ctm3x4
[108.242037] Starting dynamic subtest: pipe-A-plane-0
[108.396890] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[108.405547] Starting dynamic subtest: pipe-A-plane-1
[108.529993] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[108.538141] Starting dynamic subtest: pipe-A-plane-2
[108.663405] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[109.839932] Starting dynamic subtest: pipe-B-plane-0
[109.977528] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[109.986897] Starting dynamic subtest: pipe-B-plane-1
[110.111078] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[110.120142] Starting dynamic subtest: pipe-B-plane-2
[110.244171] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[111.464312] Starting dynamic subtest: pipe-C-plane-0
[111.591041] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[111.600491] Starting dynamic subtest: pipe-C-plane-1
[111.735335] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[111.746251] Starting dynamic subtest: pipe-C-plane-2
[111.881290] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[113.124697] Starting dynamic subtest: pipe-D-plane-0
[113.258168] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[113.266769] Starting dynamic subtest: pipe-D-plane-1
[113.391412] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[113.399306] Starting dynamic subtest: pipe-D-plane-2
[113.524689] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[113.809633] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.749s)
[114.652650] [017/133] (904s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[114.763413] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[114.768104] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[114.840777] [018/133] (903s left) api_intel_allocator (fork-simple-stress)
[114.894755] Starting subtest: fork-simple-stress
[120.342550] Subtest fork-simple-stress: SUCCESS (5.395s)
[120.429016] [019/133] (898s left) gem_reg_read (timestamp-monotonic)
[120.493055] Starting subtest: timestamp-monotonic
[125.535289] Subtest timestamp-monotonic: SUCCESS (4.989s)
[125.577069] [020/133] (893s left) gem_workarounds (reset-fd)
[125.647107] Starting subtest: reset-fd
[125.835091] Subtest reset-fd: SUCCESS (0.188s)
[125.954615] [021/133] (892s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[126.057120] Starting subtest: 2x-flip-vs-modeset-vs-hang
[126.066157] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[126.139887] [022/133] (892s left) gem_exec_endless (dispatch)
[126.200274] Starting subtest: dispatch
[126.202185] Starting dynamic subtest: rcs0
[126.208617] Dynamic subtest rcs0: SUCCESS (0.005s)
[126.216852] Starting dynamic subtest: bcs0
[126.221434] Dynamic subtest bcs0: SUCCESS (0.004s)
[126.229966] Starting dynamic subtest: vcs0
[126.234139] Dynamic subtest vcs0: SUCCESS (0.006s)
[126.242097] Starting dynamic subtest: vcs1
[126.246387] Dynamic subtest vcs1: SUCCESS (0.005s)
[126.253696] Starting dynamic subtest: vecs0
[126.258071] Dynamic subtest vecs0: SUCCESS (0.005s)
[126.265446] Starting dynamic subtest: ccs0
[126.269796] Dynamic subtest ccs0: SUCCESS (0.006s)
[126.272038] Subtest dispatch: SUCCESS (0.035s)
[127.942118] [023/133] (890s left) kms_tiled_display (basic-test-pattern)
[128.056216] Subtest basic-test-pattern: SKIP (0.000s)
[128.100502] [024/133] (890s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[128.188992] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[128.191284] Starting dynamic subtest: pipe-A-default-mode
[130.878316] Dynamic subtest pipe-A-default-mode: SUCCESS (2.690s)
[130.880617] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.691s)
[131.742200] [025/133] (887s left) gem_tiled_partial_pwrite_pread (reads)
[131.797481] Subtest reads: SKIP (0.000s)
[131.863832] [026/133] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[131.970952] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[131.975107] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[132.076056] [027/133] (887s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[132.125722] Starting subtest: etime-single-wait-all-for-submit-submitted
[132.234350] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[132.305731] [028/133] (886s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[132.351911] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[132.354127] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[132.438496] [029/133] (886s left) gem_mmap_offset (bad-flags)
[132.483367] Starting subtest: bad-flags
[132.485629] Subtest bad-flags: SUCCESS (0.000s)
[132.580191] [030/133] (886s left) kms_addfb_basic (bad-pitch-65536)
[132.638945] Starting subtest: bad-pitch-65536
[132.641166] Subtest bad-pitch-65536: SUCCESS (0.000s)
[132.764970] [031/133] (886s left) kms_big_fb (linear-64bpp-rotate-0)
[132.881347] Starting subtest: linear-64bpp-rotate-0
[134.481673] Subtest linear-64bpp-rotate-0: SUCCESS (1.600s)
[134.644778] [032/133] (884s left) kms_atomic_interruptible (legacy-setmode)
[134.731462] Starting subtest: legacy-setmode
[134.733458] Starting dynamic subtest: pipe-A-eDP-1
[141.604440] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.872s)
[141.606902] Subtest legacy-setmode: SUCCESS (6.873s)
[142.412787] [033/133] (876s left) kms_invalid_mode (zero-clock)
[142.500106] Starting subtest: zero-clock
[142.502333] Starting dynamic subtest: pipe-A-eDP-1
[142.782100] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[142.790777] Starting dynamic subtest: pipe-B-eDP-1
[142.792697] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[142.800121] Starting dynamic subtest: pipe-C-eDP-1
[142.802592] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[142.810067] Starting dynamic subtest: pipe-D-eDP-1
[142.811903] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[142.813811] Subtest zero-clock: SUCCESS (0.288s)
[143.638267] [034/133] (875s left) gem_eio (in-flight-external)
[143.855490] Starting subtest: in-flight-external
[144.982444] Subtest in-flight-external: SUCCESS (1.126s)
[145.109239] [035/133] (874s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[145.207501] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[145.897820] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[146.083163] [036/133] (873s left) gem_exec_schedule (in-order)
[146.155061] Starting subtest: in-order
[146.156921] Starting dynamic subtest: rcs0
[146.253407] Dynamic subtest rcs0: SUCCESS (0.105s)
[146.263937] Starting dynamic subtest: vcs0
[146.333041] Dynamic subtest vcs0: SUCCESS (0.079s)
[146.343457] Starting dynamic subtest: vcs1
[146.413589] Dynamic subtest vcs1: SUCCESS (0.080s)
[146.424380] Starting dynamic subtest: vecs0
[146.495691] Dynamic subtest vecs0: SUCCESS (0.082s)
[146.507126] Starting dynamic subtest: ccs0
[146.586106] Dynamic subtest ccs0: SUCCESS (0.090s)
[146.588562] Subtest in-order: SUCCESS (0.438s)
[148.011246] [037/133] (871s left) kms_vblank (wait-forked-busy)
[148.113108] Starting subtest: wait-forked-busy
[148.115408] Starting dynamic subtest: pipe-A-eDP-1
[150.017560] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.901s)
[150.032126] Starting dynamic subtest: pipe-D-eDP-1
[152.602965] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.581s)
[152.605281] Subtest wait-forked-busy: SUCCESS (4.489s)
[153.413087] [038/133] (866s left) vgem_slow (nohang)
[153.527130] Starting subtest: nohang
[164.003611] Subtest nohang: SUCCESS (10.424s)
[164.036962] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[164.040174] [039/133] (855s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[164.137618] Starting subtest: plane-all-modeset-transition-internal-panels
[164.140030] Starting dynamic subtest: pipe-A-eDP-1
[165.458214] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.319s)
[165.732306] Starting dynamic subtest: pipe-B-eDP-1
[166.782497] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.058s)
[167.053954] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.918s)
[167.897741] [040/133] (851s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[167.997880] Starting subtest: plane-upscale-20x20-with-pixel-format
[168.000121] Starting dynamic subtest: pipe-A
[169.045918] Dynamic subtest pipe-A: SUCCESS (1.050s)
[169.053893] Starting dynamic subtest: pipe-B
[171.196776] Dynamic subtest pipe-B: SUCCESS (2.149s)
[171.204675] Starting dynamic subtest: pipe-C
[172.389040] Dynamic subtest pipe-C: SUCCESS (1.191s)
[172.402182] Starting dynamic subtest: pipe-D
[173.626024] Dynamic subtest pipe-D: SUCCESS (1.236s)
[173.628200] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.631s)
[174.814639] [041/133] (844s left) kms_plane_cursor (primary)
[174.900172] Starting subtest: primary
[174.904713] Starting dynamic subtest: pipe-A-eDP-1-size-64
[177.437668] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.538s)
[177.461311] Starting dynamic subtest: pipe-A-eDP-1-size-128
[180.017094] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[180.042524] Starting dynamic subtest: pipe-A-eDP-1-size-256
[182.606995] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[182.926901] Starting dynamic subtest: pipe-B-eDP-1-size-64
[186.222696] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.305s)
[186.246065] Starting dynamic subtest: pipe-B-eDP-1-size-128
[188.801044] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.561s)
[188.825487] Starting dynamic subtest: pipe-B-eDP-1-size-256
[191.379834] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s)
[191.699306] Starting dynamic subtest: pipe-C-eDP-1-size-64
[194.571361] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.881s)
[194.597190] Starting dynamic subtest: pipe-C-eDP-1-size-128
[196.771274] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[196.797495] Starting dynamic subtest: pipe-C-eDP-1-size-256
[198.993037] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.202s)
[199.309080] Starting dynamic subtest: pipe-D-eDP-1-size-64
[202.215315] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.915s)
[202.241714] Starting dynamic subtest: pipe-D-eDP-1-size-128
[204.404378] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.169s)
[204.430025] Starting dynamic subtest: pipe-D-eDP-1-size-256
[206.593619] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s)
[206.904164] Subtest primary: SUCCESS (32.004s)
[207.743189] [042/133] (811s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[207.836173] Starting subtest: plane-primary-toggle-with-vblank-wait
[207.838531] Starting dynamic subtest: pipe-A-eDP-1
[208.009276] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[208.315835] Starting dynamic subtest: pipe-B-eDP-1
[209.242404] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.935s)
[209.549316] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.713s)
[210.406095] [043/133] (809s left) syncobj_timeline (invalid-query-illegal-handle)
[210.462017] Starting subtest: invalid-query-illegal-handle
[210.464333] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[210.555416] [044/133] (809s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[210.657027] Starting subtest: fbc-dirtyfb-ioctl
[210.659338] Starting dynamic subtest: A-eDP-1
[213.266179] Dynamic subtest A-eDP-1: SUCCESS (2.609s)
[213.268694] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.610s)
[214.070969] [045/133] (805s left) kms_addfb_basic (invalid-get-prop)
[214.136870] Starting subtest: invalid-get-prop
[214.138802] Subtest invalid-get-prop: SUCCESS (0.000s)
[214.267595] [046/133] (805s left) syncobj_wait (wait-for-submit-snapshot)
[214.324070] Starting subtest: wait-for-submit-snapshot
[214.404099] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[214.481335] [047/133] (805s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[214.581103] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[214.585324] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[214.670205] [048/133] (805s left) i915_drm_fdinfo (memory-info-active)
[214.709174] Starting subtest: memory-info-active
[214.711417] Starting dynamic subtest: smem0
[217.336556] Dynamic subtest smem0: SUCCESS (2.628s)
[217.338652] Subtest memory-info-active: SUCCESS (2.629s)
[217.411219] [049/133] (802s left) api_intel_bb (object-noreloc-purge-cache-simple)
[217.476369] Starting subtest: object-noreloc-purge-cache-simple
[217.485322] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.009s)
[217.595956] [050/133] (802s left) kms_psr (psr-cursor-mmap-gtt)
[217.697486] Starting subtest: psr-cursor-mmap-gtt
[217.699470] Starting dynamic subtest: eDP-1
[219.453544] Dynamic subtest eDP-1: SUCCESS (1.756s)
[219.455727] Subtest psr-cursor-mmap-gtt: SUCCESS (1.757s)
[220.320833] [051/133] (799s left) kms_pipe_crc_basic (suspend-read-crc)
[220.427861] Starting subtest: suspend-read-crc
[220.430172] Starting dynamic subtest: pipe-A-eDP-1
[238.053895] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.758s)
[238.066113] Starting dynamic subtest: pipe-B-eDP-1
[255.931076] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.142s)
[255.940998] Starting dynamic subtest: pipe-C-eDP-1
[273.946530] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.077s)
[273.965532] Starting dynamic subtest: pipe-D-eDP-1
[291.927473] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.063s)
[291.929867] Subtest suspend-read-crc: SUCCESS (12.046s)
[292.739143] [052/133] (727s left) kms_chamelium_hpd (hdmi-hpd-fast)
[293.134002] Subtest hdmi-hpd-fast: SKIP (0.000s)
[293.946353] [053/133] (726s left) kms_cursor_crc (cursor-tearing-position-change)
[294.059513] Starting subtest: cursor-tearing-position-change
[294.062146] Starting dynamic subtest: pipe-A-eDP-1
[294.624114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[294.634370] Starting dynamic subtest: pipe-D-eDP-1
[295.882358] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.265s)
[295.885053] Subtest cursor-tearing-position-change: SUCCESS (1.833s)
[296.728226] [054/133] (723s left) perf (short-reads)
[296.862915] Starting subtest: short-reads
[296.876225] Subtest short-reads: SUCCESS (0.015s)
[296.926662] [055/133] (723s left) kms_chamelium_edid (dp-mode-timings)
[297.320703] Subtest dp-mode-timings: SKIP (0.000s)
[298.129551] [056/133] (722s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[298.220815] Starting subtest: fbc-pr-sprite-mmap-gtt
[298.225302] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[298.291590] [057/133] (721s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[298.379130] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[307.507278] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.153s)
[307.619823] [058/133] (712s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[307.750688] Starting subtest: verify-pxp-key-change-after-suspend-resume
[315.670559] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.931s)
[315.780098] [059/133] (704s left) gem_exec_reloc (basic-cpu-read-noreloc)
[315.835863] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[315.901001] [060/133] (704s left) perf (mi-rpc)
[315.990321] Starting subtest: mi-rpc
[315.994762] Subtest mi-rpc: SKIP (0.000s)
[316.032331] [061/133] (704s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[316.131931] Starting subtest: fbcpsr-tiling-4
[323.204839] Subtest fbcpsr-tiling-4: SUCCESS (7.076s)
[323.330996] [062/133] (697s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[323.445573] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[323.450171] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[323.550748] [063/133] (696s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[323.652086] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[323.656453] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[323.744945] [064/133] (696s left) kms_lease (lease-uevent)
[323.830445] Starting subtest: lease-uevent
[324.843450] Subtest lease-uevent: SUCCESS (1.013s)
[324.960488] [065/133] (695s left) kms_pm_backlight (brightness-with-dpms)
[325.063015] Starting subtest: brightness-with-dpms
[325.109489] Starting dynamic subtest: eDP-1
[327.487091] Dynamic subtest eDP-1: SUCCESS (2.377s)
[327.489564] Subtest brightness-with-dpms: SUCCESS (2.426s)
[328.351538] [066/133] (692s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[328.451755] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[328.456000] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[328.558991] [067/133] (692s left) kms_flip (2x-plain-flip-fb-recreate)
[328.655870] Starting subtest: 2x-plain-flip-fb-recreate
[328.667458] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[328.747273] [068/133] (691s left) gem_wait (await)
[328.808560] Starting subtest: await
[328.811023] Starting dynamic subtest: all-engines
[329.940528] Dynamic subtest all-engines: SUCCESS (1.132s)
[329.958639] Starting dynamic subtest: rcs0
[331.002412] Dynamic subtest rcs0: SUCCESS (1.059s)
[331.020805] Starting dynamic subtest: bcs0
[332.061638] Dynamic subtest bcs0: SUCCESS (1.057s)
[332.078823] Starting dynamic subtest: vcs0
[333.114260] Dynamic subtest vcs0: SUCCESS (1.052s)
[333.130667] Starting dynamic subtest: vcs1
[334.167758] Dynamic subtest vcs1: SUCCESS (1.052s)
[334.184032] Starting dynamic subtest: vecs0
[335.220751] Dynamic subtest vecs0: SUCCESS (1.051s)
[335.237583] Starting dynamic subtest: ccs0
[336.278663] Dynamic subtest ccs0: SUCCESS (1.056s)
[336.281157] Subtest await: SUCCESS (7.473s)
[336.479888] [069/133] (684s left) kms_psr (fbc-psr-primary-page-flip)
[336.582650] Starting subtest: fbc-psr-primary-page-flip
[336.584813] Starting dynamic subtest: eDP-1
[336.588796] Dynamic subtest eDP-1: SKIP (0.000s)
[336.592834] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[336.654337] [070/133] (684s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[336.763333] Starting subtest: 4-tiled-32bpp-rotate-0
[338.186055] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.424s)
[338.316733] [071/133] (682s left) kms_async_flips (async-flip-dpms)
[338.414787] Starting subtest: async-flip-dpms
[338.798386] Starting dynamic subtest: pipe-A-eDP-1
[342.567059] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.770s)
[342.947594] Starting dynamic subtest: pipe-B-eDP-1
[345.745537] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.812s)
[346.134844] Starting dynamic subtest: pipe-C-eDP-1
[348.902290] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s)
[349.283021] Starting dynamic subtest: pipe-D-eDP-1
[352.066949] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.792s)
[352.069252] Subtest async-flip-dpms: SUCCESS (13.656s)
[353.249543] [072/133] (667s left) kms_cdclk (mode-transition-all-outputs)
[353.345648] Starting subtest: mode-transition-all-outputs
[353.633990] Subtest mode-transition-all-outputs: SKIP (0.287s)
[354.463921] [073/133] (666s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[354.564643] Starting subtest: fbc-rgb101010-draw-blt
[359.198207] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.636s)
[360.386804] [074/133] (660s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[360.472267] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[367.034208] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.568s)
[367.133814] [075/133] (653s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[367.232627] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[367.236809] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[367.328533] [076/133] (653s left) perf_pmu (gt-awake)
[367.370763] Starting subtest: gt-awake
[376.427221] Subtest gt-awake: SUCCESS (9.057s)
[376.521166] [077/133] (644s left) i915_getparams_basic (basic-eu-total)
[376.575776] Starting subtest: basic-eu-total
[376.580310] Subtest basic-eu-total: SUCCESS (0.000s)
[376.662990] [078/133] (644s left) kms_prop_blob (basic)
[376.712098] Starting subtest: basic
[376.714284] Subtest basic: SUCCESS (0.000s)
[376.841687] [079/133] (644s left) gem_mmap_wc (write-wc-read-gtt)
[376.898781] Subtest write-wc-read-gtt: SKIP (0.000s)
[376.956425] [080/133] (644s left) kms_cursor_crc (cursor-offscreen-128x42)
[377.180555] Starting subtest: cursor-offscreen-128x42
[377.226198] Subtest cursor-offscreen-128x42: SKIP (0.041s)
[377.433895] [081/133] (643s left) kms_psr (pr-sprite-render)
[377.530100] Starting subtest: pr-sprite-render
[377.533572] Subtest pr-sprite-render: SKIP (0.000s)
[377.603763] [082/133] (643s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[377.664715] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[377.772562] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[377.850609] [083/133] (643s left) perf_pmu (semaphore-wait-idle)
[377.888078] Starting subtest: semaphore-wait-idle
[377.890369] Starting dynamic subtest: rcs0
[378.401704] Dynamic subtest rcs0: SUCCESS (0.513s)
[378.414425] Starting dynamic subtest: bcs0
[378.915537] Dynamic subtest bcs0: SUCCESS (0.510s)
[378.928405] Starting dynamic subtest: vcs0
[379.428432] Dynamic subtest vcs0: SUCCESS (0.510s)
[379.440990] Starting dynamic subtest: vcs1
[379.941185] Dynamic subtest vcs1: SUCCESS (0.510s)
[379.953548] Starting dynamic subtest: vecs0
[380.453928] Dynamic subtest vecs0: SUCCESS (0.510s)
[380.466453] Starting dynamic subtest: ccs0
[380.970083] Dynamic subtest ccs0: SUCCESS (0.513s)
[380.972926] Subtest semaphore-wait-idle: SUCCESS (3.083s)
[382.454538] [084/133] (638s left) gem_exec_reloc (basic-cpu)
[382.515556] Subtest basic-cpu: SKIP (0.000s)
[382.579852] [085/133] (638s left) gem_exec_fence (keep-in-fence)
[382.764994] Starting subtest: keep-in-fence
[382.767544] Starting dynamic subtest: rcs0
[382.824571] Dynamic subtest rcs0: SUCCESS (0.060s)
[382.837419] Starting dynamic subtest: bcs0
[382.881368] Dynamic subtest bcs0: SUCCESS (0.054s)
[382.894469] Starting dynamic subtest: vcs0
[384.490922] Dynamic subtest vcs0: SUCCESS (1.606s)
[384.503734] Starting dynamic subtest: vcs1
[386.531511] Dynamic subtest vcs1: SUCCESS (1.981s)
[386.544668] Starting dynamic subtest: vecs0
[388.457940] Dynamic subtest vecs0: SUCCESS (1.983s)
[388.471534] Starting dynamic subtest: ccs0
[388.698079] Dynamic subtest ccs0: SUCCESS (0.238s)
[388.701306] Subtest keep-in-fence: SUCCESS (5.936s)
[390.541565] [086/133] (630s left) gem_exec_whisper (basic-fds-forked)
[390.612260] Starting subtest: basic-fds-forked
[413.434328] Subtest basic-fds-forked: SUCCESS (22.825s)
[413.636911] [087/133] (607s left) gem_ctx_isolation (dirty-create)
[413.715856] Starting subtest: dirty-create
[413.718362] Starting dynamic subtest: rcs0
[413.950766] Dynamic subtest rcs0: SUCCESS (0.235s)
[413.963553] Starting dynamic subtest: bcs0
[414.208973] Dynamic subtest bcs0: SUCCESS (0.257s)
[414.221577] Starting dynamic subtest: vcs0
[414.472844] Dynamic subtest vcs0: SUCCESS (0.263s)
[414.485207] Starting dynamic subtest: vcs1
[415.674717] Dynamic subtest vcs1: SUCCESS (1.201s)
[415.685689] Starting dynamic subtest: vecs0
[417.650672] Dynamic subtest vecs0: SUCCESS (1.975s)
[417.660452] Starting dynamic subtest: ccs0
[419.656507] Dynamic subtest ccs0: SUCCESS (2.005s)
[419.658940] Subtest dirty-create: SUCCESS (5.943s)
[419.898086] [088/133] (601s left) kms_content_protection (lic-type-1)
[420.036642] Starting subtest: lic-type-1
[420.042233] Subtest lic-type-1: SKIP (0.000s)
[420.160496] [089/133] (601s left) gem_exec_create (madvise)
[420.212724] Starting subtest: madvise
[420.215238] Starting dynamic subtest: smem
[440.366003] Dynamic subtest smem: SUCCESS (20.160s)
[440.368374] Subtest madvise: SUCCESS (20.161s)
[441.375281] [090/133] (580s left) kms_prop_blob (invalid-get-prop-any)
[441.440493] Starting subtest: invalid-get-prop-any
[441.442847] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[441.561679] [091/133] (580s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[441.657385] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[441.659527] Starting dynamic subtest: pipe-A-eDP-1
[441.681514] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[441.692659] Starting dynamic subtest: pipe-B-eDP-1
[441.714132] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[441.723633] Starting dynamic subtest: pipe-C-eDP-1
[441.745934] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[441.755204] Starting dynamic subtest: pipe-D-eDP-1
[441.777209] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[441.781289] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[443.927658] [092/133] (577s left) gem_ctx_engines (execute-one)
[443.994294] Starting subtest: execute-one
[446.152856] Subtest execute-one: SUCCESS (2.163s)
[446.485564] [093/133] (575s left) gem_spin_batch (resubmit-new)
[446.551384] Starting subtest: resubmit-new
[446.553881] Starting dynamic subtest: rcs0
[446.565274] Dynamic subtest rcs0: SUCCESS (0.014s)
[446.576587] Starting dynamic subtest: bcs0
[446.579124] Dynamic subtest bcs0: SUCCESS (0.007s)
[446.588853] Starting dynamic subtest: vcs0
[446.591088] Dynamic subtest vcs0: SUCCESS (0.006s)
[446.600254] Starting dynamic subtest: vcs1
[446.602498] Dynamic subtest vcs1: SUCCESS (0.007s)
[446.611528] Starting dynamic subtest: vecs0
[446.613720] Dynamic subtest vecs0: SUCCESS (0.005s)
[446.624029] Starting dynamic subtest: ccs0
[446.626217] Dynamic subtest ccs0: SUCCESS (0.006s)
[446.628399] Subtest resubmit-new: SUCCESS (0.049s)
[448.465973] [094/133] (573s left) gem_ccs (ctrl-surf-copy)
[448.536780] Starting subtest: ctrl-surf-copy
[448.541842] Subtest ctrl-surf-copy: SKIP (0.000s)
[448.642777] [095/133] (573s left) kms_flip (flip-vs-fences)
[448.740592] Starting subtest: flip-vs-fences
[448.744544] Subtest flip-vs-fences: SKIP (0.000s)
[448.846820] [096/133] (573s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[448.949372] Starting subtest: x-tiled-32bpp-rotate-90
[448.969109] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[449.088283] [097/133] (572s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[449.178305] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[449.182367] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[449.266141] [098/133] (572s left) gem_exec_await (wide-all)
[449.474423] Starting subtest: wide-all
[472.705527] Subtest wide-all: SUCCESS (23.221s)
[472.887143] [099/133] (549s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[473.037531] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[473.039828] Starting dynamic subtest: pipe-A-default-mode
[474.177948] Dynamic subtest pipe-A-default-mode: SKIP (1.138s)
[474.182309] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.140s)
[474.314290] [100/133] (547s left) kms_feature_discovery (psr1)
[474.402335] Starting subtest: psr1
[474.404587] Subtest psr1: SUCCESS (0.001s)
[474.478557] [101/133] (547s left) gem_exec_schedule (u-lateslice)
[474.570915] Starting subtest: u-lateslice
[474.573276] Starting dynamic subtest: rcs0
[474.580694] Dynamic subtest rcs0: SUCCESS (0.020s)
[474.592456] Starting dynamic subtest: bcs0
[474.598802] Dynamic subtest bcs0: SUCCESS (0.017s)
[474.609315] Starting dynamic subtest: vcs0
[474.615899] Dynamic subtest vcs0: SUCCESS (0.017s)
[474.625875] Starting dynamic subtest: vcs1
[474.633038] Dynamic subtest vcs1: SUCCESS (0.017s)
[474.642736] Starting dynamic subtest: vecs0
[474.651065] Dynamic subtest vecs0: SUCCESS (0.017s)
[474.660361] Starting dynamic subtest: ccs0
[474.669678] Dynamic subtest ccs0: SUCCESS (0.018s)
[474.671931] Subtest u-lateslice: SUCCESS (0.109s)
[476.527881] [102/133] (545s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[476.634059] Starting subtest: psr-1p-primscrn-spr-indfb-move
[484.230512] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.603s)
[484.406995] [103/133] (537s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[484.511398] Starting subtest: invalidate-primary-flip-overlay
[495.295096] Subtest invalidate-primary-flip-overlay: SUCCESS (10.790s)
[495.387506] [104/133] (526s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[495.473586] Starting subtest: psr2-plane-move-sf-dmg-area
[495.475366] Starting dynamic subtest: pipe-A-eDP-1
[500.042669] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.569s)
[500.054698] Starting dynamic subtest: pipe-B-eDP-1
[505.368800] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.329s)
[505.371192] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.901s)
[506.235788] [105/133] (516s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[506.350998] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[511.086462] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.742s)
[512.236411] [106/133] (510s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[512.350575] Starting subtest: basic-flip-after-cursor-atomic
[513.306112] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.954s)
[514.167779] [107/133] (508s left) kms_flip (dpms-vs-vblank-race-interruptible)
[514.265297] Starting subtest: dpms-vs-vblank-race-interruptible
[514.267604] Starting dynamic subtest: A-eDP1
[519.235139] Dynamic subtest A-eDP1: SUCCESS (4.969s)
[519.245750] Starting dynamic subtest: B-eDP1
[522.740589] Dynamic subtest B-eDP1: SUCCESS (3.506s)
[522.751190] Starting dynamic subtest: C-eDP1
[527.371941] Dynamic subtest C-eDP1: SUCCESS (4.628s)
[527.382875] Starting dynamic subtest: D-eDP1
[531.990120] Dynamic subtest D-eDP1: SUCCESS (4.620s)
[531.992439] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.736s)
[532.873935] [108/133] (489s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[532.938000] Starting subtest: y-tiled-to-vebox-yf-tiled
[532.942440] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[533.132210] [109/133] (489s left) perf_pmu (all-busy-check-all)
[533.175342] Starting subtest: all-busy-check-all
[534.441880] Subtest all-busy-check-all: SUCCESS (1.269s)
[534.553962] [110/133] (488s left) i915_pm_rps (thresholds-idle)
[534.617887] Starting subtest: thresholds-idle
[534.622199] Subtest thresholds-idle: SKIP (0.000s)
[534.722701] [111/133] (487s left) kms_flip (modeset-vs-vblank-race)
[534.818070] Starting subtest: modeset-vs-vblank-race
[534.820343] Starting dynamic subtest: A-eDP1
[539.500821] Dynamic subtest A-eDP1: SUCCESS (4.686s)
[539.516410] Starting dynamic subtest: B-eDP1
[544.221635] Dynamic subtest B-eDP1: SUCCESS (4.720s)
[544.235746] Starting dynamic subtest: C-eDP1
[548.926254] Dynamic subtest C-eDP1: SUCCESS (4.703s)
[548.936591] Starting dynamic subtest: D-eDP1
[553.553574] Dynamic subtest D-eDP1: SUCCESS (4.627s)
[553.558952] Subtest modeset-vs-vblank-race: SUCCESS (18.752s)
[554.731567] [112/133] (467s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[554.829422] Starting subtest: psr-rgb565-draw-mmap-gtt
[554.834086] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[554.976494] [113/133] (467s left) dmabuf_sync_file (export-multiwait)
[555.029266] Starting subtest: export-multiwait
[555.031655] Subtest export-multiwait: SUCCESS (0.001s)
[555.122428] [114/133] (467s left) kms_flip (nonexisting-fb)
[555.209681] Starting subtest: nonexisting-fb
[555.211967] Starting dynamic subtest: A-eDP1
[556.434780] Dynamic subtest A-eDP1: SUCCESS (1.224s)
[556.454344] Starting dynamic subtest: B-eDP1
[557.626395] Dynamic subtest B-eDP1: SUCCESS (1.189s)
[557.639808] Starting dynamic subtest: C-eDP1
[558.757193] Dynamic subtest C-eDP1: SUCCESS (1.129s)
[558.770968] Starting dynamic subtest: D-eDP1
[559.880869] Dynamic subtest D-eDP1: SUCCESS (1.121s)
[559.883030] Subtest nonexisting-fb: SUCCESS (4.676s)
[561.052531] [115/133] (461s left) sysfs_timeslice_duration (idempotent)
[561.116672] Starting subtest: idempotent
[561.118934] Starting dynamic subtest: vecs0
[561.121223] Dynamic subtest vecs0: SUCCESS (0.000s)
[561.132023] Starting dynamic subtest: ccs0
[561.134246] Dynamic subtest ccs0: SUCCESS (0.000s)
[561.143675] Starting dynamic subtest: vcs0
[561.145772] Dynamic subtest vcs0: SUCCESS (0.000s)
[561.154889] Starting dynamic subtest: bcs0
[561.156684] Dynamic subtest bcs0: SUCCESS (0.000s)
[561.168642] Starting dynamic subtest: rcs0
[561.170437] Dynamic subtest rcs0: SUCCESS (0.000s)
[561.179195] Starting dynamic subtest: vcs1
[561.181062] Dynamic subtest vcs1: SUCCESS (0.000s)
[561.182907] Subtest idempotent: SUCCESS (0.006s)
[561.221479] [116/133] (461s left) gem_exec_params (invalid-fence-in)
[561.286514] Starting subtest: invalid-fence-in
[561.288862] Subtest invalid-fence-in: SUCCESS (0.000s)
[561.382892] [117/133] (461s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[561.485667] Starting subtest: yf-tiled-64bpp-rotate-180
[561.489880] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[561.581563] [118/133] (461s left) gem_lmem_swapping (verify-random)
[561.629549] Subtest verify-random: SKIP (0.000s)
[561.673961] [119/133] (461s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[561.758662] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[561.761126] Starting dynamic subtest: pipe-A-eDP-1
[561.784015] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[561.797012] Starting dynamic subtest: pipe-B-eDP-1
[561.819071] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[561.829260] Starting dynamic subtest: pipe-C-eDP-1
[561.851052] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[561.860951] Starting dynamic subtest: pipe-D-eDP-1
[561.883024] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[561.887138] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[564.014644] [120/133] (459s left) i915_pm_rpm (system-suspend-devices)
[565.543043] Starting subtest: system-suspend-devices
[573.198982] Subtest system-suspend-devices: SUCCESS (7.663s)
[573.589574] [121/133] (449s left) gem_close_race (basic-threads)
[573.664545] Starting subtest: basic-threads
[575.004527] Subtest basic-threads: SUCCESS (1.338s)
[575.214162] [122/133] (447s left) syncobj_timeline (wait-all-interrupted)
[575.261886] Starting subtest: wait-all-interrupted
[575.364663] Subtest wait-all-interrupted: SUCCESS (0.101s)
[575.446890] [123/133] (447s left) kms_flip (2x-flip-vs-panning-interruptible)
[575.544275] Starting subtest: 2x-flip-vs-panning-interruptible
[575.556467] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[575.629770] [124/133] (447s left) kms_atomic (plane-primary-legacy)
[575.719275] Starting subtest: plane-primary-legacy
[575.721443] Starting dynamic subtest: pipe-A-eDP-1
[576.204667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.485s)
[576.206926] Subtest plane-primary-legacy: SUCCESS (0.486s)
[577.020085] [125/133] (446s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[577.125676] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[577.129888] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[577.230114] [126/133] (446s left) gem_lmem_swapping (massive-random)
[577.273740] Subtest massive-random: SKIP (0.000s)
[577.316868] [127/133] (446s left) gem_eio (in-flight-internal-10ms)
[577.523803] Starting subtest: in-flight-internal-10ms
[578.534222] Subtest in-flight-internal-10ms: SUCCESS (1.009s)
[578.669866] [128/133] (444s left) kms_busy (extended-pageflip-hang-newfb)
[578.771684] Starting subtest: extended-pageflip-hang-newfb
[578.773942] Starting dynamic subtest: pipe-A
[605.281076] Dynamic subtest pipe-A: SUCCESS (26.481s)
[605.293215] Starting dynamic subtest: pipe-D
[620.224323] Dynamic subtest pipe-D: SUCCESS (14.925s)
[620.226668] Subtest extended-pageflip-hang-newfb: SUCCESS (41.410s)
[621.030047] [129/133] (402s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[621.119847] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[621.124182] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[621.187126] [130/133] (402s left) gem_ctx_persistence (legacy-engines-persistence)
[621.243334] Starting subtest: legacy-engines-persistence
[621.245669] Starting dynamic subtest: render
[622.055388] Dynamic subtest render: SUCCESS (0.810s)
[622.070814] Starting dynamic subtest: bsd1
[622.819631] Dynamic subtest bsd1: SUCCESS (0.760s)
[622.835514] Starting dynamic subtest: bsd2
[623.566419] Dynamic subtest bsd2: SUCCESS (0.743s)
[623.578151] Starting dynamic subtest: blt
[624.366464] Dynamic subtest blt: SUCCESS (0.797s)
[624.381156] Starting dynamic subtest: vebox
[625.130950] Dynamic subtest vebox: SUCCESS (0.760s)
[625.133552] Subtest legacy-engines-persistence: SUCCESS (3.885s)
[625.214698] [131/133] (398s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[625.309132] Starting subtest: y-tiled-8bpp-rotate-0
[625.313345] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[625.412071] [132/133] (398s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[625.498330] Starting subtest: primary-yf-tiled-reflect-x-180
[625.569485] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.070s)
[625.684038] [133/133] (397s left) kms_vrr (seamless-rr-switch-virtual)
[625.774951] Starting subtest: seamless-rr-switch-virtual
[625.781389] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[625.856118] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_exec_gttfill
results: parsing output: 5/ for test: gen7_exec_parse
results: parsing output: 6/ for test: gem_set_tiling_vs_blt
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: gem_ctx_param
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: kms_color_pipeline
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: api_intel_allocator
results: parsing output: 18/ for test: gem_reg_read
results: parsing output: 19/ for test: gem_workarounds
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_exec_endless
results: parsing output: 22/ for test: kms_tiled_display
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_mmap_offset
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_atomic_interruptible
results: parsing output: 32/ for test: kms_invalid_mode
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_vblank
results: parsing output: 37/ for test: vgem_slow
results: parsing output: 38/ for test: kms_atomic_transition
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_plane_cursor
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_dirtyfb
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_pipe_crc_basic
results: parsing output: 51/ for test: kms_chamelium_hpd
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_chamelium_edid
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_pxp
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_lease
results: parsing output: 64/ for test: kms_pm_backlight
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_wait
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_async_flips
results: parsing output: 71/ for test: kms_cdclk
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: i915_getparams_basic
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: gem_mmap_wc
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: gem_ctx_isolation
results: parsing output: 87/ for test: kms_content_protection
results: parsing output: 88/ for test: gem_exec_create
results: parsing output: 89/ for test: kms_prop_blob
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: gem_ctx_engines
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: gem_ccs
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_await
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_feature_discovery
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_psr_stress_test
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: i915_pm_rps
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: sysfs_timeslice_duration
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: gem_close_race
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_atomic
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_lmem_swapping
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_busy
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_rotation_crc
results: parsing output: 132/ for test: kms_vrr
Done.