[60.354815] Initializing watchdogs
[60.354860]   /dev/watchdog0
[60.368555] [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]
[60.372796] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.375069] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.378199] [001/131] (960s left) i915_pm_rps (min-max-config-idle)
[60.470065] Starting subtest: min-max-config-idle
[60.474073] Subtest min-max-config-idle: SKIP (0.001s)
[60.594189] [002/131] (960s left) kms_properties (crtc-properties-atomic)
[60.683052] Starting subtest: crtc-properties-atomic
[60.685454] Starting dynamic subtest: pipe-A-eDP-1
[61.155837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.474s)
[61.163852] Starting dynamic subtest: pipe-B-eDP-1
[62.317515] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s)
[62.326210] Starting dynamic subtest: pipe-C-eDP-1
[63.462345] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.146s)
[63.471126] Starting dynamic subtest: pipe-D-eDP-1
[64.586257] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[64.588592] Subtest crtc-properties-atomic: SUCCESS (3.913s)
[65.411627] [003/131] (955s left) drm_mm (drm_mm)
[65.452390] Starting subtest: drm_mm
[65.463195] Starting dynamic subtest: drm_test_mm_init
[65.604369] Dynamic subtest drm_test_mm_init: SUCCESS (0.140s)
[65.612862] Starting dynamic subtest: drm_test_mm_debug
[65.711490] Dynamic subtest drm_test_mm_debug: SUCCESS (0.108s)
[65.720279] Starting dynamic subtest: drm_test_mm_align32
[65.851449] Dynamic subtest drm_test_mm_align32: SUCCESS (0.140s)
[65.860060] Starting dynamic subtest: drm_test_mm_align64
[65.994303] Dynamic subtest drm_test_mm_align64: SUCCESS (0.143s)
[66.002943] Starting dynamic subtest: drm_test_mm_lowest
[66.122878] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.128s)
[66.129546] Starting dynamic subtest: drm_test_mm_highest
[66.245235] Dynamic subtest drm_test_mm_highest: SUCCESS (0.122s)
[66.247283] Subtest drm_mm: SUCCESS (0.793s)
[66.437375] [004/131] (954s left) kms_chamelium_frames (hdmi-aspect-ratio)
[66.839882] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[67.638720] [005/131] (953s left) api_intel_allocator (fork-simple-once)
[67.851587] Starting subtest: fork-simple-once
[67.876891] Subtest fork-simple-once: SUCCESS (0.027s)
[68.246798] [006/131] (952s left) kms_big_fb (linear-8bpp-rotate-270)
[68.348092] Starting subtest: linear-8bpp-rotate-270
[68.368729] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[68.523924] [007/131] (952s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[68.616831] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[68.991536] Starting dynamic subtest: pipe-A-eDP-1
[71.805689] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.815s)
[72.167310] Starting dynamic subtest: pipe-B-eDP-1
[74.928529] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[75.289099] Starting dynamic subtest: pipe-C-eDP-1
[78.056771] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.772s)
[78.415022] Starting dynamic subtest: pipe-D-eDP-1
[81.180563] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[81.183195] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.569s)
[82.394750] [008/131] (938s left) kms_fence_pin_leak
[82.594366] [009/131] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[82.691068] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[82.695359] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[82.827122] [010/131] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[82.928392] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[82.932794] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[83.058254] [011/131] (938s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[83.123419] Starting subtest: multi-wait-all-for-submit-unsubmitted
[83.225455] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[83.320432] [012/131] (938s left) i915_drm_fdinfo (most-busy-check-all)
[83.356827] Starting subtest: most-busy-check-all
[83.359713] Starting dynamic subtest: rcs0
[83.364448] Dynamic subtest rcs0: SKIP (0.003s)
[83.375673] Starting dynamic subtest: bcs0
[83.380069] Dynamic subtest bcs0: SKIP (0.000s)
[83.390681] Starting dynamic subtest: vcs0
[83.394884] Dynamic subtest vcs0: SKIP (0.000s)
[83.403204] Starting dynamic subtest: vcs1
[83.407133] Dynamic subtest vcs1: SKIP (0.000s)
[83.413213] Starting dynamic subtest: vecs0
[83.417185] Dynamic subtest vecs0: SKIP (0.000s)
[83.423730] Starting dynamic subtest: ccs0
[83.428577] Dynamic subtest ccs0: SKIP (0.000s)
[83.432907] Subtest most-busy-check-all: SKIP (0.006s)
[83.467665] [013/131] (937s left) kms_flip (2x-flip-vs-panning-vs-hang)
[83.583586] Starting subtest: 2x-flip-vs-panning-vs-hang
[83.593520] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.012s)
[83.694659] [014/131] (937s left) kms_vblank (ts-continuation-suspend)
[83.796932] Starting subtest: ts-continuation-suspend
[83.799190] Starting dynamic subtest: pipe-A-eDP-1
[100.282881] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.312s)
[100.299864] Starting dynamic subtest: pipe-D-eDP-1
[117.286904] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.212s)
[117.289409] Subtest ts-continuation-suspend: SUCCESS (7.527s)
[118.108513] [015/131] (903s left) gem_exec_whisper (basic-forked)
[118.180730] Starting subtest: basic-forked
[125.340707] Subtest basic-forked: SUCCESS (7.243s)
[125.546887] [016/131] (895s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[125.655951] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[125.658382] Starting dynamic subtest: pipe-A-default-mode
[125.942130] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[125.946565] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.288s)
[126.836170] [017/131] (894s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[126.951704] Starting subtest: extended-modeset-hang-newfb-with-reset
[126.954212] Starting dynamic subtest: pipe-A
[140.946379] Dynamic subtest pipe-A: SUCCESS (14.036s)
[140.956373] Starting dynamic subtest: pipe-D
[156.741095] Dynamic subtest pipe-D: SUCCESS (15.793s)
[156.743325] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.834s)
[157.559639] [018/131] (864s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[157.699077] Starting subtest: basic-flip-after-cursor-atomic
[158.649472] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.948s)
[159.485752] [019/131] (862s left) gem_readwrite (read-bad-handle)
[159.540913] Subtest read-bad-handle: SKIP (0.000s)
[159.614304] [020/131] (862s left) gen9_exec_parse (bb-chained)
[159.670399] Subtest bb-chained: SKIP (0.000s)
[159.757826] [021/131] (861s left) kms_plane_alpha_blend (alpha-basic)
[159.846839] Starting subtest: alpha-basic
[160.140750] Starting dynamic subtest: pipe-A-eDP-1
[162.045636] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.902s)
[162.070907] Starting dynamic subtest: pipe-D-eDP-1
[164.757597] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.691s)
[164.759790] Subtest alpha-basic: SUCCESS (4.910s)
[165.649530] [022/131] (856s left) gem_spin_batch (legacy)
[165.706442] Starting subtest: legacy
[165.708626] Starting dynamic subtest: default
[169.038743] Dynamic subtest default: SUCCESS (3.327s)
[169.050253] Starting dynamic subtest: render
[172.267941] Dynamic subtest render: SUCCESS (3.229s)
[172.281705] Starting dynamic subtest: bsd
[175.507005] Dynamic subtest bsd: SUCCESS (3.235s)
[175.518195] Starting dynamic subtest: bsd1
[178.742909] Dynamic subtest bsd1: SUCCESS (3.235s)
[178.754703] Starting dynamic subtest: bsd2
[181.977133] Dynamic subtest bsd2: SUCCESS (3.233s)
[181.988307] Starting dynamic subtest: blt
[185.211506] Dynamic subtest blt: SUCCESS (3.233s)
[185.221664] Starting dynamic subtest: vebox
[188.447539] Dynamic subtest vebox: SUCCESS (3.235s)
[188.449784] Subtest legacy: SUCCESS (22.740s)
[189.027814] [023/131] (832s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[189.158805] Starting subtest: yf-tiled-32bpp-rotate-90
[189.163049] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[189.298038] [024/131] (832s left) kms_pm_rpm (i2c)
[191.029774] Starting subtest: i2c
[196.528759] Subtest i2c: SUCCESS (5.499s)
[196.641759] [025/131] (825s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[196.753890] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[197.797829] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.045s)
[197.952629] [026/131] (823s left) kms_psr (pr-sprite-mmap-gtt)
[198.059497] Starting subtest: pr-sprite-mmap-gtt
[198.063206] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[198.155017] [027/131] (823s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[198.260200] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[202.921547] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.665s)
[204.148068] [028/131] (817s left) kms_flip (2x-blocking-absolute-wf_vblank)
[204.254305] Starting subtest: 2x-blocking-absolute-wf_vblank
[204.265832] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.014s)
[204.367011] [029/131] (817s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[204.469368] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[204.473650] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[204.599745] [030/131] (817s left) gem_render_tiled_blits (basic)
[204.660496] Subtest basic: SKIP (0.000s)
[204.738953] [031/131] (817s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[204.823947] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[204.826111] Starting dynamic subtest: pipe-A-eDP-1
[204.881762] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[204.895593] Starting dynamic subtest: pipe-B-eDP-1
[204.950665] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[204.959781] Starting dynamic subtest: pipe-C-eDP-1
[205.013584] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[205.022590] Starting dynamic subtest: pipe-D-eDP-1
[205.071670] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[205.075693] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[206.996415] [032/131] (815s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[207.116539] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[215.664224] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.550s)
[215.801187] [033/131] (806s left) i915_fb_tiling (basic-x-tiling)
[215.870137] Subtest basic-x-tiling: SKIP (0.000s)
[215.966283] [034/131] (806s left) gem_exec_params (sol-reset-not-gen7)
[216.031610] Starting subtest: sol-reset-not-gen7
[216.037025] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[216.193470] [035/131] (806s left) kms_flip (plain-flip-ts-check-interruptible)
[216.305053] Starting subtest: plain-flip-ts-check-interruptible
[216.307328] Starting dynamic subtest: A-eDP1
[225.123051] Dynamic subtest A-eDP1: SUCCESS (8.814s)
[225.137952] Starting dynamic subtest: B-eDP1
[233.963445] Dynamic subtest B-eDP1: SUCCESS (8.837s)
[233.974830] Starting dynamic subtest: C-eDP1
[242.781819] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[242.791634] Starting dynamic subtest: D-eDP1
[251.613216] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[251.618707] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.307s)
[252.818944] [036/131] (769s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[252.940820] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[252.945008] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[253.081037] [037/131] (769s left) syncobj_timeline (etime-single-wait-all-submitted)
[253.136273] Starting subtest: etime-single-wait-all-submitted
[253.241088] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[253.347918] [038/131] (769s left) gem_userptr_blits (forbidden-operations)
[253.415593] Starting subtest: forbidden-operations
[253.419872] Subtest forbidden-operations: SKIP (0.000s)
[253.581795] [039/131] (768s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[253.633453] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[253.736387] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[253.837730] [040/131] (768s left) vgem_basic (sysfs)
[253.920762] Starting subtest: sysfs
[253.923333] Subtest sysfs: SUCCESS (0.003s)
[254.005680] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[254.008889] [041/131] (768s left) gem_madvise (dontneed-after-mmap)
[254.045712] Starting subtest: dontneed-after-mmap
[254.069494] Subtest dontneed-after-mmap: SUCCESS (0.023s)
[254.205659] [042/131] (768s left) kms_setmode (basic)
[254.263656] Starting subtest: basic
[254.583585] Starting dynamic subtest: pipe-A-eDP-1
[256.711624] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.124s)
[257.055129] Starting dynamic subtest: pipe-B-eDP-1
[259.136997] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.088s)
[259.447694] Subtest basic: SUCCESS (5.181s)
[260.301936] [043/131] (762s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[260.409564] Starting subtest: psr-indfb-scaledprimary
[266.144460] Subtest psr-indfb-scaledprimary: SUCCESS (5.737s)
[266.318364] [044/131] (756s left) gem_exec_balancer (bonded-chain)
[266.384167] Starting subtest: bonded-chain
[273.369688] Subtest bonded-chain: SUCCESS (6.984s)
[273.743440] [045/131] (748s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[273.865562] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[280.912080] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.050s)
[281.072086] [046/131] (741s left) gem_partial_pwrite_pread (reads-display)
[281.142445] Subtest reads-display: SKIP (0.000s)
[281.221469] [047/131] (741s left) gem_pxp (regular-baseline-src-copy-readible)
[281.346776] Starting subtest: regular-baseline-src-copy-readible
[281.406417] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s)
[281.566301] [048/131] (741s left) kms_psr (fbc-psr-cursor-plane-move)
[281.669944] Starting subtest: fbc-psr-cursor-plane-move
[281.672231] Starting dynamic subtest: eDP-1
[281.676487] Dynamic subtest eDP-1: SKIP (0.000s)
[281.680725] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[281.769268] [049/131] (741s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[281.868075] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[281.871846] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[281.995622] [050/131] (740s left) kms_rotation_crc (multiplane-rotation)
[282.098541] Starting subtest: multiplane-rotation
[299.497653] Subtest multiplane-rotation: SUCCESS (17.405s)
[299.658504] [051/131] (723s left) kms_feature_discovery (display-1x)
[299.760380] Starting subtest: display-1x
[299.762147] Subtest display-1x: SUCCESS (0.000s)
[299.859255] [052/131] (723s left) kms_cursor_crc (cursor-random-32x10)
[300.025359] Starting subtest: cursor-random-32x10
[300.078547] Subtest cursor-random-32x10: SKIP (0.049s)
[300.369434] [053/131] (722s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[300.481431] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[300.484764] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[300.618183] [054/131] (722s left) gem_exec_schedule (noreorder-corked)
[300.801643] Starting subtest: noreorder-corked
[300.804116] Starting dynamic subtest: rcs0
[301.975347] Dynamic subtest rcs0: SUCCESS (1.176s)
[301.987433] Starting dynamic subtest: vcs0
[303.938173] Dynamic subtest vcs0: SUCCESS (1.960s)
[303.954329] Starting dynamic subtest: vcs1
[305.912013] Dynamic subtest vcs1: SUCCESS (1.972s)
[305.922656] Starting dynamic subtest: vecs0
[307.896560] Dynamic subtest vecs0: SUCCESS (1.982s)
[307.914373] Starting dynamic subtest: ccs0
[309.068386] Dynamic subtest ccs0: SUCCESS (1.170s)
[309.071257] Subtest noreorder-corked: SUCCESS (8.273s)
[309.281804] [055/131] (713s left) gem_softpin (noreloc)
[309.348760] Starting subtest: noreloc
[314.768211] Subtest noreloc: SUCCESS (5.418s)
[314.937632] [056/131] (708s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[314.999416] Starting subtest: single-wait-for-submit-available-submitted
[315.001657] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[315.143511] [057/131] (708s left) kms_pm_dc (dc5-dpms-negative)
[316.254125] Starting subtest: dc5-dpms-negative
[316.258719] Subtest dc5-dpms-negative: SKIP (0.000s)
[316.354856] [058/131] (706s left) gem_exercise_blt (fast-copy)
[316.424711] Starting subtest: fast-copy
[316.427155] Starting dynamic subtest: linear-smem-smem
[316.446008] Dynamic subtest linear-smem-smem: SUCCESS (0.022s)
[316.457863] Starting dynamic subtest: xmajor-smem-smem
[316.464065] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[316.473338] Starting dynamic subtest: tile4-smem-smem
[316.482250] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[316.491288] Starting dynamic subtest: tile64-smem-smem
[316.499759] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[316.502140] Subtest fast-copy: SUCCESS (0.077s)
[316.660566] [059/131] (706s left) kms_psr (fbc-pr-sprite-blt)
[316.768671] Starting subtest: fbc-pr-sprite-blt
[316.773141] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[316.860912] [060/131] (706s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[321.862119] Starting subtest: psr2-cursor-plane-move-continuous-sf
[321.864861] Starting dynamic subtest: pipe-A-eDP-1
[332.953382] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.092s)
[332.964049] Starting dynamic subtest: pipe-B-eDP-1
[343.988438] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.033s)
[343.990824] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.130s)
[344.805911] [061/131] (678s left) kms_invalid_mode (zero-vdisplay)
[344.924736] Starting subtest: zero-vdisplay
[344.927040] Starting dynamic subtest: pipe-A-eDP-1
[345.228363] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.305s)
[345.238520] Starting dynamic subtest: pipe-B-eDP-1
[345.240811] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[345.250217] Starting dynamic subtest: pipe-C-eDP-1
[345.252509] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[345.261647] Starting dynamic subtest: pipe-D-eDP-1
[345.263941] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[345.266315] Subtest zero-vdisplay: SUCCESS (0.311s)
[346.043895] [062/131] (677s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[346.144036] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[353.190886] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.048s)
[353.319374] [063/131] (670s left) gem_mmap_offset (perf)
[353.386247] Starting subtest: perf
[353.388463] Starting dynamic subtest: smem0
[353.751759] Dynamic subtest smem0: SUCCESS (0.365s)
[353.753759] Subtest perf: SUCCESS (0.365s)
[353.900884] [064/131] (669s left) kms_plane (plane-position-covered)
[354.000216] Starting subtest: plane-position-covered
[354.501594] Starting dynamic subtest: pipe-A-plane-1
[355.819306] Dynamic subtest pipe-A-plane-1: SUCCESS (1.317s)
[355.829536] Starting dynamic subtest: pipe-A-plane-2
[357.124400] Dynamic subtest pipe-A-plane-2: SUCCESS (1.304s)
[357.134643] Starting dynamic subtest: pipe-A-plane-3
[358.381979] Dynamic subtest pipe-A-plane-3: SUCCESS (1.258s)
[358.391841] Starting dynamic subtest: pipe-A-plane-4
[359.710094] Dynamic subtest pipe-A-plane-4: SUCCESS (1.325s)
[359.720401] Starting dynamic subtest: pipe-A-plane-5
[359.734903] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[360.889041] Starting dynamic subtest: pipe-B-plane-1
[362.224045] Dynamic subtest pipe-B-plane-1: SUCCESS (1.344s)
[362.233692] Starting dynamic subtest: pipe-B-plane-2
[363.507406] Dynamic subtest pipe-B-plane-2: SUCCESS (1.281s)
[363.517652] Starting dynamic subtest: pipe-B-plane-3
[364.756178] Dynamic subtest pipe-B-plane-3: SUCCESS (1.247s)
[364.765839] Starting dynamic subtest: pipe-B-plane-4
[366.044722] Dynamic subtest pipe-B-plane-4: SUCCESS (1.289s)
[366.055077] Starting dynamic subtest: pipe-B-plane-5
[366.070549] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[366.072888] Subtest plane-position-covered: SUCCESS (12.068s)
[366.914360] [065/131] (656s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[366.980304] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[366.984777] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[367.189399] [066/131] (656s left) syncobj_wait (wait-for-submit-snapshot)
[367.245187] Starting subtest: wait-for-submit-snapshot
[367.324833] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[367.427709] [067/131] (656s left) gem_exec_flush (basic-batch-kernel-default-uc)
[367.513540] Starting subtest: basic-batch-kernel-default-uc
[374.041405] Subtest basic-batch-kernel-default-uc: SUCCESS (6.529s)
[374.255074] [068/131] (649s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[374.360084] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[374.364071] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[374.500811] [069/131] (649s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[374.613114] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[374.615397] Starting dynamic subtest: pipe-A-default-mode
[374.904997] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[374.909707] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.292s)
[375.746308] [070/131] (648s left) gem_ctx_shared (q-smoketest-all)
[375.821573] Starting subtest: Q-smoketest-all
[408.199315] Subtest Q-smoketest-all: SUCCESS (32.329s)
[410.033775] [071/131] (613s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[410.126299] Starting subtest: 4-tiled-addfb-size-offset-overflow
[410.128221] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[410.266094] [072/131] (613s left) gem_eio (wait-immediate)
[410.521980] Starting subtest: wait-immediate
[410.949697] Subtest wait-immediate: SUCCESS (0.428s)
[411.121514] [073/131] (612s left) gem_exec_schedule (u-semaphore-noskip)
[411.191548] Starting subtest: u-semaphore-noskip
[411.591418] Subtest u-semaphore-noskip: SUCCESS (0.403s)
[411.979549] [074/131] (611s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[412.083077] Starting subtest: y-tiled-64bpp-rotate-270
[412.087645] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[412.221203] [075/131] (611s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[412.321859] Starting subtest: read-crc-frame-sequence
[412.324181] Starting dynamic subtest: pipe-A-eDP-1
[413.032688] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[413.043044] Starting dynamic subtest: pipe-B-eDP-1
[414.393325] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.358s)
[414.412941] Starting dynamic subtest: pipe-C-eDP-1
[415.681804] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.289s)
[415.692405] Starting dynamic subtest: pipe-D-eDP-1
[417.034704] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s)
[417.037133] Subtest read-crc-frame-sequence: SUCCESS (4.715s)
[417.887860] [076/131] (606s left) gem_mmap (bad-object)
[417.957367] Subtest bad-object: SKIP (0.000s)
[418.019727] [077/131] (606s left) perf (gen12-group-concurrent-oa-buffer-read)
[418.191696] Starting subtest: gen12-group-concurrent-oa-buffer-read
[428.218824] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.027s)
[428.267719] [078/131] (595s left) kms_atomic (plane-cursor-legacy)
[428.389039] Starting subtest: plane-cursor-legacy
[428.391332] Starting dynamic subtest: pipe-A-eDP-1
[428.802436] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[428.804777] Subtest plane-cursor-legacy: SUCCESS (0.412s)
[429.621621] [079/131] (594s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[434.674047] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[434.678534] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[435.542377] [080/131] (588s left) kms_content_protection (dp-mst-type-1)
[435.688525] Starting subtest: dp-mst-type-1
[435.692927] Subtest dp-mst-type-1: SKIP (0.000s)
[435.831588] [081/131] (588s left) gem_exec_fence (syncobj-timeline-signal)
[436.388475] Starting subtest: syncobj-timeline-signal
[436.396538] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[438.059907] [082/131] (586s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[443.083511] Starting subtest: pr-cursor-plane-update-sf
[443.088092] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[443.958908] [083/131] (580s left) i915_selftest (perf)
[448.725461] Starting subtest: perf
[448.727620] Starting dynamic subtest: engine_cs
[451.623325] Dynamic subtest engine_cs: SUCCESS (2.898s)
[451.632273] Starting dynamic subtest: request
[459.051184] Dynamic subtest request: SUCCESS (7.426s)
[459.060805] Starting dynamic subtest: migrate
[463.520235] Dynamic subtest migrate: SUCCESS (4.467s)
[463.529716] Starting dynamic subtest: region
[469.524434] Dynamic subtest region: SUCCESS (6.002s)
[469.527323] Subtest perf: SUCCESS (20.802s)
[469.556128] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[469.556846] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[469.559800] [084/131] (554s left) kms_psr (psr2-cursor-blt)
[471.230364] Starting subtest: psr2-cursor-blt
[471.232695] Starting dynamic subtest: eDP-1
[472.985167] Dynamic subtest eDP-1: SUCCESS (1.754s)
[472.987439] Subtest psr2-cursor-blt: SUCCESS (1.755s)
[473.821797] [FACT kms_psr (psr2-cursor-blt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[473.823048] [FACT kms_psr (psr2-cursor-blt)] new: kernel.kmod_is_loaded.i915: true
[473.827445] [085/131] (550s left) prime_self_import (reimport-vs-gem_close-race)
[473.883140] Starting subtest: reimport-vs-gem_close-race
[478.987363] Subtest reimport-vs-gem_close-race: SUCCESS (5.104s)
[479.087741] [086/131] (545s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[479.147017] Starting subtest: multi-wait-all-for-submit-signaled
[479.149317] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[479.260871] [087/131] (545s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[479.394572] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[479.399217] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[479.569495] [088/131] (544s left) perf_pmu (most-busy-idle-check-all)
[479.614753] Starting subtest: most-busy-idle-check-all
[479.616886] Starting dynamic subtest: rcs0
[480.933992] Dynamic subtest rcs0: SUCCESS (1.317s)
[480.945353] Starting dynamic subtest: bcs0
[482.919021] Dynamic subtest bcs0: SUCCESS (1.982s)
[482.931262] Starting dynamic subtest: vcs0
[484.902544] Dynamic subtest vcs0: SUCCESS (1.981s)
[484.914183] Starting dynamic subtest: vcs1
[486.884297] Dynamic subtest vcs1: SUCCESS (1.979s)
[486.896659] Starting dynamic subtest: vecs0
[488.933551] Dynamic subtest vecs0: SUCCESS (2.047s)
[488.945848] Starting dynamic subtest: ccs0
[490.918423] Dynamic subtest ccs0: SUCCESS (1.981s)
[490.921256] Subtest most-busy-idle-check-all: SUCCESS (11.304s)
[491.041490] [089/131] (533s left) gem_fence_thrash (bo-copy)
[491.075410] Starting subtest: bo-copy
[491.105522] Subtest bo-copy: SKIP (0.025s)
[491.173685] [090/131] (533s left) kms_flip (plain-flip-interruptible)
[491.284511] Starting subtest: plain-flip-interruptible
[491.287044] Starting dynamic subtest: A-eDP1
[492.988057] Dynamic subtest A-eDP1: SUCCESS (1.704s)
[492.999572] Starting dynamic subtest: B-eDP1
[494.599661] Dynamic subtest B-eDP1: SUCCESS (1.610s)
[494.608931] Starting dynamic subtest: C-eDP1
[496.232838] Dynamic subtest C-eDP1: SUCCESS (1.632s)
[496.241808] Starting dynamic subtest: D-eDP1
[497.854989] Dynamic subtest D-eDP1: SUCCESS (1.621s)
[497.857400] Subtest plain-flip-interruptible: SUCCESS (6.576s)
[499.054579] [091/131] (525s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[499.103374] Starting subtest: invalid-bsd1-flag-on-vebox
[499.105724] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[499.253092] [092/131] (525s left) kms_dp_aux_dev
[499.625558] [093/131] (525s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[499.684344] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[499.743883] [094/131] (525s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[499.831203] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[499.835423] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[499.962444] [095/131] (524s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[500.025261] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[500.027550] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[500.165572] [096/131] (524s left) kms_cursor_edge_walk (256x256-top-edge)
[500.264065] Starting subtest: 256x256-top-edge
[500.266342] Starting dynamic subtest: pipe-A-eDP-1
[503.707091] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s)
[503.717606] Starting dynamic subtest: pipe-D-eDP-1
[506.830612] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[506.832880] Subtest 256x256-top-edge: SUCCESS (6.569s)
[507.654775] [097/131] (517s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[507.752500] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[514.309267] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.560s)
[514.478610] [098/131] (510s left) kms_cursor_crc (cursor-sliding-max-size)
[514.784047] Starting subtest: cursor-sliding-max-size
[514.790374] Subtest cursor-sliding-max-size: SKIP (0.000s)
[514.949270] [099/131] (510s left) gem_wait (wait)
[515.018238] Starting subtest: wait
[515.020579] Starting dynamic subtest: all-engines
[516.900396] Dynamic subtest all-engines: SUCCESS (1.881s)
[516.912780] Starting dynamic subtest: rcs0
[517.946629] Dynamic subtest rcs0: SUCCESS (1.045s)
[517.958681] Starting dynamic subtest: bcs0
[518.993247] Dynamic subtest bcs0: SUCCESS (1.045s)
[519.004618] Starting dynamic subtest: vcs0
[520.038314] Dynamic subtest vcs0: SUCCESS (1.043s)
[520.049301] Starting dynamic subtest: vcs1
[521.086460] Dynamic subtest vcs1: SUCCESS (1.046s)
[521.097631] Starting dynamic subtest: vecs0
[522.131230] Dynamic subtest vecs0: SUCCESS (1.043s)
[522.142532] Starting dynamic subtest: ccs0
[523.178029] Dynamic subtest ccs0: SUCCESS (1.045s)
[523.180537] Subtest wait: SUCCESS (8.162s)
[523.404080] [100/131] (501s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[523.494934] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[523.497313] Starting dynamic subtest: pipe-A-eDP-1
[523.521345] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[523.537997] Starting dynamic subtest: pipe-B-eDP-1
[523.561645] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[523.572362] Starting dynamic subtest: pipe-C-eDP-1
[523.594176] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[523.603532] Starting dynamic subtest: pipe-D-eDP-1
[523.627178] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[523.631446] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[525.761317] [101/131] (499s left) gem_busy (busy)
[525.834059] Starting subtest: busy
[525.836367] Starting dynamic subtest: all-engines
[525.923624] Dynamic subtest all-engines: SUCCESS (0.090s)
[525.934444] Starting dynamic subtest: rcs0
[527.916219] Dynamic subtest rcs0: SUCCESS (1.991s)
[527.927703] Starting dynamic subtest: bcs0
[527.972760] Dynamic subtest bcs0: SUCCESS (0.054s)
[527.983211] Starting dynamic subtest: vcs0
[528.012367] Dynamic subtest vcs0: SUCCESS (0.037s)
[528.021042] Starting dynamic subtest: vcs1
[529.899825] Dynamic subtest vcs1: SUCCESS (1.886s)
[529.910871] Starting dynamic subtest: vecs0
[531.882313] Dynamic subtest vecs0: SUCCESS (1.981s)
[531.892712] Starting dynamic subtest: ccs0
[533.929691] Dynamic subtest ccs0: SUCCESS (2.047s)
[533.931743] Subtest busy: SUCCESS (8.095s)
[534.326455] [102/131] (490s left) gem_mmap_gtt (basic)
[534.380387] Subtest basic: SKIP (0.000s)
[534.457784] [103/131] (490s left) gem_mmap_gtt (basic-write-read)
[534.531560] Subtest basic-write-read: SKIP (0.000s)
[534.589821] [104/131] (490s left) kms_hdr (static-toggle-suspend)
[534.678585] Starting subtest: static-toggle-suspend
[534.685294] Subtest static-toggle-suspend: SKIP (0.000s)
[534.777776] [105/131] (490s left) kms_properties (invalid-properties-legacy)
[534.879127] Starting subtest: invalid-properties-legacy
[534.989822] Subtest invalid-properties-legacy: SUCCESS (0.111s)
[535.087732] [106/131] (490s left) kms_chamelium_hpd (dp-hpd-fast)
[535.480333] Subtest dp-hpd-fast: SKIP (0.000s)
[536.250592] [107/131] (489s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[536.352505] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[536.356791] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[536.486836] [108/131] (488s left) kms_color_pipeline (plane-ctm3x4)
[536.588111] Starting subtest: plane-ctm3x4
[536.604277] Starting dynamic subtest: pipe-A-eDP-1
[537.266752] Dynamic subtest pipe-A-eDP-1: FAIL (0.301s)
[537.954025] Starting dynamic subtest: pipe-B-eDP-1
[538.725750] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[539.283111] Starting dynamic subtest: pipe-C-eDP-1
[540.097543] Dynamic subtest pipe-C-eDP-1: FAIL (0.225s)
[540.609568] Starting dynamic subtest: pipe-D-eDP-1
[541.422099] Dynamic subtest pipe-D-eDP-1: FAIL (0.224s)
[541.424160] Subtest plane-ctm3x4: FAIL (4.549s)
[542.017954] [109/131] (483s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[542.121089] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[542.123400] Starting dynamic subtest: pipe-A
[542.232015] Dynamic subtest pipe-A: SKIP (0.106s)
[542.241948] Starting dynamic subtest: pipe-B
[543.361533] Dynamic subtest pipe-B: SKIP (1.131s)
[543.370668] Starting dynamic subtest: pipe-C
[544.507861] Dynamic subtest pipe-C: SUCCESS (1.150s)
[544.517345] Starting dynamic subtest: pipe-D
[545.650526] Dynamic subtest pipe-D: SUCCESS (1.141s)
[545.652839] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.533s)
[546.872407] [110/131] (478s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[547.263116] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[548.046205] [111/131] (477s left) kms_universal_plane (cursor-fb-leak)
[548.150409] Starting subtest: cursor-fb-leak
[548.152741] Starting dynamic subtest: pipe-A-eDP-1
[548.461780] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.313s)
[548.471653] Starting dynamic subtest: pipe-B-eDP-1
[549.766488] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.304s)
[549.777531] Starting dynamic subtest: pipe-C-eDP-1
[551.078611] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.311s)
[551.089641] Starting dynamic subtest: pipe-D-eDP-1
[552.398287] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[552.400512] Subtest cursor-fb-leak: SUCCESS (4.249s)
[553.603022] [112/131] (471s left) syncobj_wait (wait-any-interrupted)
[553.655824] Starting subtest: wait-any-interrupted
[553.757027] Subtest wait-any-interrupted: SUCCESS (0.103s)
[553.857727] [113/131] (471s left) gem_ctx_isolation (dirty-switch)
[553.919460] Starting subtest: dirty-switch
[553.921754] Starting dynamic subtest: rcs0
[554.112795] Dynamic subtest rcs0: SUCCESS (0.193s)
[554.124707] Starting dynamic subtest: bcs0
[554.345071] Dynamic subtest bcs0: SUCCESS (0.231s)
[554.356530] Starting dynamic subtest: vcs0
[554.589591] Dynamic subtest vcs0: SUCCESS (0.244s)
[554.600538] Starting dynamic subtest: vcs1
[556.072148] Dynamic subtest vcs1: SUCCESS (1.481s)
[556.083503] Starting dynamic subtest: vecs0
[558.157807] Dynamic subtest vecs0: SUCCESS (2.085s)
[558.166914] Starting dynamic subtest: ccs0
[560.161779] Dynamic subtest ccs0: SUCCESS (2.004s)
[560.164278] Subtest dirty-switch: SUCCESS (6.244s)
[560.437279] [114/131] (465s left) gem_softpin (evict-snoop-interruptible)
[560.507860] Starting subtest: evict-snoop-interruptible
[560.512195] Subtest evict-snoop-interruptible: SKIP (0.000s)
[560.665664] [115/131] (464s left) api_intel_bb (intel-bb-blit-y)
[560.735511] Starting subtest: intel-bb-blit-y
[564.390150] Subtest intel-bb-blit-y: SUCCESS (3.655s)
[564.571188] [116/131] (461s left) gem_ctx_engines (execute-allforone)
[564.640409] Starting subtest: execute-allforone
[564.665194] Subtest execute-allforone: SUCCESS (0.025s)
[566.044783] [117/131] (459s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[566.149206] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[566.151432] Starting dynamic subtest: pipe-A-eDP-1
[566.209649] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[566.220317] Starting dynamic subtest: pipe-B-eDP-1
[566.276632] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[566.287462] Starting dynamic subtest: pipe-C-eDP-1
[566.345522] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[566.356004] Starting dynamic subtest: pipe-D-eDP-1
[566.414367] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[566.418716] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.010s)
[568.458572] [118/131] (457s left) sysfs_heartbeat_interval (mixed)
[568.525757] Starting subtest: mixed
[568.528203] Starting dynamic subtest: vecs0
[573.770489] Dynamic subtest vecs0: SUCCESS (5.244s)
[573.781379] Starting dynamic subtest: ccs0
[578.989369] Dynamic subtest ccs0: SUCCESS (5.217s)
[579.000755] Starting dynamic subtest: vcs0
[584.233403] Dynamic subtest vcs0: SUCCESS (5.243s)
[584.245016] Starting dynamic subtest: bcs0
[589.463849] Dynamic subtest bcs0: SUCCESS (5.228s)
[589.475075] Starting dynamic subtest: rcs0
[594.636197] Dynamic subtest rcs0: SUCCESS (5.172s)
[594.646742] Starting dynamic subtest: vcs1
[599.851209] Dynamic subtest vcs1: SUCCESS (5.211s)
[599.853753] Subtest mixed: SUCCESS (31.328s)
[599.961769] [119/131] (425s left) perf (polling-small-buf)
[600.099408] Starting subtest: polling-small-buf
[600.191796] Subtest polling-small-buf: SUCCESS (0.091s)
[600.239979] [120/131] (425s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[600.305022] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[600.307270] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[600.427001] [121/131] (425s left) gem_exec_capture (pi)
[600.489443] Starting subtest: pi
[600.491421] Starting dynamic subtest: rcs0
[605.084186] Dynamic subtest rcs0: SUCCESS (4.593s)
[605.095727] Starting dynamic subtest: bcs0
[609.331191] Dynamic subtest bcs0: SUCCESS (4.242s)
[609.344022] Starting dynamic subtest: vcs0
[613.568845] Dynamic subtest vcs0: SUCCESS (4.232s)
[613.581000] Starting dynamic subtest: vcs1
[617.826038] Dynamic subtest vcs1: SUCCESS (4.253s)
[617.838644] Starting dynamic subtest: vecs0
[621.965711] Dynamic subtest vecs0: SUCCESS (4.136s)
[621.975245] Starting dynamic subtest: ccs0
[626.293004] Dynamic subtest ccs0: SUCCESS (4.323s)
[626.295593] Subtest pi: SUCCESS (25.791s)
[626.400774] [122/131] (399s left) kms_atomic_interruptible (universal-setplane-primary)
[626.559824] Starting subtest: universal-setplane-primary
[626.562010] Starting dynamic subtest: pipe-A-eDP-1
[633.979758] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.416s)
[633.982030] Subtest universal-setplane-primary: SUCCESS (7.418s)
[634.856427] [123/131] (391s left) kms_flip (2x-dpms-vs-vblank-race)
[634.956735] Starting subtest: 2x-dpms-vs-vblank-race
[634.968506] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[635.074178] [124/131] (390s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[635.188139] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[642.138229] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.950s)
[642.325256] [125/131] (383s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[642.450789] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[649.373327] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.922s)
[649.553280] [126/131] (376s left) gem_exec_fence (invalid-fence-array)
[650.027873] Starting subtest: invalid-fence-array
[650.033470] Subtest invalid-fence-array: SUCCESS (0.003s)
[652.014263] [127/131] (374s left) gem_lmem_swapping (parallel-random-verify)
[652.055623] Subtest parallel-random-verify: SKIP (0.000s)
[652.105128] [128/131] (374s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[652.197926] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[652.200259] Starting dynamic subtest: pipe-A-eDP-1
[652.223017] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[652.234816] Starting dynamic subtest: pipe-B-eDP-1
[652.256734] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[652.265935] Starting dynamic subtest: pipe-C-eDP-1
[652.287541] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[652.296521] Starting dynamic subtest: pipe-D-eDP-1
[652.318505] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[652.322986] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[654.403891] [129/131] (371s left) gem_mmap_offset (clear-via-pagefault)
[654.473796] Starting subtest: clear-via-pagefault
[654.476171] Starting dynamic subtest: smem0
[688.381892] Dynamic subtest smem0: SUCCESS (33.893s)
[688.384755] Subtest clear-via-pagefault: SUCCESS (33.895s)
[688.545960] [130/131] (337s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[688.664793] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[688.668996] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[688.786168] [131/131] (337s left) gem_ctx_persistence (heartbeat-close)
[688.855065] Starting subtest: heartbeat-close
[688.859638] Subtest heartbeat-close: SKIP (0.000s)
[688.991442] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rps
results: parsing output: 1/ for test: kms_properties
results: parsing output: 2/ for test: drm_mm
results: parsing output: 3/ for test: kms_chamelium_frames
results: parsing output: 4/ for test: api_intel_allocator
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_async_flips
results: parsing output: 7/ for test: kms_fence_pin_leak
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: i915_drm_fdinfo
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_vblank
results: parsing output: 14/ for test: gem_exec_whisper
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: kms_busy
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: gem_readwrite
results: parsing output: 19/ for test: gen9_exec_parse
results: parsing output: 20/ for test: kms_plane_alpha_blend
results: parsing output: 21/ for test: gem_spin_batch
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_pm_rpm
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_render_tiled_blits
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_fb_tiling
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: gem_madvise
results: parsing output: 41/ for test: kms_setmode
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_partial_pwrite_pread
results: parsing output: 46/ for test: gem_pxp
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_rotation_crc
results: parsing output: 50/ for test: kms_feature_discovery
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: gem_softpin
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_pm_dc
results: parsing output: 57/ for test: gem_exercise_blt
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_invalid_mode
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_mmap_offset
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: gem_exec_flush
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: gem_ctx_shared
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_pipe_crc_basic
results: parsing output: 75/ for test: gem_mmap
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_content_protection
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: i915_selftest
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: prime_self_import
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: gem_fence_thrash
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_exec_params
results: parsing output: 91/ for test: kms_dp_aux_dev
results: parsing output: 92/ for test: kms_pipe_b_c_ivb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_cursor_edge_walk
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: gem_wait
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: gem_busy
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_hdr
results: parsing output: 104/ for test: kms_properties
results: parsing output: 105/ for test: kms_chamelium_hpd
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_color_pipeline
results: parsing output: 108/ for test: kms_plane_scaling
results: parsing output: 109/ for test: kms_chamelium_edid
results: parsing output: 110/ for test: kms_universal_plane
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_ctx_isolation
results: parsing output: 113/ for test: gem_softpin
results: parsing output: 114/ for test: api_intel_bb
results: parsing output: 115/ for test: gem_ctx_engines
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: sysfs_heartbeat_interval
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: gem_exec_capture
results: parsing output: 121/ for test: kms_atomic_interruptible
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_fence
results: parsing output: 126/ for test: gem_lmem_swapping
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_mmap_offset
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_ctx_persistence
Done.