[78.744780] Initializing watchdogs
[78.744848]   /dev/watchdog0
[78.765773] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[78.777386] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[78.781647] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[78.783976] [001/154] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[78.972532] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[78.974248] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[79.128795] [002/154] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[79.317751] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[79.319450] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[79.492190] [003/154] (959s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[79.680499] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[79.682304] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[79.855835] [004/154] (959s left) kms_chamelium_hpd (hdmi-hpd)
[80.134260] Subtest hdmi-hpd: SKIP (0.000s)
[80.327975] [005/154] (959s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[80.404964] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[80.407383] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[80.635668] [006/154] (959s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[80.817595] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[80.818432] Starting dynamic subtest: pipe-A
[80.920487] Dynamic subtest pipe-A: SUCCESS (0.103s)
[80.936127] Starting dynamic subtest: pipe-B
[81.168461] Dynamic subtest pipe-B: SUCCESS (0.247s)
[81.185782] Starting dynamic subtest: pipe-C
[81.391635] Dynamic subtest pipe-C: SUCCESS (0.230s)
[81.404237] Starting dynamic subtest: pipe-D
[81.627838] Dynamic subtest pipe-D: SUCCESS (0.247s)
[81.628600] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.829s)
[81.920965] [007/154] (957s left) kms_cursor_edge_walk (64x64-left-edge)
[82.095583] Starting subtest: 64x64-left-edge
[82.097363] Starting dynamic subtest: pipe-A-DP-3
[85.471202] Dynamic subtest pipe-A-DP-3: SUCCESS (3.499s)
[85.484597] Starting dynamic subtest: pipe-D-DP-3
[88.743654] Dynamic subtest pipe-D-DP-3: SUCCESS (3.347s)
[88.744639] Subtest 64x64-left-edge: SUCCESS (6.848s)
[89.014093] [008/154] (950s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[89.204581] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[89.946236] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (0.753s)
[90.213423] [009/154] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[90.394503] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[90.396224] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[90.591082] [010/154] (949s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[90.669493] Starting subtest: yf-tiled-to-vebox-y-tiled
[90.671367] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[90.954853] [011/154] (949s left) api_intel_bb (add-remove-objects)
[91.024935] Starting subtest: add-remove-objects
[91.059071] Subtest add-remove-objects: SUCCESS (0.035s)
[91.245829] [012/154] (948s left) kms_color (ctm-negative)
[91.428463] Starting subtest: ctm-negative
[91.429361] Starting dynamic subtest: pipe-A-DP-3
[92.324391] Dynamic subtest pipe-A-DP-3: SUCCESS (0.906s)
[92.336501] Starting dynamic subtest: pipe-B-DP-3
[92.957853] Dynamic subtest pipe-B-DP-3: SUCCESS (0.639s)
[92.971810] Starting dynamic subtest: pipe-C-DP-3
[93.535536] Dynamic subtest pipe-C-DP-3: SUCCESS (0.583s)
[93.550492] Starting dynamic subtest: pipe-D-DP-3
[94.149655] Dynamic subtest pipe-D-DP-3: SUCCESS (0.620s)
[94.150654] Subtest ctm-negative: SUCCESS (2.750s)
[94.454485] [013/154] (945s left) kms_psr (pr-cursor-plane-onoff)
[94.635869] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[94.689529] [014/154] (945s left) gem_userptr_blits (stress-mm)
[94.780360] Starting subtest: stress-mm
[100.118062] Subtest stress-mm: SUCCESS (5.369s)
[100.344555] [015/154] (940s left) gem_exec_params (secure-non-root)
[100.426254] Starting subtest: secure-non-root
[100.428136] Subtest secure-non-root: SKIP (0.000s)
[100.623661] [016/154] (939s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[100.806474] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[100.808298] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[100.897651] [017/154] (939s left) drm_read (empty-block)
[101.147825] Starting subtest: empty-block
[102.149506] Subtest empty-block: SUCCESS (1.004s)
[102.323586] [018/154] (938s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[102.505153] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[113.453409] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.965s)
[113.735645] [019/154] (926s left) gem_exec_fence (basic-busy)
[113.940362] Starting subtest: basic-busy
[113.941382] Starting dynamic subtest: rcs0
[114.048902] Dynamic subtest rcs0: SUCCESS (0.113s)
[114.073517] Starting dynamic subtest: bcs0
[114.104682] Dynamic subtest bcs0: SUCCESS (0.054s)
[114.144458] Starting dynamic subtest: vcs0
[114.164849] Dynamic subtest vcs0: SUCCESS (0.058s)
[114.180959] Starting dynamic subtest: vcs1
[114.219192] Dynamic subtest vcs1: SUCCESS (0.053s)
[114.252365] Starting dynamic subtest: vecs0
[114.274493] Dynamic subtest vecs0: SUCCESS (0.054s)
[114.290636] Starting dynamic subtest: vecs1
[114.328110] Dynamic subtest vecs1: SUCCESS (0.052s)
[114.362204] Starting dynamic subtest: ccs0
[114.386581] Dynamic subtest ccs0: SUCCESS (0.057s)
[114.387829] Subtest basic-busy: SUCCESS (0.451s)
[115.140182] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[115.142555] [020/154] (925s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[115.331676] Starting subtest: bo-too-small-due-to-tiling
[115.333426] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[115.480751] [021/154] (925s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[115.692302] Starting subtest: yf-tiled-32bpp-rotate-90
[115.694140] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[115.859446] [022/154] (925s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[116.052389] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[116.053323] Starting dynamic subtest: pipe-A-DP-3
[116.061066] Dynamic subtest pipe-A-DP-3: SUCCESS (0.001s)
[116.070631] Starting dynamic subtest: pipe-B-DP-3
[116.078273] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[116.087553] Starting dynamic subtest: pipe-C-DP-3
[116.095289] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[116.104537] Starting dynamic subtest: pipe-D-DP-3
[116.112331] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[116.113544] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SUCCESS (0.010s)
[116.535978] [023/154] (924s left) gem_exec_fence (syncobj-repeat)
[117.113106] Starting subtest: syncobj-repeat
[117.449558] Subtest syncobj-repeat: SUCCESS (0.336s)
[117.847220] [024/154] (923s left) kms_content_protection (lic-type-0-hdcp14)
[118.104487] Starting subtest: lic-type-0-hdcp14
[118.131442] Starting dynamic subtest: pipe-A-DP-3
[240.589240] Dynamic subtest pipe-A-DP-3: FAIL (122.283s)
[240.590263] Subtest lic-type-0-hdcp14: FAIL (122.403s)
[240.827139] [025/154] (800s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[241.019545] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[241.020358] Starting dynamic subtest: pipe-A
[242.999877] Dynamic subtest pipe-A: SUCCESS (1.980s)
[243.024751] Starting dynamic subtest: pipe-B
[245.079861] Dynamic subtest pipe-B: SUCCESS (2.078s)
[245.102606] Starting dynamic subtest: pipe-C
[245.409606] Dynamic subtest pipe-C: SUCCESS (0.328s)
[245.426332] Starting dynamic subtest: pipe-D
[245.741071] Dynamic subtest pipe-D: SUCCESS (0.330s)
[245.742317] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.722s)
[246.109325] [026/154] (795s left) i915_hangman (engine-engine-error)
[246.208439] Starting subtest: engine-engine-error
[246.209434] Starting dynamic subtest: rcs0
[247.049625] Dynamic subtest rcs0: SUCCESS (0.841s)
[247.064525] Starting dynamic subtest: bcs0
[247.776721] Dynamic subtest bcs0: SUCCESS (0.726s)
[247.786904] Starting dynamic subtest: vcs0
[248.545371] Dynamic subtest vcs0: SUCCESS (0.768s)
[248.556317] Starting dynamic subtest: vcs1
[249.257645] Dynamic subtest vcs1: SUCCESS (0.711s)
[249.268572] Starting dynamic subtest: vecs0
[249.972373] Dynamic subtest vecs0: SUCCESS (0.714s)
[249.982739] Starting dynamic subtest: vecs1
[250.732291] Dynamic subtest vecs1: SUCCESS (0.759s)
[250.743307] Starting dynamic subtest: ccs0
[251.482240] Dynamic subtest ccs0: SUCCESS (0.749s)
[251.483174] Subtest engine-engine-error: SUCCESS (5.275s)
[251.657917] [027/154] (789s left) perf_pmu (gt-awake)
[251.732058] Starting subtest: gt-awake
[256.124923] Subtest gt-awake: SUCCESS (4.393s)
[256.264549] [028/154] (785s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[256.463961] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[256.465792] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[256.655747] [029/154] (784s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[256.851477] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[256.853919] Starting dynamic subtest: pipe-A-DP-3
[256.862469] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[256.873466] Starting dynamic subtest: pipe-B-DP-3
[256.881962] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[256.892596] Starting dynamic subtest: pipe-C-DP-3
[256.901016] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[256.911921] Starting dynamic subtest: pipe-D-DP-3
[256.922204] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[256.924015] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.006s)
[257.340156] [030/154] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[257.535085] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[257.536824] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[257.678944] [031/154] (783s left) syncobj_wait (invalid-reset-bad-pad)
[257.758448] Starting subtest: invalid-reset-bad-pad
[257.759436] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[257.901836] [032/154] (783s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[258.100781] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[258.102429] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[258.248350] [033/154] (783s left) kms_vblank (ts-continuation-modeset-rpm)
[258.441191] Starting subtest: ts-continuation-modeset-rpm
[258.442162] Starting dynamic subtest: pipe-A-DP-3
[260.380592] Dynamic subtest pipe-A-DP-3: SUCCESS (1.938s)
[260.400194] Starting dynamic subtest: pipe-D-DP-3
[261.284267] Dynamic subtest pipe-D-DP-3: SUCCESS (0.900s)
[261.285231] Subtest ts-continuation-modeset-rpm: SUCCESS (2.844s)
[261.576921] [034/154] (780s left) perf_pmu (invalid-init)
[261.651253] Starting subtest: invalid-init
[261.652205] Subtest invalid-init: SUCCESS (0.000s)
[261.811803] [035/154] (780s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[262.015035] Starting subtest: 4-tiled-16bpp-rotate-180
[263.804029] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.789s)
[264.009697] [036/154] (778s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-pwrite)
[264.203251] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-pwrite
[264.707061] Subtest fbchdr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (0.504s)
[264.909828] [037/154] (777s left) gem_exec_balancer (full-late-pulse)
[265.004364] Starting subtest: full-late-pulse
[267.145235] Subtest full-late-pulse: SUCCESS (2.141s)
[267.563182] [038/154] (774s left) gem_userptr_blits (map-fixed-invalidate)
[267.657070] Starting subtest: map-fixed-invalidate
[267.658918] Subtest map-fixed-invalidate: SKIP (0.000s)
[267.802812] [039/154] (774s left) gem_readwrite (read-bad-handle)
[267.884149] Subtest read-bad-handle: SKIP (0.000s)
[267.950918] [040/154] (774s left) kms_joiner (basic-big-joiner)
[268.153319] Starting subtest: basic-big-joiner
[268.155392] Subtest basic-big-joiner: SKIP (0.000s)
[268.239057] [041/154] (774s left) prime_mmap (test_reprime)
[268.321915] Starting subtest: test_reprime
[268.322855] Starting dynamic subtest: test_reprime-smem
[268.374193] Dynamic subtest test_reprime-smem: SUCCESS (0.052s)
[268.385379] Starting dynamic subtest: test_reprime-lmem0
[268.580357] Dynamic subtest test_reprime-lmem0: SUCCESS (0.205s)
[268.581431] Subtest test_reprime: SUCCESS (0.259s)
[268.696856] [042/154] (773s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[268.899348] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[268.901175] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[269.028285] [043/154] (773s left) gem_softpin (allocator-fork)
[269.115544] Starting subtest: allocator-fork
[271.415680] Subtest allocator-fork: SUCCESS (2.300s)
[271.604929] [044/154] (770s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[271.801234] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[271.802996] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[271.954076] [045/154] (770s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[272.157976] Starting subtest: 4-tiled-64bpp-rotate-0
[274.390840] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (2.232s)
[274.563802] [046/154] (768s left) syncobj_eventfd (timeline-wait)
[274.645303] Starting subtest: timeline-wait
[274.656054] Subtest timeline-wait: SUCCESS (0.011s)
[274.846542] [047/154] (767s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[277.457897] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[277.460173] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[277.609853] [048/154] (765s left) perf (global-sseu-config-invalid)
[277.984542] Starting subtest: global-sseu-config-invalid
[277.986239] Subtest global-sseu-config-invalid: SKIP (0.000s)
[278.039899] [049/154] (764s left) kms_rotation_crc (sprite-rotation-270)
[278.235592] Starting subtest: sprite-rotation-270
[278.237405] Subtest sprite-rotation-270: SKIP (0.001s)
[278.329072] [050/154] (764s left) kms_fbcon_fbt (psr-suspend)
[278.413367] Starting subtest: psr-suspend
[278.415201] Subtest psr-suspend: SKIP (0.000s)
[278.599540] [051/154] (764s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[278.790463] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[278.824060] Starting dynamic subtest: pipe-A-plane-0
[279.290748] Dynamic subtest pipe-A-plane-0: SUCCESS (0.466s)
[279.332187] Starting dynamic subtest: pipe-A-plane-3
[279.623583] Dynamic subtest pipe-A-plane-3: SUCCESS (0.331s)
[279.904800] Starting dynamic subtest: pipe-B-plane-0
[280.276319] Dynamic subtest pipe-B-plane-0: SUCCESS (0.399s)
[280.320933] Starting dynamic subtest: pipe-B-plane-3
[280.609091] Dynamic subtest pipe-B-plane-3: SUCCESS (0.329s)
[280.749660] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SUCCESS (1.960s)
[281.009696] [052/154] (762s left) drm_read (fault-buffer)
[281.272514] Starting subtest: fault-buffer
[281.273842] Subtest fault-buffer: SUCCESS (0.003s)
[281.510083] [053/154] (761s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[281.706165] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[282.253964] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (0.548s)
[282.464908] [054/154] (760s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary)
[282.662254] Starting subtest: fbcpsrhdr-shrfb-scaledprimary
[282.663944] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s)
[282.801900] [055/154] (760s left) kms_hdr (bpc-switch)
[282.993884] Starting subtest: bpc-switch
[282.996400] Starting dynamic subtest: pipe-A-DP-3-XRGB2101010
[287.923325] Dynamic subtest pipe-A-DP-3-XRGB2101010: SUCCESS (4.927s)
[287.964531] Starting dynamic subtest: pipe-A-DP-3-XRGB16161616F
[292.578773] Dynamic subtest pipe-A-DP-3-XRGB16161616F: SUCCESS (4.647s)
[292.585245] Subtest bpc-switch: SUCCESS (9.588s)
[292.965406] [056/154] (750s left) sysfs_heartbeat_interval (precise)
[293.055478] Starting subtest: precise
[293.056409] Starting dynamic subtest: vecs0
[296.112357] Dynamic subtest vecs0: SUCCESS (3.057s)
[296.125201] Starting dynamic subtest: ccs0
[299.125719] Dynamic subtest ccs0: SUCCESS (3.012s)
[299.139545] Starting dynamic subtest: vcs0
[300.548130] Dynamic subtest vcs0: SUCCESS (1.421s)
[300.561871] Starting dynamic subtest: bcs0
[301.949117] Dynamic subtest bcs0: SUCCESS (1.399s)
[301.961532] Starting dynamic subtest: vecs1
[303.382737] Dynamic subtest vecs1: SUCCESS (1.431s)
[303.394702] Starting dynamic subtest: rcs0
[304.781367] Dynamic subtest rcs0: SUCCESS (1.399s)
[304.795050] Starting dynamic subtest: vcs1
[306.157204] Dynamic subtest vcs1: SUCCESS (1.374s)
[306.158163] Subtest precise: SUCCESS (13.103s)
[306.282621] [057/154] (737s left) kms_big_fb (linear-64bpp-rotate-0)
[306.488520] Starting subtest: linear-64bpp-rotate-0
[308.675369] Subtest linear-64bpp-rotate-0: SUCCESS (2.186s)
[308.914795] [058/154] (734s left) kms_psr (fbc-psr-primary-page-flip)
[309.109461] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[309.172386] [059/154] (734s left) i915_drm_fdinfo (most-busy-check-all)
[309.246959] Starting subtest: most-busy-check-all
[309.247914] Starting dynamic subtest: rcs0
[309.277227] Dynamic subtest rcs0: SKIP (0.029s)
[309.289513] Starting dynamic subtest: bcs0
[309.291296] Dynamic subtest bcs0: SKIP (0.000s)
[309.303639] Starting dynamic subtest: vcs0
[309.306012] Dynamic subtest vcs0: SKIP (0.000s)
[309.318262] Starting dynamic subtest: vcs1
[309.320649] Dynamic subtest vcs1: SKIP (0.000s)
[309.333535] Starting dynamic subtest: vecs0
[309.335564] Dynamic subtest vecs0: SKIP (0.000s)
[309.347132] Starting dynamic subtest: vecs1
[309.349110] Dynamic subtest vecs1: SKIP (0.000s)
[309.360762] Starting dynamic subtest: ccs0
[309.363070] Dynamic subtest ccs0: SKIP (0.000s)
[309.365535] Subtest most-busy-check-all: SKIP (0.039s)
[309.414115] [060/154] (734s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[309.654306] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[309.656087] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[309.808027] [061/154] (733s left) kms_pm_rpm (cursor)
[312.055291] Starting subtest: cursor
[312.057572] Subtest cursor: SKIP (0.000s)
[312.465904] [062/154] (731s left) syncobj_timeline (wait-for-submit-complex)
[312.544572] Starting subtest: wait-for-submit-complex
[312.607567] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[312.747438] [063/154] (731s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[312.939357] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[312.997715] [064/154] (730s left) i915_pm_rpm (gem-pread)
[315.009751] Starting subtest: gem-pread
[315.777219] Subtest gem-pread: SUCCESS (0.767s)
[316.090970] [065/154] (727s left) kms_async_flips (alternate-sync-async-flip-atomic)
[316.282868] Starting subtest: alternate-sync-async-flip-atomic
[316.516046] Starting dynamic subtest: pipe-A-DP-3
[318.834852] Dynamic subtest pipe-A-DP-3: SUCCESS (2.319s)
[319.076682] Starting dynamic subtest: pipe-B-DP-3
[321.193596] Dynamic subtest pipe-B-DP-3: SUCCESS (2.129s)
[321.408048] Starting dynamic subtest: pipe-C-DP-3
[323.525139] Dynamic subtest pipe-C-DP-3: SUCCESS (2.128s)
[323.752459] Starting dynamic subtest: pipe-D-DP-3
[325.870292] Dynamic subtest pipe-D-DP-3: SUCCESS (2.129s)
[325.875614] Subtest alternate-sync-async-flip-atomic: SUCCESS (9.590s)
[326.382499] [066/154] (717s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[326.580505] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[326.582225] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[326.711413] [067/154] (717s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[326.910280] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[326.912094] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[327.072381] [068/154] (717s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[327.152553] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[327.153475] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[327.316620] [069/154] (717s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[327.508485] Starting subtest: primary-yf-tiled-reflect-x-0
[327.605700] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.097s)
[327.770207] [070/154] (716s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[327.966471] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[327.968262] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[328.120998] [071/154] (716s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[328.330464] Starting subtest: x-tiled-32bpp-rotate-180
[330.222943] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.891s)
[330.380467] [072/154] (714s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[330.573456] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[330.574328] Starting dynamic subtest: pipe-A-DP-3
[330.582675] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[330.594568] Starting dynamic subtest: pipe-B-DP-3
[330.603186] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[330.614961] Starting dynamic subtest: pipe-C-DP-3
[330.623241] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[330.635061] Starting dynamic subtest: pipe-D-DP-3
[330.645529] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[330.647526] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s)
[331.074904] [073/154] (713s left) gem_exec_await (wide-all)
[331.391493] Starting subtest: wide-all
[353.696485] Subtest wide-all: SUCCESS (22.305s)
[353.929301] [074/154] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[354.177276] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[354.179034] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[354.307991] [075/154] (690s left) kms_plane (pixel-format-yf-tiled-modifier)
[354.508321] Starting subtest: pixel-format-yf-tiled-modifier
[354.510137] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[354.605317] [076/154] (690s left) api_intel_bb (intel-bb-blit-none)
[354.683561] Starting subtest: intel-bb-blit-none
[355.371167] Subtest intel-bb-blit-none: SUCCESS (0.687s)
[355.511371] [077/154] (689s left) kms_fence_pin_leak
[355.781721] [078/154] (689s left) kms_busy (basic)
[355.983036] Starting subtest: basic
[355.985323] Starting dynamic subtest: flip
[356.664300] Dynamic subtest flip: SUCCESS (0.680s)
[356.689396] Starting dynamic subtest: modeset
[357.727076] Dynamic subtest modeset: SUCCESS (1.060s)
[357.728415] Subtest basic: SUCCESS (1.744s)
[358.046935] [079/154] (687s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[358.243298] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[358.245115] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[358.451755] [080/154] (686s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[358.654314] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[358.656161] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[358.834519] [081/154] (686s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[359.026229] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[359.089434] [082/154] (686s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render)
[359.285499] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render
[359.287248] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[359.409851] [083/154] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[359.607989] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[359.609758] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[359.756995] [084/154] (685s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-blt)
[359.955159] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-blt
[359.956988] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[360.112451] [085/154] (685s left) intel_hwmon (hwmon-read)
[360.200677] Starting subtest: hwmon-read
[360.203257] Subtest hwmon-read: SUCCESS (0.001s)
[360.334075] [086/154] (685s left) core_setmaster_vs_auth
[360.650911] [087/154] (685s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[360.848277] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[360.850159] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[361.052566] [088/154] (684s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[361.135299] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[361.207533] [089/154] (684s left) kms_sequence (get-forked-busy)
[361.394983] Starting subtest: get-forked-busy
[361.397443] Starting dynamic subtest: pipe-A-DP-3
[364.086556] Dynamic subtest pipe-A-DP-3: SUCCESS (2.689s)
[364.107062] Starting dynamic subtest: pipe-B-DP-3
[366.664131] Dynamic subtest pipe-B-DP-3: SUCCESS (2.573s)
[366.698962] Starting dynamic subtest: pipe-C-DP-3
[369.258078] Dynamic subtest pipe-C-DP-3: SUCCESS (2.589s)
[369.291867] Starting dynamic subtest: pipe-D-DP-3
[371.876076] Dynamic subtest pipe-D-DP-3: SUCCESS (2.613s)
[371.877219] Subtest get-forked-busy: SUCCESS (10.480s)
[372.159419] [090/154] (673s left) kms_chamelium_frames (hdmi-aspect-ratio)
[372.439313] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[372.624883] [091/154] (673s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[372.823569] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[372.882792] [092/154] (673s left) perf (sysctl-defaults)
[372.984421] Starting subtest: sysctl-defaults
[372.985366] Subtest sysctl-defaults: SUCCESS (0.000s)
[373.167905] [093/154] (672s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[373.249638] Starting subtest: etime-single-wait-all-for-submit-submitted
[373.355562] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[373.506953] [094/154] (672s left) kms_rmfb (rmfb-ioctl)
[373.698307] Starting subtest: rmfb-ioctl
[373.699244] Starting dynamic subtest: pipe-A-DP-3
[373.851426] Dynamic subtest pipe-A-DP-3: SUCCESS (0.153s)
[373.877133] Starting dynamic subtest: pipe-B-DP-3
[374.147481] Dynamic subtest pipe-B-DP-3: SUCCESS (0.293s)
[374.165133] Starting dynamic subtest: pipe-C-DP-3
[374.428493] Dynamic subtest pipe-C-DP-3: SUCCESS (0.279s)
[374.442748] Starting dynamic subtest: pipe-D-DP-3
[374.726259] Dynamic subtest pipe-D-DP-3: SUCCESS (0.296s)
[374.727204] Subtest rmfb-ioctl: SUCCESS (1.029s)
[375.045066] [095/154] (671s left) kms_plane_lowres (tiling-4)
[375.236607] Starting subtest: tiling-4
[375.238932] Starting dynamic subtest: pipe-A-DP-3
[386.470060] Dynamic subtest pipe-A-DP-3: SUCCESS (11.231s)
[386.590131] Starting dynamic subtest: pipe-B-DP-3
[397.601995] Dynamic subtest pipe-B-DP-3: SUCCESS (11.024s)
[397.721969] Starting dynamic subtest: pipe-C-DP-3
[408.835071] Dynamic subtest pipe-C-DP-3: SUCCESS (11.125s)
[408.954724] Starting dynamic subtest: pipe-D-DP-3
[419.880036] Dynamic subtest pipe-D-DP-3: SUCCESS (10.937s)
[419.969423] Subtest tiling-4: SUCCESS (44.731s)
[420.252323] [096/154] (626s left) kms_frontbuffer_tracking (psrhdr-1p-pri-indfb-multidraw)
[420.450167] Starting subtest: psrhdr-1p-pri-indfb-multidraw
[420.452038] Subtest psrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[420.600837] [097/154] (625s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[420.798252] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[420.800031] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[420.942440] [098/154] (625s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-pwrite)
[421.140263] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-pwrite
[421.142041] Subtest fbchdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[421.269416] [099/154] (625s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[421.468299] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[421.470022] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[421.602887] [100/154] (625s left) prime_vgem (basic-write)
[421.697897] Starting subtest: basic-write
[421.712286] Subtest basic-write: SKIP (0.014s)
[421.858229] [101/154] (624s left) kms_frontbuffer_tracking (hdr-shrfb-scaledprimary)
[422.059395] Starting subtest: hdr-shrfb-scaledprimary
[422.808626] Subtest hdr-shrfb-scaledprimary: SUCCESS (0.749s)
[423.021977] [102/154] (623s left) syncobj_timeline (invalid-wait-bad-flags)
[423.106366] Starting subtest: invalid-wait-bad-flags
[423.107384] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[423.288879] [103/154] (623s left) gem_ctx_isolation (dirty-switch)
[423.381992] Starting subtest: dirty-switch
[423.383006] Starting dynamic subtest: rcs0
[424.008203] Dynamic subtest rcs0: SUCCESS (0.626s)
[424.023392] Starting dynamic subtest: bcs0
[424.659654] Dynamic subtest bcs0: SUCCESS (0.650s)
[424.674560] Starting dynamic subtest: vcs0
[425.319949] Dynamic subtest vcs0: SUCCESS (0.659s)
[425.334291] Starting dynamic subtest: vcs1
[425.981143] Dynamic subtest vcs1: SUCCESS (0.660s)
[425.995371] Starting dynamic subtest: vecs0
[426.644385] Dynamic subtest vecs0: SUCCESS (0.662s)
[426.658511] Starting dynamic subtest: vecs1
[427.304215] Dynamic subtest vecs1: SUCCESS (0.659s)
[427.318516] Starting dynamic subtest: ccs0
[427.943683] Dynamic subtest ccs0: SUCCESS (0.638s)
[427.944548] Subtest dirty-switch: SUCCESS (4.562s)
[428.221527] [104/154] (618s left) gem_create (busy-create)
[428.307286] Starting subtest: busy-create
[428.308240] Starting dynamic subtest: lmem0
[460.598197] Dynamic subtest lmem0: SUCCESS (32.289s)
[460.612661] Starting dynamic subtest: smem0
[492.841379] Dynamic subtest smem0: SUCCESS (32.241s)
[492.842347] Subtest busy-create: SUCCESS (64.533s)
[493.080424] [105/154] (554s left) kms_cdclk (mode-transition-all-outputs)
[493.274403] Starting subtest: mode-transition-all-outputs
[493.359382] Subtest mode-transition-all-outputs: SKIP (0.084s)
[493.601986] [106/154] (553s left) syncobj_eventfd (invalid-bad-flags)
[493.686569] Starting subtest: invalid-bad-flags
[493.687562] Subtest invalid-bad-flags: SUCCESS (0.000s)
[493.850983] [107/154] (553s left) kms_draw_crc (draw-method-pwrite)
[494.047356] Starting subtest: draw-method-pwrite
[494.048291] Starting dynamic subtest: xrgb8888-untiled
[494.483782] Dynamic subtest xrgb8888-untiled: SUCCESS (0.437s)
[494.499952] Starting dynamic subtest: rgb565-untiled
[494.918495] Dynamic subtest rgb565-untiled: SUCCESS (0.432s)
[494.965898] Starting dynamic subtest: xrgb2101010-untiled
[495.334618] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.411s)
[495.351852] Starting dynamic subtest: xbgr16161616f-untiled
[495.750686] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.412s)
[495.769557] Starting dynamic subtest: xrgb8888-xtiled
[496.300178] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.548s)
[496.315157] Starting dynamic subtest: rgb565-xtiled
[496.884697] Dynamic subtest rgb565-xtiled: SUCCESS (0.582s)
[496.908407] Starting dynamic subtest: xrgb2101010-xtiled
[497.417203] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.528s)
[497.435563] Starting dynamic subtest: xbgr16161616f-xtiled
[498.050336] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.631s)
[498.066059] Starting dynamic subtest: xrgb8888-4tiled
[498.484037] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.432s)
[498.501784] Starting dynamic subtest: rgb565-4tiled
[498.818367] Dynamic subtest rgb565-4tiled: SUCCESS (0.332s)
[498.866055] Starting dynamic subtest: xrgb2101010-4tiled
[499.267048] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.445s)
[499.282817] Starting dynamic subtest: xbgr16161616f-4tiled
[499.917229] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.649s)
[499.918241] Subtest draw-method-pwrite: SUCCESS (5.871s)
[500.122890] [108/154] (547s left) kms_cursor_crc (cursor-onscreen-128x128)
[500.502486] Starting subtest: cursor-onscreen-128x128
[500.507900] Starting dynamic subtest: pipe-A-DP-3
[503.270345] Dynamic subtest pipe-A-DP-3: SUCCESS (2.762s)
[503.328853] Starting dynamic subtest: pipe-D-DP-3
[506.005790] Dynamic subtest pipe-D-DP-3: SUCCESS (2.690s)
[506.006673] Subtest cursor-onscreen-128x128: SUCCESS (5.503s)
[506.433832] [109/154] (541s left) kms_atomic_interruptible (legacy-setmode)
[506.627075] Starting subtest: legacy-setmode
[506.627996] Starting dynamic subtest: pipe-A-DP-3
[512.961610] Dynamic subtest pipe-A-DP-3: SUCCESS (6.334s)
[512.962589] Subtest legacy-setmode: SUCCESS (6.336s)
[513.246326] [110/154] (534s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-onoff)
[513.441337] Starting subtest: hdr-2p-primscrn-spr-indfb-onoff
[513.443157] Subtest hdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[513.637215] [111/154] (533s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[513.829663] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[513.884285] [112/154] (533s left) gem_eio (wait-10ms)
[514.198744] Starting subtest: wait-10ms
[514.848390] Subtest wait-10ms: SUCCESS (0.650s)
[515.098547] [113/154] (532s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[515.294986] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[515.296746] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[515.495899] [114/154] (532s left) kms_psr (psr2-sprite-plane-onoff)
[515.687262] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[515.751031] [115/154] (532s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[515.947278] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[515.949037] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[516.113091] [116/154] (531s left) gem_exec_whisper (basic-normal)
[516.204603] Starting subtest: basic-normal
[519.966843] Subtest basic-normal: SUCCESS (3.761s)
[520.213591] [117/154] (527s left) kms_cursor_crc (cursor-random-32x32)
[520.503077] Starting subtest: cursor-random-32x32
[520.556283] Subtest cursor-random-32x32: SKIP (0.051s)
[520.999357] [118/154] (527s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[521.194332] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[521.195271] Starting dynamic subtest: pipe-A-valid-mode
[524.091516] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.894s)
[524.092986] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (2.898s)
[524.381450] [119/154] (523s left) gem_busy (parallel)
[524.667740] Starting subtest: parallel
[524.668639] Starting dynamic subtest: rcs0
[524.778434] Dynamic subtest rcs0: SUCCESS (0.110s)
[524.803478] Starting dynamic subtest: bcs0
[524.855292] Dynamic subtest bcs0: SUCCESS (0.075s)
[524.869284] Starting dynamic subtest: vcs0
[524.915432] Dynamic subtest vcs0: SUCCESS (0.059s)
[524.930596] Starting dynamic subtest: vcs1
[524.980916] Dynamic subtest vcs1: SUCCESS (0.064s)
[525.000346] Starting dynamic subtest: vecs0
[525.045124] Dynamic subtest vecs0: SUCCESS (0.063s)
[525.079317] Starting dynamic subtest: vecs1
[525.127195] Dynamic subtest vecs1: SUCCESS (0.080s)
[525.150283] Starting dynamic subtest: ccs0
[525.196825] Dynamic subtest ccs0: SUCCESS (0.068s)
[525.197881] Subtest parallel: SUCCESS (0.530s)
[525.508679] [120/154] (522s left) gem_exec_schedule (implicit-write-read)
[525.604642] Starting subtest: implicit-write-read
[525.605478] Starting dynamic subtest: rcs0
[525.912408] Dynamic subtest rcs0: SUCCESS (0.307s)
[525.925873] Starting dynamic subtest: bcs0
[526.126828] Dynamic subtest bcs0: SUCCESS (0.213s)
[526.140520] Starting dynamic subtest: vcs0
[526.355093] Dynamic subtest vcs0: SUCCESS (0.227s)
[526.369528] Starting dynamic subtest: vcs1
[526.577147] Dynamic subtest vcs1: SUCCESS (0.220s)
[526.602788] Starting dynamic subtest: vecs0
[526.815763] Dynamic subtest vecs0: SUCCESS (0.237s)
[526.829533] Starting dynamic subtest: vecs1
[527.064520] Dynamic subtest vecs1: SUCCESS (0.248s)
[527.077952] Starting dynamic subtest: ccs0
[527.279656] Dynamic subtest ccs0: SUCCESS (0.214s)
[527.280575] Subtest implicit-write-read: SUCCESS (1.675s)
[527.737270] [121/154] (520s left) kms_dirtyfb (default-dirtyfb-ioctl)
[527.929933] Starting subtest: default-dirtyfb-ioctl
[527.932432] Starting dynamic subtest: A-DP-3
[529.338375] Dynamic subtest A-DP-3: SUCCESS (1.407s)
[529.339455] Subtest default-dirtyfb-ioctl: SUCCESS (1.409s)
[529.645357] [122/154] (518s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[529.840428] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[529.855935] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.015s)
[529.965640] [123/154] (518s left) gem_exec_reloc (basic-concurrent16)
[530.060436] Subtest basic-concurrent16: SKIP (0.000s)
[530.163088] [124/154] (518s left) sw_sync (sync_busy_fork_unixsocket)
[530.214810] Starting subtest: sync_busy_fork_unixsocket
[530.223593] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[530.376403] [125/154] (518s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[530.574081] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[530.575667] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[530.715363] [126/154] (518s left) gem_mmap_offset (perf)
[530.802945] Starting subtest: perf
[530.803948] Starting dynamic subtest: lmem0
[531.064942] Dynamic subtest lmem0: SUCCESS (0.268s)
[531.079237] Starting dynamic subtest: smem0
[531.084382] Dynamic subtest smem0: SUCCESS (0.003s)
[531.085297] Subtest perf: SUCCESS (0.273s)
[531.174557] [127/154] (517s left) prime_mmap (test_forked_cpu_write)
[531.256620] Starting subtest: test_forked_cpu_write
[531.257514] Starting dynamic subtest: test_forked_cpu_write-smem
[531.265868] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[531.281380] Starting dynamic subtest: test_forked_cpu_write-lmem0
[531.282532] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.009s)
[531.283475] Subtest test_forked_cpu_write: SUCCESS (0.021s)
[531.426633] [128/154] (517s left) kms_flip (2x-flip-vs-panning)
[531.618363] Starting subtest: 2x-flip-vs-panning
[531.633818] Subtest 2x-flip-vs-panning: SKIP (0.015s)
[531.755716] [129/154] (517s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[531.944810] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[531.947300] Starting dynamic subtest: pipe-A-DP-3
[531.955993] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[531.969898] Starting dynamic subtest: pipe-B-DP-3
[531.978567] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[531.991811] Starting dynamic subtest: pipe-C-DP-3
[532.000459] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[532.013812] Starting dynamic subtest: pipe-D-DP-3
[532.024573] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[532.026605] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.007s)
[532.422408] [130/154] (516s left) kms_big_fb (yf-tiled-addfb)
[532.629373] Starting subtest: yf-tiled-addfb
[532.631241] Subtest yf-tiled-addfb: SKIP (0.000s)
[532.746992] [131/154] (516s left) kms_lease (lease-revoke)
[532.941522] Starting subtest: lease-revoke
[532.942437] Starting dynamic subtest: pipe-A-DP-3
[533.039385] Dynamic subtest pipe-A-DP-3: SUCCESS (0.097s)
[533.053124] Starting dynamic subtest: pipe-B-DP-3
[533.115369] Dynamic subtest pipe-B-DP-3: SUCCESS (0.074s)
[533.129132] Starting dynamic subtest: pipe-C-DP-3
[533.189382] Dynamic subtest pipe-C-DP-3: SUCCESS (0.073s)
[533.204179] Starting dynamic subtest: pipe-D-DP-3
[533.261434] Dynamic subtest pipe-D-DP-3: SUCCESS (0.069s)
[533.262299] Subtest lease-revoke: SUCCESS (0.320s)
[533.490672] [132/154] (515s left) device_reset (unbind-cold-reset-rebind)
[533.581047] Starting subtest: unbind-cold-reset-rebind
[533.583129] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[533.708915] [133/154] (515s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[533.907029] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[533.908899] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[534.072123] [134/154] (515s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[534.268301] Starting subtest: fbc-rgb565-draw-mmap-wc
[534.270162] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s)
[534.409869] [135/154] (515s left) testdisplay
[554.721030] [136/154] (494s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[554.813886] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[554.975720] [137/154] (494s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[555.172120] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[555.173945] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[555.376619] [138/154] (494s left) gem_exec_reloc (basic-cpu-read)
[555.466246] Subtest basic-cpu-read: SKIP (0.000s)
[555.551149] [139/154] (494s left) kms_flip (absolute-wf_vblank)
[555.742164] Starting subtest: absolute-wf_vblank
[555.747033] Starting dynamic subtest: A-DP3
[563.621512] Dynamic subtest A-DP3: SUCCESS (7.874s)
[563.637944] Starting dynamic subtest: B-DP3
[571.407745] Dynamic subtest B-DP3: SUCCESS (7.784s)
[571.424413] Starting dynamic subtest: C-DP3
[579.200496] Dynamic subtest C-DP3: SUCCESS (7.790s)
[579.216456] Starting dynamic subtest: D-DP3
[586.992376] Dynamic subtest D-DP3: SUCCESS (7.790s)
[586.994589] Subtest absolute-wf_vblank: SUCCESS (31.251s)
[587.324981] [140/154] (462s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move)
[587.526996] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move
[587.528800] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[587.661954] [141/154] (462s left) gem_exec_schedule (submit-golden-slice)
[587.757805] Starting subtest: submit-golden-slice
[587.758770] Starting dynamic subtest: rcs0
[587.842119] Dynamic subtest rcs0: SUCCESS (0.084s)
[587.857466] Starting dynamic subtest: bcs0
[587.898774] Dynamic subtest bcs0: SUCCESS (0.056s)
[587.913845] Starting dynamic subtest: vcs0
[587.952034] Dynamic subtest vcs0: SUCCESS (0.052s)
[587.967126] Starting dynamic subtest: vcs1
[588.008403] Dynamic subtest vcs1: SUCCESS (0.055s)
[588.024298] Starting dynamic subtest: vecs0
[588.065145] Dynamic subtest vecs0: SUCCESS (0.055s)
[588.080511] Starting dynamic subtest: vecs1
[588.123161] Dynamic subtest vecs1: SUCCESS (0.057s)
[588.138666] Starting dynamic subtest: ccs0
[588.177191] Dynamic subtest ccs0: SUCCESS (0.053s)
[588.178167] Subtest submit-golden-slice: SUCCESS (0.420s)
[588.644353] [142/154] (461s left) gen7_exec_parse (load-register-reg)
[588.731558] Subtest load-register-reg: SKIP (0.000s)
[588.824554] [143/154] (461s left) gem_exec_params (invalid-flag)
[588.912300] Starting subtest: invalid-flag
[588.913315] Subtest invalid-flag: SUCCESS (0.000s)
[589.059863] [144/154] (461s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[589.255772] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[589.260842] Starting dynamic subtest: A-DP3
[597.386537] Dynamic subtest A-DP3: SUCCESS (8.125s)
[597.402781] Starting dynamic subtest: B-DP3
[605.440867] Dynamic subtest B-DP3: SUCCESS (8.052s)
[605.457311] Starting dynamic subtest: C-DP3
[613.520824] Dynamic subtest C-DP3: SUCCESS (8.078s)
[613.536466] Starting dynamic subtest: D-DP3
[621.571195] Dynamic subtest D-DP3: SUCCESS (8.048s)
[621.576188] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.319s)
[621.977139] [145/154] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[622.175913] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[622.177699] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[622.313870] [146/154] (428s left) gem_ctx_shared (detached-shared-gtt)
[622.406359] Starting subtest: detached-shared-gtt
[624.557025] Subtest detached-shared-gtt: SUCCESS (2.150s)
[626.834559] [147/154] (423s left) gem_lmem_swapping (parallel-multi)
[629.732841] Starting subtest: parallel-multi
[629.735182] Starting dynamic subtest: lmem0
[683.938394] Dynamic subtest lmem0: SUCCESS (54.203s)
[683.939368] Subtest parallel-multi: SUCCESS (54.204s)
[684.983093] [FACT gem_lmem_swapping (parallel-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[684.984447] [FACT gem_lmem_swapping (parallel-multi)] deleted: kernel.kmod_is_loaded.i915: true
[684.986408] [148/154] (365s left) gem_mmap_gtt (basic-small-copy-odd)
[686.651421] Subtest basic-small-copy-odd: SKIP (0.000s)
[686.726557] [FACT gem_mmap_gtt (basic-small-copy-odd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[686.728963] [FACT gem_mmap_gtt (basic-small-copy-odd)] new: kernel.kmod_is_loaded.i915: true
[686.732069] [149/154] (363s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt)
[686.933242] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt
[686.935041] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[687.079523] [150/154] (363s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-move)
[687.276210] Starting subtest: hdr-2p-scndscrn-spr-indfb-move
[687.277999] Subtest hdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[687.435532] [151/154] (363s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[687.633193] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[687.634978] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[687.764329] [152/154] (362s left) kms_psr (psr-sprite-mmap-gtt)
[687.969289] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[688.030230] [153/154] (362s left) gem_mmap_wc (write)
[688.115148] Subtest write: SKIP (0.000s)
[688.180423] [154/154] (362s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[688.380284] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[688.382058] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[688.529377] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_cursor_edge_walk
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_render_copy
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: gem_userptr_blits
results: parsing output: 14/ for test: gem_exec_params
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: drm_read
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_addfb_basic
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_exec_fence
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_plane_scaling
results: parsing output: 25/ for test: i915_hangman
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_vblank
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: gem_readwrite
results: parsing output: 39/ for test: kms_joiner
results: parsing output: 40/ for test: prime_mmap
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: syncobj_eventfd
results: parsing output: 46/ for test: gem_pxp
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: kms_fbcon_fbt
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: drm_read
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_hdr
results: parsing output: 55/ for test: sysfs_heartbeat_interval
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: i915_drm_fdinfo
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_pm_rpm
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: i915_pm_rpm
results: parsing output: 64/ for test: kms_async_flips
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: gem_exec_await
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: kms_fence_pin_leak
results: parsing output: 77/ for test: kms_busy
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: intel_hwmon
results: parsing output: 85/ for test: core_setmaster_vs_auth
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_sequence
results: parsing output: 89/ for test: kms_chamelium_frames
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_rmfb
results: parsing output: 94/ for test: kms_plane_lowres
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: prime_vgem
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: gem_ctx_isolation
results: parsing output: 103/ for test: gem_create
results: parsing output: 104/ for test: kms_cdclk
results: parsing output: 105/ for test: syncobj_eventfd
results: parsing output: 106/ for test: kms_draw_crc
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: kms_atomic_interruptible
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_whisper
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: gem_busy
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_dirtyfb
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: sw_sync
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_mmap_offset
results: parsing output: 126/ for test: prime_mmap
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_lease
results: parsing output: 131/ for test: device_reset
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: testdisplay
results: parsing output: 135/ for test: gem_userptr_blits
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_exec_reloc
results: parsing output: 138/ for test: kms_flip
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: gem_exec_schedule
results: parsing output: 141/ for test: gen7_exec_parse
results: parsing output: 142/ for test: gem_exec_params
results: parsing output: 143/ for test: kms_flip
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_ctx_shared
results: parsing output: 146/ for test: gem_lmem_swapping
results: parsing output: 147/ for test: gem_mmap_gtt
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: gem_mmap_wc
results: parsing output: 153/ for test: kms_frontbuffer_tracking
Done.