[76.634734] Initializing watchdogs
[76.634778]   /dev/watchdog0
[76.649907] [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]
[76.654553] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[76.656818] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[76.660197] [001/131] (960s left) gen9_exec_parse (bb-chained)
[76.761546] Subtest bb-chained: SKIP (0.000s)
[76.836695] [002/131] (960s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[76.937257] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[76.939524] Starting dynamic subtest: pipe-A-eDP-1
[76.973550] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[76.981589] Starting dynamic subtest: pipe-B-eDP-1
[77.002401] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[77.008806] Starting dynamic subtest: pipe-C-eDP-1
[77.029895] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[77.036595] Starting dynamic subtest: pipe-D-eDP-1
[77.058404] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[77.062775] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[79.209753] [003/131] (958s left) kms_properties (crtc-properties-atomic)
[79.306580] Starting subtest: crtc-properties-atomic
[79.308839] Starting dynamic subtest: pipe-A-eDP-1
[79.787699] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.481s)
[79.796331] Starting dynamic subtest: pipe-B-eDP-1
[80.953576] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s)
[80.962767] Starting dynamic subtest: pipe-C-eDP-1
[82.077272] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[82.086222] Starting dynamic subtest: pipe-D-eDP-1
[83.215192] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[83.217649] Subtest crtc-properties-atomic: SUCCESS (3.905s)
[84.045268] [004/131] (953s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[84.160946] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[84.165403] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[84.275144] [005/131] (953s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[84.364588] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[84.366845] Starting dynamic subtest: pipe-A-default-mode
[84.660882] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[84.665854] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.294s)
[85.480606] [006/131] (951s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[85.588685] Starting subtest: psr-1p-primscrn-cur-indfb-move
[93.015928] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.425s)
[93.179925] [007/131] (944s left) kms_psr (psr2-primary-mmap-cpu)
[93.289409] Starting subtest: psr2-primary-mmap-cpu
[93.291588] Starting dynamic subtest: eDP-1
[94.998318] Dynamic subtest eDP-1: SUCCESS (1.709s)
[95.000734] Subtest psr2-primary-mmap-cpu: SUCCESS (1.709s)
[95.883159] [008/131] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[95.983621] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[95.988101] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[96.108856] [009/131] (941s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[96.209845] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[96.213773] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[96.343921] [010/131] (941s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[96.446596] Starting subtest: 4-tiled-addfb-size-offset-overflow
[96.448604] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[96.588168] [011/131] (940s left) gem_eio (wait-immediate)
[96.743153] Starting subtest: wait-immediate
[96.979355] Subtest wait-immediate: SUCCESS (0.236s)
[97.157107] [012/131] (940s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[102.165429] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[102.169992] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.003s)
[103.021110] [013/131] (934s left) gem_exec_alignment (many)
[103.086674] Starting subtest: many
[124.890686] Subtest many: SUCCESS (21.746s)
[125.933673] [014/131] (911s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[126.088311] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[130.726692] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.642s)
[131.877127] [015/131] (905s left) kms_psr (fbc-psr-cursor-blt)
[131.980781] Starting subtest: fbc-psr-cursor-blt
[131.983269] Starting dynamic subtest: eDP-1
[131.987702] Dynamic subtest eDP-1: SKIP (0.000s)
[131.992194] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[132.074723] [016/131] (905s left) gem_fence_thrash (bo-write-verify-threaded-y)
[132.107550] Starting subtest: bo-write-verify-threaded-y
[132.132075] Subtest bo-write-verify-threaded-y: SKIP (0.021s)
[132.182258] [017/131] (905s left) fbdev (unaligned-read)
[132.218569] Starting subtest: unaligned-read
[132.233569] Subtest unaligned-read: SUCCESS (0.015s)
[132.308422] [018/131] (905s left) kms_lease (lease-unleased-crtc)
[132.399580] Starting subtest: lease-unleased-crtc
[132.402821] Starting dynamic subtest: pipe-A-eDP-1
[132.699036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[132.707386] Starting dynamic subtest: pipe-B-eDP-1
[133.501771] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.802s)
[133.512176] Starting dynamic subtest: pipe-C-eDP-1
[133.514864] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[133.527945] Starting dynamic subtest: pipe-D-eDP-1
[133.530603] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[133.532732] Subtest lease-unleased-crtc: SUCCESS (1.116s)
[133.907452] [019/131] (903s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[134.017834] Starting subtest: x-tiled-16bpp-rotate-0
[135.385276] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.368s)
[135.529104] [020/131] (902s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[140.557223] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[140.561770] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.003s)
[141.424482] [021/131] (896s left) gem_exec_balancer (bonded-false-hang)
[141.684762] Starting subtest: bonded-false-hang
[141.690288] Subtest bonded-false-hang: SKIP (0.000s)
[141.803739] [022/131] (896s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[141.904670] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[148.518500] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.616s)
[148.663277] [023/131] (889s left) gem_exec_params (mmapped)
[148.719585] Starting subtest: mmapped
[148.724366] Subtest mmapped: SUCCESS (0.003s)
[148.866799] [024/131] (889s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[148.961513] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[155.955741] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (6.996s)
[157.158024] [025/131] (880s left) gem_mmap_gtt (cpuset-big-copy)
[157.221548] Subtest cpuset-big-copy: SKIP (0.000s)
[157.273392] [026/131] (880s left) kms_psr (fbc-psr2-sprite-blt)
[157.368920] Starting subtest: fbc-psr2-sprite-blt
[157.371261] Starting dynamic subtest: eDP-1
[157.375669] Dynamic subtest eDP-1: SKIP (0.000s)
[157.380186] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[157.467790] [027/131] (880s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[157.569528] Starting subtest: flip-primary-invalidate-overlay
[169.157507] Subtest flip-primary-invalidate-overlay: SUCCESS (11.590s)
[169.349665] [028/131] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[169.452280] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[169.455666] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[169.566827] [029/131] (868s left) kms_getfb (getfb-handle-protection)
[169.659556] Starting subtest: getfb-handle-protection
[169.677715] Subtest getfb-handle-protection: SUCCESS (0.019s)
[169.814785] [030/131] (868s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[169.871485] Starting subtest: multi-wait-all-for-submit-submitted
[169.976502] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[170.077467] [031/131] (868s left) kms_flip (2x-plain-flip-ts-check)
[170.173399] Starting subtest: 2x-plain-flip-ts-check
[170.184976] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[170.285433] [032/131] (868s left) gem_pxp (reject-modify-context-protection-on)
[170.408606] Starting subtest: reject-modify-context-protection-on
[170.411060] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[170.543308] [033/131] (867s left) kms_chamelium_audio (dp-audio-edid)
[170.920937] Subtest dp-audio-edid: SKIP (0.000s)
[171.735171] [034/131] (866s left) sysfs_timeslice_duration (timeout)
[171.801340] Starting subtest: timeout
[171.803822] Starting dynamic subtest: vecs0
[180.889326] Dynamic subtest vecs0: SUCCESS (9.084s)
[180.900090] Starting dynamic subtest: ccs0
[182.249988] Dynamic subtest ccs0: SUCCESS (1.361s)
[182.260371] Starting dynamic subtest: vcs0
[191.886060] Dynamic subtest vcs0: SUCCESS (9.632s)
[191.897602] Starting dynamic subtest: bcs0
[192.583583] Dynamic subtest bcs0: SUCCESS (0.697s)
[192.596888] Starting dynamic subtest: rcs0
[193.981640] Dynamic subtest rcs0: SUCCESS (1.396s)
[193.992343] Starting dynamic subtest: vcs1
[203.928844] Dynamic subtest vcs1: SUCCESS (9.947s)
[203.931530] Subtest timeout: SUCCESS (32.128s)
[204.015893] [035/131] (834s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[204.084665] Starting subtest: invalid-bsd2-flag-on-vebox
[204.086986] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.001s)
[204.224821] [036/131] (834s left) gem_exercise_blt (fast-copy-emit)
[204.284887] Starting subtest: fast-copy-emit
[204.287294] Starting dynamic subtest: linear-smem-smem-emit
[204.316108] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.032s)
[204.325976] Starting dynamic subtest: xmajor-smem-smem-emit
[204.338972] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.022s)
[204.349895] Starting dynamic subtest: tile4-smem-smem-emit
[204.358820] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.020s)
[204.366952] Starting dynamic subtest: tile64-smem-smem-emit
[204.377953] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.018s)
[204.380298] Subtest fast-copy-emit: SUCCESS (0.094s)
[204.526444] [037/131] (834s left) kms_plane_multiple (2x-tiling-4)
[204.628395] Starting subtest: 2x-tiling-4
[204.633089] Subtest 2x-tiling-4: SKIP (0.000s)
[204.723697] [038/131] (833s left) dmabuf_sync_file (export-before-signal)
[204.832417] Starting subtest: export-before-signal
[204.834214] Subtest export-before-signal: SUCCESS (0.001s)
[204.898781] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[204.901760] [039/131] (833s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[204.986049] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[204.987931] Starting dynamic subtest: pipe-A-eDP-1
[205.034919] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[205.042843] Starting dynamic subtest: pipe-B-eDP-1
[205.091045] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[205.100180] Starting dynamic subtest: pipe-C-eDP-1
[205.146884] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[205.156039] Starting dynamic subtest: pipe-D-eDP-1
[205.202822] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[205.206322] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[207.161274] [040/131] (831s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[207.258367] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[207.262381] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[207.381526] [041/131] (831s left) i915_pm_rpm (gem-pread)
[209.107722] Starting subtest: gem-pread
[211.333922] Subtest gem-pread: SUCCESS (2.230s)
[211.445173] [042/131] (827s left) prime_vgem (fence-wait)
[211.513907] Starting subtest: fence-wait
[211.516085] Starting dynamic subtest: rcs0
[212.572611] Dynamic subtest rcs0: SUCCESS (1.057s)
[212.583774] Starting dynamic subtest: bcs0
[213.644718] Dynamic subtest bcs0: SUCCESS (1.070s)
[213.655411] Starting dynamic subtest: vcs0
[214.688024] Dynamic subtest vcs0: SUCCESS (1.042s)
[214.699644] Starting dynamic subtest: vcs1
[215.732332] Dynamic subtest vcs1: SUCCESS (1.042s)
[215.742321] Starting dynamic subtest: vecs0
[216.772484] Dynamic subtest vecs0: SUCCESS (1.038s)
[216.784359] Starting dynamic subtest: ccs0
[217.817224] Dynamic subtest ccs0: SUCCESS (1.042s)
[217.819903] Subtest fence-wait: SUCCESS (6.302s)
[217.980240] [043/131] (820s left) syncobj_timeline (invalid-wait-bad-flags)
[218.035734] Starting subtest: invalid-wait-bad-flags
[218.038045] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[218.168167] [044/131] (820s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[218.272581] Starting subtest: fbcpsr-rgb565-draw-render
[225.347261] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.076s)
[225.513552] [045/131] (813s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[225.573945] Starting subtest: wait-all-for-submit-delayed-submit
[225.677778] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[225.765367] [046/131] (813s left) gem_exec_flush (basic-wb-rw-default)
[225.817101] Starting subtest: basic-wb-rw-default
[231.299924] Subtest basic-wb-rw-default: SUCCESS (5.450s)
[231.467023] [047/131] (807s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[231.563099] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[231.567201] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[231.687634] [048/131] (807s left) kms_pipe_crc_basic (suspend-read-crc)
[231.775546] Starting subtest: suspend-read-crc
[231.777806] Starting dynamic subtest: pipe-A-eDP-1
[249.698966] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.749s)
[249.709882] Starting dynamic subtest: pipe-B-eDP-1
[267.441464] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.856s)
[267.452969] Starting dynamic subtest: pipe-C-eDP-1
[285.374674] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.699s)
[285.385278] Starting dynamic subtest: pipe-D-eDP-1
[303.357763] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.758s)
[303.360836] Subtest suspend-read-crc: SUCCESS (11.068s)
[304.238319] [049/131] (734s left) gem_exec_reloc (basic-gtt-wc)
[304.307658] Subtest basic-gtt-wc: SKIP (0.000s)
[304.389099] [050/131] (734s left) gem_watchdog (default-physical)
[304.479713] Starting subtest: default-physical
[306.259982] Subtest default-physical: SUCCESS (1.753s)
[306.356172] [051/131] (732s left) gem_fence_thrash (bo-write-verify-threaded-x)
[306.389528] Starting subtest: bo-write-verify-threaded-x
[306.417179] Subtest bo-write-verify-threaded-x: SKIP (0.023s)
[306.485437] [052/131] (732s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[306.587252] Starting subtest: fbc-rgb565-draw-blt
[310.854276] Subtest fbc-rgb565-draw-blt: SUCCESS (4.203s)
[311.999401] [053/131] (727s left) kms_universal_plane (disable-primary-vs-flip)
[312.103453] Starting subtest: disable-primary-vs-flip
[312.105951] Starting dynamic subtest: pipe-A-eDP-1
[313.640574] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.521s)
[313.651625] Starting dynamic subtest: pipe-B-eDP-1
[315.821775] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.167s)
[315.833142] Starting dynamic subtest: pipe-C-eDP-1
[318.017815] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.182s)
[318.028820] Starting dynamic subtest: pipe-D-eDP-1
[320.191989] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.160s)
[320.194612] Subtest disable-primary-vs-flip: SUCCESS (8.035s)
[321.006021] [054/131] (718s left) kms_cursor_edge_walk (128x128-top-edge)
[321.106428] Starting subtest: 128x128-top-edge
[321.109082] Starting dynamic subtest: pipe-A-eDP-1
[324.563097] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s)
[324.573650] Starting dynamic subtest: pipe-D-eDP-1
[327.704533] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.136s)
[327.707410] Subtest 128x128-top-edge: SUCCESS (6.582s)
[328.529297] [055/131] (710s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[328.656077] Starting subtest: flip-vs-cursor-busy-crc-legacy
[329.470736] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.815s)
[330.360594] [056/131] (709s left) kms_flip (modeset-vs-vblank-race-interruptible)
[330.454435] Starting subtest: modeset-vs-vblank-race-interruptible
[330.457108] Starting dynamic subtest: A-eDP1
[335.174533] Dynamic subtest A-eDP1: SUCCESS (4.717s)
[335.186174] Starting dynamic subtest: B-eDP1
[339.776779] Dynamic subtest B-eDP1: SUCCESS (4.602s)
[339.789179] Starting dynamic subtest: C-eDP1
[344.380899] Dynamic subtest C-eDP1: SUCCESS (4.603s)
[344.391323] Starting dynamic subtest: D-eDP1
[348.902583] Dynamic subtest D-eDP1: SUCCESS (4.521s)
[348.905102] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.453s)
[350.079677] [057/131] (689s left) perf_pmu (busy-start)
[350.123610] Starting subtest: busy-start
[350.126340] Starting dynamic subtest: rcs0
[352.673553] Dynamic subtest rcs0: SUCCESS (2.551s)
[352.686689] Starting dynamic subtest: bcs0
[355.244799] Dynamic subtest bcs0: SUCCESS (2.547s)
[355.256909] Starting dynamic subtest: vcs0
[359.159126] Dynamic subtest vcs0: SUCCESS (3.932s)
[359.170814] Starting dynamic subtest: vcs1
[363.190293] Dynamic subtest vcs1: SUCCESS (4.028s)
[363.203188] Starting dynamic subtest: vecs0
[367.157962] Dynamic subtest vecs0: SUCCESS (3.964s)
[367.168830] Starting dynamic subtest: ccs0
[369.729719] Dynamic subtest ccs0: SUCCESS (2.548s)
[369.732637] Subtest busy-start: SUCCESS (19.583s)
[369.848853] [058/131] (669s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[369.951565] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[376.504065] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.552s)
[376.638616] [059/131] (662s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[376.747998] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[376.750550] Starting dynamic subtest: pipe-A-eDP-1
[392.966960] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.412s)
[392.977875] Starting dynamic subtest: pipe-B-eDP-1
[409.907894] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.349s)
[409.919096] Starting dynamic subtest: pipe-C-eDP-1
[426.885691] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.318s)
[426.895822] Starting dynamic subtest: pipe-D-eDP-1
[443.894338] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.364s)
[443.896289] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.447s)
[445.131928] [060/131] (594s left) kms_flip (2x-flip-vs-expired-vblank)
[445.237869] Starting subtest: 2x-flip-vs-expired-vblank
[445.250400] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[445.358098] [061/131] (594s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[445.472009] Starting subtest: basic-flip-before-cursor-atomic
[446.416334] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.918s)
[447.317607] [062/131] (592s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[447.412126] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[447.416316] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[447.538354] [063/131] (592s left) gem_ctx_param (basic)
[447.600318] Starting subtest: basic
[447.602703] Subtest basic: SUCCESS (0.001s)
[447.718974] [064/131] (592s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[447.826112] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[447.828268] Starting dynamic subtest: pipe-A-default-mode
[448.141674] Dynamic subtest pipe-A-default-mode: SKIP (0.307s)
[448.146106] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.308s)
[448.985654] [065/131] (590s left) gem_create (create-ext-placement-each)
[449.160427] Starting subtest: create-ext-placement-each
[449.163063] Subtest create-ext-placement-each: SUCCESS (0.000s)
[449.266535] [066/131] (590s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[449.658324] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[450.512659] [067/131] (589s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[450.615358] Starting subtest: extended-pageflip-modeset-hang-oldfb
[450.617695] Starting dynamic subtest: pipe-A
[458.593027] Dynamic subtest pipe-A: SUCCESS (7.905s)
[458.603295] Starting dynamic subtest: pipe-D
[467.248317] Dynamic subtest pipe-D: SUCCESS (8.627s)
[467.250799] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.536s)
[468.124969] [068/131] (571s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[468.178007] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[468.180317] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[468.299181] [069/131] (571s left) api_intel_bb (add-remove-objects)
[468.345957] Starting subtest: add-remove-objects
[468.350772] Subtest add-remove-objects: SUCCESS (0.006s)
[468.496680] [070/131] (571s left) gem_exec_fence (keep-in-fence)
[468.683515] Starting subtest: keep-in-fence
[468.686319] Starting dynamic subtest: rcs0
[468.777981] Dynamic subtest rcs0: SUCCESS (0.094s)
[468.790807] Starting dynamic subtest: bcs0
[468.830790] Dynamic subtest bcs0: SUCCESS (0.051s)
[468.842468] Starting dynamic subtest: vcs0
[470.650536] Dynamic subtest vcs0: SUCCESS (1.814s)
[470.663428] Starting dynamic subtest: vcs1
[472.634819] Dynamic subtest vcs1: SUCCESS (1.978s)
[472.647519] Starting dynamic subtest: vecs0
[474.737617] Dynamic subtest vecs0: SUCCESS (2.046s)
[474.750174] Starting dynamic subtest: ccs0
[474.921523] Dynamic subtest ccs0: SUCCESS (0.235s)
[474.924370] Subtest keep-in-fence: SUCCESS (6.233s)
[476.747845] [071/131] (563s left) api_intel_bb (destroy-bb)
[476.798724] Starting subtest: destroy-bb
[476.813134] Subtest destroy-bb: SUCCESS (0.013s)
[476.914395] [072/131] (563s left) kms_psr (fbc-pr-cursor-render)
[477.010684] Starting subtest: fbc-pr-cursor-render
[477.014702] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[477.092927] [073/131] (563s left) gem_softpin (safe-alignment)
[477.155997] Starting subtest: safe-alignment
[477.180781] Subtest safe-alignment: SUCCESS (0.025s)
[478.712484] [074/131] (561s left) i915_hangman (gt-engine-error)
[478.773109] Starting subtest: gt-engine-error
[478.775037] Starting dynamic subtest: rcs0
[480.664492] Dynamic subtest rcs0: SUCCESS (1.892s)
[480.676147] Starting dynamic subtest: bcs0
[482.649162] Dynamic subtest bcs0: SUCCESS (1.982s)
[482.662420] Starting dynamic subtest: vcs0
[484.631949] Dynamic subtest vcs0: SUCCESS (1.981s)
[484.645459] Starting dynamic subtest: vcs1
[486.616772] Dynamic subtest vcs1: SUCCESS (1.982s)
[486.634279] Starting dynamic subtest: vecs0
[488.663849] Dynamic subtest vecs0: SUCCESS (2.045s)
[488.677518] Starting dynamic subtest: ccs0
[490.647687] Dynamic subtest ccs0: SUCCESS (1.981s)
[490.650299] Subtest gt-engine-error: SUCCESS (11.879s)
[490.741350] [075/131] (549s left) kms_cursor_crc (cursor-onscreen-512x512)
[490.981478] Starting subtest: cursor-onscreen-512x512
[490.985874] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[491.156700] [076/131] (549s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[491.248208] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[491.250518] Starting dynamic subtest: pipe-A
[491.311587] Dynamic subtest pipe-A: SUCCESS (0.065s)
[491.323225] Starting dynamic subtest: pipe-B
[492.415560] Dynamic subtest pipe-B: SUCCESS (1.102s)
[492.427317] Starting dynamic subtest: pipe-C
[493.528264] Dynamic subtest pipe-C: SUCCESS (1.111s)
[493.540331] Starting dynamic subtest: pipe-D
[494.657898] Dynamic subtest pipe-D: SUCCESS (1.129s)
[494.660202] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.413s)
[495.842011] [077/131] (544s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[495.964878] Starting subtest: flip-vs-cursor-busy-crc-atomic
[496.766501] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.801s)
[497.577377] [078/131] (542s left) kms_dp_link_training (uhbr-sst)
[497.672056] Starting subtest: uhbr-sst
[497.681083] Subtest uhbr-sst: SKIP (0.000s)
[497.752834] [079/131] (542s left) perf (blocking-parameterized)
[497.901529] Starting subtest: blocking-parameterized
[517.924871] Subtest blocking-parameterized: SUCCESS (20.019s)
[517.976658] [080/131] (522s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[518.071942] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[518.076020] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[518.213175] [081/131] (522s left) vgem_basic (sysfs)
[518.257065] Starting subtest: sysfs
[518.259013] Subtest sysfs: SUCCESS (0.000s)
[518.326486] [082/131] (522s left) gem_ctx_persistence (engines-hostile)
[518.387188] Starting subtest: engines-hostile
[518.389567] Starting dynamic subtest: rcs0
[518.529512] Dynamic subtest rcs0: SUCCESS (0.142s)
[518.543279] Starting dynamic subtest: bcs0
[518.630490] Dynamic subtest bcs0: SUCCESS (0.099s)
[518.642368] Starting dynamic subtest: vcs0
[518.735255] Dynamic subtest vcs0: SUCCESS (0.103s)
[518.746358] Starting dynamic subtest: vcs1
[518.842111] Dynamic subtest vcs1: SUCCESS (0.105s)
[518.854580] Starting dynamic subtest: vecs0
[518.954018] Dynamic subtest vecs0: SUCCESS (0.110s)
[518.965929] Starting dynamic subtest: ccs0
[519.070778] Dynamic subtest ccs0: SUCCESS (0.115s)
[519.072960] Subtest engines-hostile: SUCCESS (0.686s)
[519.170687] [083/131] (521s left) i915_suspend (fence-restore-untiled)
[519.234605] Starting subtest: fence-restore-untiled
[519.238313] Subtest fence-restore-untiled: SKIP (0.000s)
[519.356457] [084/131] (521s left) syncobj_wait (invalid-reset-illegal-handle)
[519.408719] Starting subtest: invalid-reset-illegal-handle
[519.410577] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[519.526736] [085/131] (521s left) gem_readwrite (write-bad-handle)
[519.590033] Subtest write-bad-handle: SKIP (0.000s)
[519.661944] [086/131] (520s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[519.722904] Subtest no-spare-fences-busy: SKIP (0.000s)
[519.803601] [087/131] (520s left) gem_ctx_persistence (heartbeat-close)
[519.864396] Starting subtest: heartbeat-close
[519.868384] Subtest heartbeat-close: SKIP (0.000s)
[519.997798] [088/131] (520s left) kms_cursor_crc (cursor-onscreen-256x256)
[520.208691] Starting subtest: cursor-onscreen-256x256
[520.212975] Starting dynamic subtest: pipe-A-eDP-1
[522.315282] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s)
[522.344998] Starting dynamic subtest: pipe-D-eDP-1
[525.148981] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.810s)
[525.150963] Subtest cursor-onscreen-256x256: SUCCESS (4.937s)
[526.047719] [089/131] (514s left) gem_ringfill (engines-basic)
[531.646288] Starting subtest: engines-basic
[531.648923] Starting dynamic subtest: rcs0
[531.697801] Dynamic subtest rcs0: SUCCESS (0.051s)
[531.707727] Starting dynamic subtest: bcs0
[531.740566] Dynamic subtest bcs0: SUCCESS (0.041s)
[531.751639] Starting dynamic subtest: vcs0
[531.784625] Dynamic subtest vcs0: SUCCESS (0.042s)
[531.795626] Starting dynamic subtest: vcs1
[531.828476] Dynamic subtest vcs1: SUCCESS (0.042s)
[531.839310] Starting dynamic subtest: vecs0
[531.870666] Dynamic subtest vecs0: SUCCESS (0.040s)
[531.881280] Starting dynamic subtest: ccs0
[531.916603] Dynamic subtest ccs0: SUCCESS (0.044s)
[531.918952] Subtest engines-basic: SUCCESS (0.272s)
[532.015958] [090/131] (508s left) kms_pm_rpm (cursor)
[533.844461] Starting subtest: cursor
[533.849709] Subtest cursor: SKIP (0.000s)
[534.296500] [091/131] (506s left) gem_pread (bench)
[534.354114] Subtest bench: SKIP (0.000s)
[534.415842] [092/131] (506s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[534.509804] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[538.065980] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.559s)
[539.283370] [093/131] (501s left) gem_exec_schedule (submit-golden-slice)
[539.356457] Starting subtest: submit-golden-slice
[539.358535] Starting dynamic subtest: rcs0
[539.385913] Dynamic subtest rcs0: SUCCESS (0.040s)
[539.395995] Starting dynamic subtest: bcs0
[539.420964] Dynamic subtest bcs0: SUCCESS (0.034s)
[539.436754] Starting dynamic subtest: vcs0
[539.461419] Dynamic subtest vcs0: SUCCESS (0.039s)
[539.474979] Starting dynamic subtest: vcs1
[539.491779] Dynamic subtest vcs1: SUCCESS (0.029s)
[539.501701] Starting dynamic subtest: vecs0
[539.522636] Dynamic subtest vecs0: SUCCESS (0.030s)
[539.535195] Starting dynamic subtest: ccs0
[539.554643] Dynamic subtest ccs0: SUCCESS (0.031s)
[539.556910] Subtest submit-golden-slice: SUCCESS (0.210s)
[540.783671] [094/131] (500s left) gem_exec_schedule (preempt-contexts)
[540.866305] Starting subtest: preempt-contexts
[540.868628] Starting dynamic subtest: rcs0
[540.914101] Dynamic subtest rcs0: SUCCESS (0.057s)
[540.924615] Starting dynamic subtest: bcs0
[540.966288] Dynamic subtest bcs0: SUCCESS (0.052s)
[540.976356] Starting dynamic subtest: vcs0
[541.011233] Dynamic subtest vcs0: SUCCESS (0.044s)
[541.021144] Starting dynamic subtest: vcs1
[541.055488] Dynamic subtest vcs1: SUCCESS (0.043s)
[541.065356] Starting dynamic subtest: vecs0
[541.094105] Dynamic subtest vecs0: SUCCESS (0.039s)
[541.104213] Starting dynamic subtest: ccs0
[541.139897] Dynamic subtest ccs0: SUCCESS (0.046s)
[541.142174] Subtest preempt-contexts: SUCCESS (0.284s)
[542.787214] [095/131] (498s left) kms_frontbuffer_tracking (psr-suspend)
[542.889106] Starting subtest: psr-suspend
[581.031871] Subtest psr-suspend: SUCCESS (7.578s)
[581.138390] [096/131] (459s left) gem_exec_capture (capture-invisible)
[581.203690] Starting subtest: capture-invisible
[581.206692] Starting dynamic subtest: smem0
[581.211970] Dynamic subtest smem0: SKIP (0.000s)
[581.216678] Subtest capture-invisible: SKIP (0.001s)
[581.321921] [097/131] (459s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[581.414557] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[581.417149] Starting dynamic subtest: pipe-A-eDP-1
[581.438765] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[581.449963] Starting dynamic subtest: pipe-B-eDP-1
[581.473132] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.024s)
[581.483508] Starting dynamic subtest: pipe-C-eDP-1
[581.508461] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[581.518680] Starting dynamic subtest: pipe-D-eDP-1
[581.544294] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[581.546698] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.095s)
[583.782172] [098/131] (457s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[583.883479] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[584.940419] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.033s)
[585.103868] [099/131] (456s left) kms_big_fb (linear-64bpp-rotate-90)
[585.212439] Starting subtest: linear-64bpp-rotate-90
[585.232544] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[585.370970] [100/131] (455s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[585.474710] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[592.188458] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.631s)
[592.336662] [101/131] (448s left) kms_content_protection (dp-mst-suspend-resume)
[592.471530] Starting subtest: dp-mst-suspend-resume
[592.477192] Subtest dp-mst-suspend-resume: SKIP (0.000s)
[592.629277] [102/131] (448s left) kms_atomic (plane-primary-legacy)
[592.723248] Starting subtest: plane-primary-legacy
[592.725925] Starting dynamic subtest: pipe-A-eDP-1
[593.171184] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[593.173932] Subtest plane-primary-legacy: SUCCESS (0.447s)
[593.983118] [103/131] (447s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[594.034340] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[594.037135] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[594.150160] [104/131] (447s left) gem_userptr_blits (unsync-unmap-after-close)
[594.216502] Subtest unsync-unmap-after-close: SKIP (0.000s)
[594.377315] [105/131] (447s left) drm_read (empty-nonblock)
[594.511314] Starting subtest: empty-nonblock
[594.514207] Subtest empty-nonblock: SUCCESS (0.000s)
[594.649564] [106/131] (446s left) gem_eio (suspend)
[594.892036] Starting subtest: suspend
[606.858863] Subtest suspend: SUCCESS (11.928s)
[607.025574] [107/131] (434s left) kms_psr (pr-primary-render)
[607.124497] Starting subtest: pr-primary-render
[607.129361] Subtest pr-primary-render: SKIP (0.000s)
[607.220939] [108/131] (434s left) kms_vblank (ts-continuation-suspend)
[607.318481] Starting subtest: ts-continuation-suspend
[607.321123] Starting dynamic subtest: pipe-A-eDP-1
[623.022650] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.471s)
[623.037208] Starting dynamic subtest: pipe-D-eDP-1
[640.002938] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.127s)
[640.005452] Subtest ts-continuation-suspend: SUCCESS (3.602s)
[640.906314] [109/131] (400s left) kms_flip (2x-nonexisting-fb-interruptible)
[641.017466] Starting subtest: 2x-nonexisting-fb-interruptible
[641.029453] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[641.119931] [110/131] (400s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[641.222190] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[648.211041] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.858s)
[648.372924] [111/131] (393s left) kms_invalid_mode (uint-max-clock)
[648.483115] Starting subtest: uint-max-clock
[648.485510] Starting dynamic subtest: pipe-A-eDP-1
[648.764707] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[648.776007] Starting dynamic subtest: pipe-B-eDP-1
[648.777934] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[648.787831] Starting dynamic subtest: pipe-C-eDP-1
[648.789998] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[648.799767] Starting dynamic subtest: pipe-D-eDP-1
[648.802020] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[648.804289] Subtest uint-max-clock: SUCCESS (0.292s)
[649.638337] [112/131] (392s left) kms_properties (get_properties-sanity-non-atomic)
[649.738151] Starting subtest: get_properties-sanity-non-atomic
[649.740565] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[649.838150] [113/131] (391s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[651.366654] Starting subtest: modeset-non-lpsp-stress-no-wait
[651.415918] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.048s)
[652.111526] [114/131] (389s left) kms_flip (flip-vs-absolute-wf_vblank)
[652.206331] Starting subtest: flip-vs-absolute-wf_vblank
[652.208693] Starting dynamic subtest: A-eDP1
[661.178895] Dynamic subtest A-eDP1: SUCCESS (8.933s)
[661.188606] Starting dynamic subtest: B-eDP1
[670.121443] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[670.132770] Starting dynamic subtest: C-eDP1
[679.091157] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[679.104005] Starting dynamic subtest: D-eDP1
[688.021770] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[688.023929] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.722s)
[689.227637] [115/131] (352s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[689.292610] Starting subtest: basic-batch-kernel-default-cmd
[689.296954] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[689.488980] [116/131] (352s left) gem_exec_whisper (basic-fds-all)
[689.555609] Starting subtest: basic-fds-all
[700.831583] Subtest basic-fds-all: SUCCESS (11.271s)
[701.038401] [117/131] (340s left) kms_properties (invalid-properties-atomic)
[701.133494] Starting subtest: invalid-properties-atomic
[701.441056] Subtest invalid-properties-atomic: SUCCESS (0.307s)
[701.528406] [118/131] (340s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[701.623957] Starting subtest: plane-scaler-unity-scaling-with-rotation
[701.626351] Starting dynamic subtest: pipe-A
[701.850325] Dynamic subtest pipe-A: SUCCESS (0.228s)
[701.860569] Starting dynamic subtest: pipe-B
[703.208318] Dynamic subtest pipe-B: SUCCESS (1.357s)
[703.218758] Starting dynamic subtest: pipe-C
[704.518975] Dynamic subtest pipe-C: SUCCESS (1.310s)
[704.530064] Starting dynamic subtest: pipe-D
[705.846675] Dynamic subtest pipe-D: SUCCESS (1.327s)
[705.849013] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.224s)
[707.037642] [119/131] (334s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[707.100378] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[707.200480] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[707.305602] [120/131] (334s left) syncobj_basic (bad-pad-handle-to-fd)
[707.355849] Starting subtest: bad-pad-handle-to-fd
[707.357992] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[707.471263] [121/131] (334s left) kms_chamelium_hpd (dp-hpd)
[707.859191] Subtest dp-hpd: SKIP (0.000s)
[708.637439] [122/131] (333s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[708.746949] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[709.125216] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[710.556394] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: FAIL (0.840s)
[710.568857] Starting dynamic subtest: pipe-A-eDP-1-4
[710.977206] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.654s)
[710.988616] Starting dynamic subtest: pipe-A-eDP-1-4
[711.148326] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.017s)
[711.160028] Starting dynamic subtest: pipe-A-eDP-1-x
[711.502726] Dynamic subtest pipe-A-eDP-1-x: FAIL (0.592s)
[711.616907] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[712.978544] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: FAIL (1.159s)
[712.990604] Starting dynamic subtest: pipe-B-eDP-1-4
[713.403439] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.179s)
[713.415272] Starting dynamic subtest: pipe-B-eDP-1-4
[713.575399] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.483s)
[713.586982] Starting dynamic subtest: pipe-B-eDP-1-x
[713.954736] Dynamic subtest pipe-B-eDP-1-x: FAIL (0.175s)
[713.984673] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[716.785661] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[716.800174] Starting dynamic subtest: pipe-C-eDP-1-4
[718.950440] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s)
[718.963532] Starting dynamic subtest: pipe-C-eDP-1-4
[720.960742] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[720.973492] Starting dynamic subtest: pipe-C-eDP-1-x
[723.129221] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.167s)
[723.493687] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[726.225242] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.738s)
[726.235395] Starting dynamic subtest: pipe-D-eDP-1-4
[728.401047] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[728.411306] Starting dynamic subtest: pipe-D-eDP-1-4
[730.411888] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[730.422126] Starting dynamic subtest: pipe-D-eDP-1-x
[732.592618] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[732.595343] Subtest async-flip-with-page-flip-events-tiled-atomic: FAIL (23.839s)
[733.832060] [123/131] (308s left) i915_drm_fdinfo (most-busy-check-all)
[733.870535] Starting subtest: most-busy-check-all
[733.872791] Starting dynamic subtest: rcs0
[733.877300] Dynamic subtest rcs0: SKIP (0.004s)
[733.889335] Starting dynamic subtest: bcs0
[733.893435] Dynamic subtest bcs0: SKIP (0.000s)
[733.903230] Starting dynamic subtest: vcs0
[733.907465] Dynamic subtest vcs0: SKIP (0.000s)
[733.916895] Starting dynamic subtest: vcs1
[733.920891] Dynamic subtest vcs1: SKIP (0.000s)
[733.930172] Starting dynamic subtest: vecs0
[733.934125] Dynamic subtest vecs0: SKIP (0.000s)
[733.943766] Starting dynamic subtest: ccs0
[733.947741] Dynamic subtest ccs0: SKIP (0.000s)
[733.951925] Subtest most-busy-check-all: SKIP (0.009s)
[733.990173] [124/131] (308s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[734.116103] Starting subtest: fb-8bpc-vs-panel-6bpc
[734.118285] Starting dynamic subtest: pipe-A-eDP-1
[735.483810] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.366s)
[735.485777] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.367s)
[736.308353] [125/131] (305s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[736.428361] Starting subtest: cursorB-vs-flipA-atomic-transitions
[736.432859] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[736.583220] [126/131] (305s left) gem_set_tiling_vs_pwrite
[736.708406] [127/131] (305s left) gem_mmap (bad-object)
[736.762985] Subtest bad-object: SKIP (0.000s)
[736.829445] [128/131] (305s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[736.930661] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[736.934815] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[737.054195] [129/131] (305s left) syncobj_wait (multi-wait-for-submit-submitted)
[737.110150] Starting subtest: multi-wait-for-submit-submitted
[737.218113] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[737.307996] [130/131] (305s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[737.396494] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[737.400887] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[737.528858] [131/131] (304s left) gem_mmap_offset (isolation)
[737.578856] Starting subtest: isolation
[737.596202] Subtest isolation: SUCCESS (0.006s)
[737.710133] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_properties
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: gem_exec_alignment
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_fence_thrash
results: parsing output: 16/ for test: fbdev
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_psr_stress_test
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_getfb
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_chamelium_audio
results: parsing output: 33/ for test: sysfs_timeslice_duration
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: gem_exercise_blt
results: parsing output: 36/ for test: kms_plane_multiple
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: i915_pm_rpm
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_flush
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_pipe_crc_basic
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_watchdog
results: parsing output: 50/ for test: gem_fence_thrash
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_universal_plane
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: gem_create
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_busy
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: i915_hangman
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_dp_link_training
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: vgem_basic
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: i915_suspend
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: gem_readwrite
results: parsing output: 85/ for test: gem_fenced_exec_thrash
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: gem_ringfill
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: gem_pread
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_capture
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_content_protection
results: parsing output: 101/ for test: kms_atomic
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: drm_read
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_vblank
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_invalid_mode
results: parsing output: 111/ for test: kms_properties
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gem_exec_flush
results: parsing output: 115/ for test: gem_exec_whisper
results: parsing output: 116/ for test: kms_properties
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: syncobj_basic
results: parsing output: 120/ for test: kms_chamelium_hpd
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_dither
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 126/ for test: gem_mmap
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_mmap_offset
Done.