[101.585250] Initializing watchdogs
[101.585323]   /dev/watchdog0
[101.594272] [001/130] (960s left) kms_cursor_crc (cursor-onscreen-32x32)
[101.891707] Starting subtest: cursor-onscreen-32x32
[101.938010] Subtest cursor-onscreen-32x32: SKIP (0.045s)
[102.320451] [002/130] (959s left) gem_workarounds (reset-context)
[102.428597] Starting subtest: reset-context
[102.623462] Subtest reset-context: SUCCESS (0.195s)
[102.767867] [003/130] (959s left) kms_vblank (ts-continuation-dpms-suspend)
[102.993499] Starting subtest: ts-continuation-dpms-suspend
[102.995738] Starting dynamic subtest: pipe-A-DP-4
[122.660932] Dynamic subtest pipe-A-DP-4: SUCCESS (4.355s)
[122.677125] Starting dynamic subtest: pipe-D-DP-4
[142.644431] Dynamic subtest pipe-D-DP-4: SUCCESS (3.984s)
[142.645172] Subtest ts-continuation-dpms-suspend: SUCCESS (8.345s)
[144.877822] [004/130] (950s left) gem_exec_reloc (basic-write-wc)
[144.957069] Subtest basic-write-wc: SKIP (0.000s)
[145.006957] [005/130] (950s left) gem_mmap_wc (write-read)
[145.079355] Subtest write-read: SKIP (0.000s)
[145.122579] [006/130] (950s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[145.370317] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[145.371316] Starting dynamic subtest: pipe-A-valid-mode
[145.452176] Dynamic subtest pipe-A-valid-mode: SKIP (0.081s)
[145.453722] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.083s)
[145.606526] [007/130] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[145.875034] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[145.877098] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[145.968406] [008/130] (949s left) gem_pxp (reject-modify-context-protection-off-2)
[148.590956] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[148.650391] [009/130] (946s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[148.874719] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[148.875497] Starting dynamic subtest: pipe-A-DP-4
[148.884287] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[148.893789] Starting dynamic subtest: pipe-B-DP-4
[148.902346] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[148.910849] Starting dynamic subtest: pipe-C-DP-4
[148.919061] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[148.927268] Starting dynamic subtest: pipe-D-DP-4
[148.935819] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[148.937339] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[149.254089] [010/130] (946s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[149.501085] Starting subtest: 4-tiled-16bpp-rotate-0
[151.166398] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.665s)
[151.290708] [011/130] (944s left) gem_ctx_isolation (preservation-reset)
[151.476715] Starting subtest: preservation-reset
[151.477993] Starting dynamic subtest: rcs0
[152.042073] Dynamic subtest rcs0: SUCCESS (0.565s)
[152.050668] Starting dynamic subtest: bcs0
[152.625169] Dynamic subtest bcs0: SUCCESS (0.583s)
[152.634004] Starting dynamic subtest: vcs0
[153.262382] Dynamic subtest vcs0: SUCCESS (0.637s)
[153.271224] Starting dynamic subtest: vcs1
[153.846004] Dynamic subtest vcs1: SUCCESS (0.583s)
[153.854724] Starting dynamic subtest: vecs0
[154.425692] Dynamic subtest vecs0: SUCCESS (0.579s)
[154.434544] Starting dynamic subtest: vecs1
[155.028981] Dynamic subtest vecs1: SUCCESS (0.603s)
[155.037644] Starting dynamic subtest: ccs0
[155.629989] Dynamic subtest ccs0: SUCCESS (0.601s)
[155.630782] Subtest preservation-reset: SUCCESS (4.154s)
[155.815120] [012/130] (939s left) kms_flip (flip-vs-wf_vblank-interruptible)
[156.084770] Starting subtest: flip-vs-wf_vblank-interruptible
[156.091880] Starting dynamic subtest: A-DP4
[157.369703] Dynamic subtest A-DP4: SUCCESS (1.277s)
[157.383012] Starting dynamic subtest: B-DP4
[158.443296] Dynamic subtest B-DP4: SUCCESS (1.073s)
[158.453003] Starting dynamic subtest: C-DP4
[159.510732] Dynamic subtest C-DP4: SUCCESS (1.067s)
[159.520294] Starting dynamic subtest: D-DP4
[160.525803] Dynamic subtest D-DP4: SUCCESS (1.015s)
[160.526711] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (4.442s)
[160.819246] [013/130] (934s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[161.085671] Starting subtest: fbc-tiling-linear
[166.925358] Subtest fbc-tiling-linear: FAIL (5.530s)
[166.964312] [014/130] (928s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[167.039340] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[167.080658] [015/130] (928s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[167.319405] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[167.348474] [016/130] (928s left) gem_eio (suspend)
[167.621942] Starting subtest: suspend
[181.374416] Subtest suspend: SUCCESS (13.720s)
[184.605478] [017/130] (914s left) kms_plane_scaling (intel-max-src-size)
[184.848336] Starting subtest: intel-max-src-size
[184.860867] Starting dynamic subtest: pipe-A-DP-4
[185.144394] Dynamic subtest pipe-A-DP-4: FAIL (0.012s)
[185.146116] Subtest intel-max-src-size: FAIL (0.025s)
[185.188210] [018/130] (913s left) gem_create (create-massive)
[185.272657] Starting subtest: create-massive
[185.273432] Subtest create-massive: SUCCESS (0.000s)
[185.465283] [019/130] (913s left) syncobj_wait (invalid-signal-bad-pad)
[185.540565] Starting subtest: invalid-signal-bad-pad
[185.541929] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[185.638780] [020/130] (913s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[185.876144] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[185.877128] Starting dynamic subtest: pipe-A-DP-4
[185.898608] Dynamic subtest pipe-A-DP-4: SKIP (0.004s)
[185.907802] Starting dynamic subtest: pipe-B-DP-4
[185.927796] Dynamic subtest pipe-B-DP-4: SKIP (0.003s)
[185.936756] Starting dynamic subtest: pipe-C-DP-4
[185.956279] Dynamic subtest pipe-C-DP-4: SKIP (0.003s)
[185.964815] Starting dynamic subtest: pipe-D-DP-4
[185.984829] Dynamic subtest pipe-D-DP-4: SKIP (0.003s)
[185.986449] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.017s)
[186.310079] [021/130] (912s left) kms_rotation_crc (multiplane-rotation)
[186.559878] Starting subtest: multiplane-rotation
[198.128272] Subtest multiplane-rotation: SUCCESS (11.563s)
[198.307256] [022/130] (900s left) kms_frontbuffer_tracking (basic)
[198.547956] Starting subtest: basic
[201.242621] Subtest basic: SUCCESS (2.695s)
[201.400151] [023/130] (897s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[201.655237] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[201.657332] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[201.753907] [024/130] (897s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[202.002281] Starting subtest: fb-8bpc-vs-panel-8bpc
[202.004407] Starting dynamic subtest: pipe-A-DP-4
[202.401238] Dynamic subtest pipe-A-DP-4: SUCCESS (0.395s)
[202.403041] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.397s)
[202.611821] [025/130] (896s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[202.865345] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[202.897538] [026/130] (896s left) perf_pmu (busy-double-start)
[202.959723] Starting subtest: busy-double-start
[202.960511] Starting dynamic subtest: rcs0
[206.577339] Dynamic subtest rcs0: SUCCESS (3.617s)
[206.590029] Starting dynamic subtest: bcs0
[210.166146] Dynamic subtest bcs0: SUCCESS (3.587s)
[210.178621] Starting dynamic subtest: vcs0
[213.753350] Dynamic subtest vcs0: FAIL (3.568s)
[213.764482] Starting dynamic subtest: vcs1
[217.318863] Dynamic subtest vcs1: FAIL (3.563s)
[217.329538] Starting dynamic subtest: vecs0
[220.882301] Dynamic subtest vecs0: FAIL (3.563s)
[220.893256] Starting dynamic subtest: vecs1
[224.443694] Dynamic subtest vecs1: FAIL (3.561s)
[224.454220] Starting dynamic subtest: ccs0
[228.012419] Dynamic subtest ccs0: SUCCESS (3.585s)
[228.014225] Subtest busy-double-start: FAIL (25.050s)
[228.110169] [027/130] (871s left) kms_content_protection (dp-mst-type-1)
[228.401325] Starting subtest: dp-mst-type-1
[228.402972] Subtest dp-mst-type-1: SKIP (0.000s)
[228.501065] [028/130] (870s left) gem_sync (basic-all)
[228.607956] Starting subtest: basic-all
[231.422387] Subtest basic-all: SUCCESS (2.813s)
[231.592283] [029/130] (867s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[231.810856] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[231.812429] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[231.898774] [030/130] (867s left) perf (missing-sample-flags)
[232.269239] Starting subtest: missing-sample-flags
[232.270041] Subtest missing-sample-flags: SUCCESS (0.000s)
[232.290355] [031/130] (867s left) kms_cursor_edge_walk (256x256-right-edge)
[232.594991] Starting subtest: 256x256-right-edge
[232.596987] Starting dynamic subtest: pipe-A-DP-4
[236.053288] Dynamic subtest pipe-A-DP-4: SUCCESS (3.455s)
[236.069372] Starting dynamic subtest: pipe-D-DP-4
[239.374194] Dynamic subtest pipe-D-DP-4: SUCCESS (3.318s)
[239.375089] Subtest 256x256-right-edge: SUCCESS (6.778s)
[239.613473] [032/130] (859s left) syncobj_timeline (wait-all-for-submit-complex)
[239.737344] Starting subtest: wait-all-for-submit-complex
[239.956505] Subtest wait-all-for-submit-complex: SUCCESS (0.218s)
[240.026420] [033/130] (859s left) api_intel_bb (intel-bb-blit-none)
[240.134896] Starting subtest: intel-bb-blit-none
[240.824948] Subtest intel-bb-blit-none: SUCCESS (0.690s)
[240.957572] [034/130] (858s left) gem_exec_store (basic)
[241.082782] Starting subtest: basic
[241.234230] Subtest basic: SUCCESS (0.151s)
[241.516644] [035/130] (857s left) debugfs_test (read_all_entries)
[241.644553] Starting subtest: read_all_entries
[242.353846] Subtest read_all_entries: SUCCESS (0.709s)
[242.570436] [036/130] (856s left) gem_eio (in-flight-external)
[242.912839] Starting subtest: in-flight-external
[244.169852] Subtest in-flight-external: SUCCESS (1.257s)
[244.386273] [037/130] (855s left) i915_pm_rpm (gem-execbuf-stress)
[247.159617] Starting subtest: gem-execbuf-stress
[247.161322] Starting dynamic subtest: lmem0
[252.372007] Dynamic subtest lmem0: SUCCESS (5.209s)
[252.416913] Starting dynamic subtest: extra-wait-lmem0
[305.772265] Dynamic subtest extra-wait-lmem0: SUCCESS (53.399s)
[305.803651] Starting dynamic subtest: smem0
[309.195125] Dynamic subtest smem0: SUCCESS (3.421s)
[309.239467] Starting dynamic subtest: extra-wait-smem0
[362.589343] Dynamic subtest extra-wait-smem0: SUCCESS (53.379s)
[362.590958] Subtest gem-execbuf-stress: SUCCESS (115.419s)
[362.963340] [038/130] (736s left) gem_lmem_swapping (random-engines)
[366.491460] Starting subtest: random-engines
[366.492423] Starting dynamic subtest: lmem0
[367.336714] Dynamic subtest lmem0: SUCCESS (0.845s)
[367.337610] Subtest random-engines: SUCCESS (0.846s)
[369.102744] [039/130] (730s left) kms_busy (extended-pageflip-hang-oldfb)
[370.811965] Starting subtest: extended-pageflip-hang-oldfb
[370.816944] Starting dynamic subtest: pipe-A
[371.150696] Dynamic subtest pipe-A: SUCCESS (0.333s)
[371.176454] Starting dynamic subtest: pipe-D
[371.428756] Dynamic subtest pipe-D: SUCCESS (0.267s)
[371.429675] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.620s)
[371.698757] [040/130] (727s left) kms_prime (basic-crc-vgem)
[374.518793] Subtest basic-crc-vgem: SKIP (0.000s)
[374.589849] [041/130] (725s left) kms_addfb_basic (bad-pitch-1024)
[374.662955] Starting subtest: bad-pitch-1024
[374.663757] Subtest bad-pitch-1024: SUCCESS (0.000s)
[374.914867] [042/130] (724s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[375.161040] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[375.162780] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[375.221732] [043/130] (724s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[375.453776] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[377.755615] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.302s)
[377.920548] [044/130] (721s left) kms_flip (2x-flip-vs-panning-vs-hang)
[378.165801] Starting subtest: 2x-flip-vs-panning-vs-hang
[378.182733] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.018s)
[378.258164] [045/130] (721s left) gem_ccs (block-copy-uncompressed)
[378.346809] Starting subtest: block-copy-uncompressed
[378.347737] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[378.388973] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.041s)
[378.398669] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[378.403187] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.013s)
[378.412914] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[378.511433] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.107s)
[378.521244] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[378.612596] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.100s)
[378.623468] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[378.626869] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.013s)
[378.636281] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-lmem0
[378.640514] Dynamic subtest xmajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.013s)
[378.650228] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-smem
[378.749799] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.108s)
[378.759358] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-lmem0
[378.852565] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.102s)
[378.863538] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[378.868725] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[378.878334] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-lmem0
[378.882682] Dynamic subtest tile4-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.013s)
[378.892295] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-smem
[378.990441] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.107s)
[379.000321] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-lmem0
[379.094157] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.103s)
[379.105171] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[379.108890] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.014s)
[379.118535] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-lmem0
[379.122754] Dynamic subtest tile64-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.013s)
[379.132461] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-smem
[379.215723] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.092s)
[379.225291] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-lmem0
[379.311662] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.095s)
[379.312435] Subtest block-copy-uncompressed: SUCCESS (0.965s)
[379.413589] [046/130] (720s left) gem_userptr_blits (mmap-offset-banned)
[379.506799] Starting subtest: mmap-offset-banned
[379.507624] Starting dynamic subtest: fixed
[379.508433] Dynamic subtest fixed: SUCCESS (0.000s)
[379.509259] Subtest mmap-offset-banned: SUCCESS (0.001s)
[379.674996] [047/130] (720s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[379.930701] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[379.932231] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[380.014501] [048/130] (719s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[380.276991] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[380.278604] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[380.398969] [049/130] (719s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[380.657264] Starting subtest: y-tiled-64bpp-rotate-270
[380.658983] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[380.765598] [050/130] (719s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[381.022460] Starting subtest: basic-flip-before-cursor-legacy
[382.058126] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.034s)
[382.307342] [051/130] (717s left) kms_chamelium_edid (dp-edid-resolution-list)
[382.623050] Subtest dp-edid-resolution-list: SKIP (0.000s)
[382.743575] [052/130] (717s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[382.972931] Starting subtest: 2x-cursor-vs-flip-atomic
[382.975111] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s)
[383.049005] [053/130] (716s left) i915_hangman (engine-error-state-capture)
[383.153975] Starting subtest: engine-error-state-capture
[383.154777] Starting dynamic subtest: rcs0
[385.833229] Dynamic subtest rcs0: SUCCESS (2.678s)
[385.843094] Starting dynamic subtest: bcs0
[389.850096] Dynamic subtest bcs0: SUCCESS (4.016s)
[389.862728] Starting dynamic subtest: vcs0
[393.903494] Dynamic subtest vcs0: SUCCESS (4.053s)
[393.917243] Starting dynamic subtest: vcs1
[397.869248] Dynamic subtest vcs1: SUCCESS (3.965s)
[397.882259] Starting dynamic subtest: vecs0
[401.899603] Dynamic subtest vecs0: SUCCESS (4.030s)
[401.912963] Starting dynamic subtest: vecs1
[405.862641] Dynamic subtest vecs1: SUCCESS (3.962s)
[405.877531] Starting dynamic subtest: ccs0
[409.915618] Dynamic subtest ccs0: SUCCESS (4.050s)
[409.916626] Subtest engine-error-state-capture: SUCCESS (26.766s)
[410.048421] [054/130] (689s left) gem_userptr_blits (sync-unmap)
[410.138200] Starting subtest: sync-unmap
[410.157164] Subtest sync-unmap: SUCCESS (0.018s)
[410.322311] [055/130] (689s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[410.556535] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[411.773343] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.216s)
[411.964501] [056/130] (688s left) perf_pmu (busy-check-all)
[412.037436] Starting subtest: busy-check-all
[412.038272] Starting dynamic subtest: rcs0
[412.625283] Dynamic subtest rcs0: SUCCESS (0.587s)
[412.637989] Starting dynamic subtest: bcs0
[413.179710] Dynamic subtest bcs0: SUCCESS (0.552s)
[413.193603] Starting dynamic subtest: vcs0
[413.734720] Dynamic subtest vcs0: SUCCESS (0.550s)
[413.748269] Starting dynamic subtest: vcs1
[414.288677] Dynamic subtest vcs1: SUCCESS (0.549s)
[414.302346] Starting dynamic subtest: vecs0
[414.842726] Dynamic subtest vecs0: SUCCESS (0.549s)
[414.856999] Starting dynamic subtest: vecs1
[415.397585] Dynamic subtest vecs1: SUCCESS (0.550s)
[415.411724] Starting dynamic subtest: ccs0
[415.952264] Dynamic subtest ccs0: SUCCESS (0.550s)
[415.956818] Subtest busy-check-all: SUCCESS (3.917s)
[416.066878] [057/130] (684s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[416.291999] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[416.318754] [058/130] (683s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[416.396802] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[416.439740] [059/130] (683s left) gem_mmap_gtt (cpuset-big-copy-xy)
[416.532799] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[416.568148] [060/130] (683s left) kms_pipe_crc_basic (nonblocking-crc)
[416.802023] Starting subtest: nonblocking-crc
[416.802831] Starting dynamic subtest: pipe-A-DP-4
[417.511785] Dynamic subtest pipe-A-DP-4: SUCCESS (0.709s)
[417.525081] Starting dynamic subtest: pipe-B-DP-4
[418.172698] Dynamic subtest pipe-B-DP-4: SUCCESS (0.658s)
[418.185824] Starting dynamic subtest: pipe-C-DP-4
[418.786063] Dynamic subtest pipe-C-DP-4: SUCCESS (0.610s)
[418.804397] Starting dynamic subtest: pipe-D-DP-4
[419.445175] Dynamic subtest pipe-D-DP-4: SUCCESS (0.655s)
[419.446617] Subtest nonblocking-crc: SUCCESS (2.644s)
[419.721071] [061/130] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[419.976690] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[419.978309] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[420.097276] [062/130] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[420.365094] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[420.366917] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[420.464785] [063/130] (679s left) drm_fdinfo (all-busy-check-all)
[420.550401] Starting subtest: all-busy-check-all
[420.576258] Subtest all-busy-check-all: SKIP (0.025s)
[420.638853] [064/130] (679s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[420.746028] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[420.863546] [065/130] (679s left) gem_exec_params (invalid-ring)
[420.956578] Starting subtest: invalid-ring
[420.957387] Subtest invalid-ring: SUCCESS (0.000s)
[421.043177] [066/130] (679s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[421.274849] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[421.289223] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.014s)
[421.357668] [067/130] (679s left) gem_exec_params (no-blt)
[421.445809] Starting subtest: no-blt
[421.448749] Subtest no-blt: SUCCESS (0.001s)
[421.580084] [068/130] (678s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[421.826715] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[421.828328] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[421.914041] [069/130] (678s left) kms_psr (fbc-psr2-primary-page-flip)
[422.171473] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[422.200492] [070/130] (678s left) gem_exec_whisper (basic-normal)
[422.291972] Starting subtest: basic-normal
[425.307617] Subtest basic-normal: SUCCESS (3.015s)
[425.492331] [071/130] (675s left) kms_getfb (getfb2-into-addfb2)
[425.565963] Starting subtest: getfb2-into-addfb2
[425.566771] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[425.658733] [072/130] (674s left) gem_exec_params (invalid-flag)
[425.744523] Starting subtest: invalid-flag
[425.745347] Subtest invalid-flag: SUCCESS (0.000s)
[425.864954] [073/130] (674s left) gem_exec_schedule (preemptive-hang)
[426.069348] Starting subtest: preemptive-hang
[426.070190] Starting dynamic subtest: rcs0
[435.455252] Dynamic subtest rcs0: SUCCESS (9.385s)
[435.465786] Starting dynamic subtest: bcs0
[444.419228] Dynamic subtest bcs0: SUCCESS (8.963s)
[444.429996] Starting dynamic subtest: vcs0
[453.456915] Dynamic subtest vcs0: SUCCESS (9.036s)
[453.467216] Starting dynamic subtest: vcs1
[462.483555] Dynamic subtest vcs1: SUCCESS (9.025s)
[462.493867] Starting dynamic subtest: vecs0
[471.435421] Dynamic subtest vecs0: SUCCESS (8.951s)
[471.445613] Starting dynamic subtest: vecs1
[480.466663] Dynamic subtest vecs1: SUCCESS (9.030s)
[480.477045] Starting dynamic subtest: ccs0
[489.466190] Dynamic subtest ccs0: SUCCESS (8.997s)
[489.466995] Subtest preemptive-hang: SUCCESS (63.394s)
[489.720725] [074/130] (610s left) prime_vgem (basic-blt)
[489.833295] Starting subtest: basic-blt
[489.893700] Subtest basic-blt: SUCCESS (0.060s)
[490.058134] [075/130] (610s left) kms_psr (pr-primary-blt)
[490.287378] Subtest pr-primary-blt: SKIP (0.000s)
[490.321569] [076/130] (610s left) gem_exec_params (readonly)
[490.403272] Starting subtest: readonly
[490.405313] Subtest readonly: SUCCESS (0.001s)
[490.578830] [077/130] (610s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[490.825274] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[490.828074] Starting dynamic subtest: pipe-A-valid-mode
[490.915419] Dynamic subtest pipe-A-valid-mode: SKIP (0.088s)
[490.917013] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.091s)
[491.103473] [078/130] (609s left) gem_ctx_sseu (mmap-args)
[491.196250] Subtest mmap-args: SKIP (0.000s)
[491.242728] [079/130] (609s left) kms_sequence (get-busy)
[491.483929] Starting subtest: get-busy
[491.484821] Starting dynamic subtest: pipe-A-DP-4
[494.018594] Dynamic subtest pipe-A-DP-4: SUCCESS (2.533s)
[494.033964] Starting dynamic subtest: pipe-B-DP-4
[496.494026] Dynamic subtest pipe-B-DP-4: SUCCESS (2.474s)
[496.506048] Starting dynamic subtest: pipe-C-DP-4
[498.970699] Dynamic subtest pipe-C-DP-4: SUCCESS (2.473s)
[498.984440] Starting dynamic subtest: pipe-D-DP-4
[501.453076] Dynamic subtest pipe-D-DP-4: SUCCESS (2.481s)
[501.454113] Subtest get-busy: SUCCESS (9.969s)
[501.726953] [080/130] (599s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[502.097574] Starting subtest: cursor-rapid-movement-64x21
[502.102289] Starting dynamic subtest: pipe-A-DP-4
[502.521380] Dynamic subtest pipe-A-DP-4: SUCCESS (0.419s)
[502.572720] Starting dynamic subtest: pipe-D-DP-4
[503.010345] Dynamic subtest pipe-D-DP-4: SUCCESS (0.446s)
[503.011220] Subtest cursor-rapid-movement-64x21: SUCCESS (0.912s)
[503.375202] [081/130] (597s left) gem_vm_create (create-ext)
[503.475359] Starting subtest: create-ext
[503.480760] Subtest create-ext: SUCCESS (0.005s)
[503.646940] [082/130] (597s left) kms_addfb_basic (invalid-get-prop-any)
[503.725060] Starting subtest: invalid-get-prop-any
[503.725878] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[503.982424] [083/130] (597s left) drm_fdinfo (most-busy-check-all)
[504.075222] Starting subtest: most-busy-check-all
[504.076026] Starting dynamic subtest: rcs0
[504.099733] Dynamic subtest rcs0: SKIP (0.024s)
[504.110418] Starting dynamic subtest: bcs0
[504.111911] Dynamic subtest bcs0: SKIP (0.000s)
[504.122222] Starting dynamic subtest: vcs0
[504.123763] Dynamic subtest vcs0: SKIP (0.000s)
[504.133639] Starting dynamic subtest: vcs1
[504.135232] Dynamic subtest vcs1: SKIP (0.000s)
[504.145433] Starting dynamic subtest: vecs0
[504.146980] Dynamic subtest vecs0: SKIP (0.000s)
[504.157981] Starting dynamic subtest: vecs1
[504.159551] Dynamic subtest vecs1: SKIP (0.000s)
[504.169685] Starting dynamic subtest: ccs0
[504.171254] Dynamic subtest ccs0: SKIP (0.000s)
[504.172802] Subtest most-busy-check-all: SKIP (0.033s)
[504.187700] [084/130] (596s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[504.463210] Starting subtest: x-tiled-64bpp-rotate-0
[506.186290] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.722s)
[506.373573] [085/130] (594s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[506.614398] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[506.616007] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[506.723586] [086/130] (594s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[506.816506] Starting subtest: etime-single-wait-all-available-unsubmitted
[506.921636] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.105s)
[507.030596] [087/130] (594s left) gen9_exec_parse (bb-chained)
[507.115644] Subtest bb-chained: SKIP (0.000s)
[507.200255] [088/130] (594s left) gem_mmap_gtt (basic-small-bo-tiledx)
[507.286744] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[507.332575] [089/130] (593s left) kms_pm_lpsp (kms-lpsp)
[508.565004] Starting subtest: kms-lpsp
[508.566687] Subtest kms-lpsp: SKIP (0.000s)
[508.619974] [090/130] (592s left) prime_mmap (test_correct_cpu_write)
[508.698022] Starting subtest: test_correct_cpu_write
[508.698838] Starting dynamic subtest: test_correct_cpu_write-smem
[508.699622] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[508.710103] Starting dynamic subtest: test_correct_cpu_write-lmem0
[508.710916] Dynamic subtest test_correct_cpu_write-lmem0: SUCCESS (0.000s)
[508.711721] Subtest test_correct_cpu_write: SUCCESS (0.002s)
[508.824259] [091/130] (592s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[509.081663] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[509.083266] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[509.186619] [092/130] (592s left) gem_exec_balancer (waits)
[509.290882] Starting subtest: waits
[521.849377] Subtest waits: SUCCESS (12.556s)
[522.234988] [093/130] (579s left) debugfs_test (read_all_entries_display_on)
[522.477623] Starting subtest: read_all_entries_display_on
[523.241196] Subtest read_all_entries_display_on: SUCCESS (0.764s)
[523.405566] [094/130] (578s left) syncobj_timeline (invalid-query-one-illegal-handle)
[523.487546] Starting subtest: invalid-query-one-illegal-handle
[523.488321] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[523.622750] [095/130] (577s left) gem_exec_reloc (basic-gtt-read-active)
[523.712053] Subtest basic-gtt-read-active: SKIP (0.000s)
[523.769494] [096/130] (577s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[524.013099] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[525.238695] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.225s)
[525.393156] [097/130] (576s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[525.490615] Starting subtest: etime-multi-wait-all-for-submit-submitted
[525.593253] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[525.709431] [098/130] (575s left) gem_exec_reloc (basic-write-cpu)
[525.794035] Subtest basic-write-cpu: SKIP (0.000s)
[525.839675] [099/130] (575s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[526.064259] Starting subtest: bad-pixel-format-y-tiled-ccs
[526.065056] Starting dynamic subtest: pipe-A-DP-4
[526.072916] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[526.083567] Starting dynamic subtest: pipe-B-DP-4
[526.098213] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[526.108807] Starting dynamic subtest: pipe-C-DP-4
[526.116364] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[526.126548] Starting dynamic subtest: pipe-D-DP-4
[526.134217] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[526.135765] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.007s)
[526.454270] [100/130] (575s left) i915_query (hwconfig_table)
[526.557036] Starting subtest: hwconfig_table
[526.692557] Subtest hwconfig_table: SUCCESS (0.001s)
[526.741140] [101/130] (574s left) gem_exec_gttfill (all-engines)
[526.836181] Starting subtest: all-engines
[552.656987] Subtest all-engines: SUCCESS (25.816s)
[552.900236] [102/130] (548s left) gem_mmap_offset (bad-object)
[553.006038] Starting subtest: bad-object
[553.006835] Subtest bad-object: SUCCESS (0.000s)
[553.098334] [103/130] (548s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[553.475392] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[553.608559] [104/130] (548s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[553.852098] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[553.853832] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[553.984061] [105/130] (547s left) kms_plane_lowres (tiling-x)
[554.233283] Starting subtest: tiling-x
[554.234232] Starting dynamic subtest: pipe-A-DP-4
[564.709311] Dynamic subtest pipe-A-DP-4: SUCCESS (10.472s)
[564.811309] Starting dynamic subtest: pipe-B-DP-4
[574.956448] Dynamic subtest pipe-B-DP-4: SUCCESS (10.155s)
[575.074255] Starting dynamic subtest: pipe-C-DP-4
[585.568560] Dynamic subtest pipe-C-DP-4: SUCCESS (10.502s)
[585.686548] Starting dynamic subtest: pipe-D-DP-4
[596.295628] Dynamic subtest pipe-D-DP-4: SUCCESS (10.617s)
[596.384545] Subtest tiling-x: SUCCESS (42.144s)
[596.658186] [106/130] (505s left) gem_exec_reloc (basic-write-cpu-active)
[596.756864] Subtest basic-write-cpu-active: SKIP (0.000s)
[596.823444] [107/130] (505s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[597.083113] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[597.110768] [108/130] (504s left) gem_create (create-valid-nonaligned)
[597.189043] Starting subtest: create-valid-nonaligned
[597.189852] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[597.418884] [109/130] (504s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[597.508119] Starting subtest: y-tiled-ccs-to-y-tiled
[597.509735] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[597.718213] [110/130] (504s left) gem_exec_balancer (parallel-out-fence)
[598.046320] Starting subtest: parallel-out-fence
[599.995407] Subtest parallel-out-fence: SUCCESS (1.949s)
[600.107458] [111/130] (501s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[600.344093] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[600.345758] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[600.442956] [112/130] (501s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[600.681608] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[600.695655] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.013s)
[600.772947] [113/130] (501s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[601.019166] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[603.548769] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.529s)
[603.712894] [114/130] (498s left) sysfs_preempt_timeout (timeout)
[603.789133] Starting subtest: timeout
[603.791158] Starting dynamic subtest: vecs0
[605.837023] Dynamic subtest vecs0: SUCCESS (2.046s)
[605.848835] Starting dynamic subtest: ccs0
[607.756112] Dynamic subtest ccs0: SUCCESS (1.918s)
[607.768915] Starting dynamic subtest: vcs0
[609.545886] Dynamic subtest vcs0: SUCCESS (1.788s)
[609.558713] Starting dynamic subtest: bcs0
[611.284901] Dynamic subtest bcs0: SUCCESS (1.737s)
[611.296688] Starting dynamic subtest: vecs1
[612.983718] Dynamic subtest vecs1: SUCCESS (1.697s)
[612.995717] Starting dynamic subtest: rcs0
[614.717993] Dynamic subtest rcs0: SUCCESS (1.733s)
[614.733602] Starting dynamic subtest: vcs1
[616.434743] Dynamic subtest vcs1: SUCCESS (1.715s)
[616.435513] Subtest timeout: SUCCESS (12.643s)
[616.563579] [115/130] (485s left) sw_sync (sync_multi_timeline_wait)
[616.629941] Starting subtest: sync_multi_timeline_wait
[616.630756] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[616.671276] [116/130] (485s left) kms_lease (empty-lease)
[616.903018] Starting subtest: empty-lease
[616.903808] Starting dynamic subtest: pipe-A-DP-4
[616.904609] Dynamic subtest pipe-A-DP-4: SUCCESS (0.001s)
[616.918237] Starting dynamic subtest: pipe-B-DP-4
[616.919035] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[616.930270] Starting dynamic subtest: pipe-C-DP-4
[616.931065] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[616.942108] Starting dynamic subtest: pipe-D-DP-4
[616.942948] Dynamic subtest pipe-D-DP-4: SUCCESS (0.002s)
[616.943732] Subtest empty-lease: SUCCESS (0.013s)
[617.010638] [117/130] (485s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[617.264521] Starting subtest: cursorA-vs-flipA-varying-size
[628.233637] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.966s)
[628.495406] [118/130] (473s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[628.739687] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[628.740610] Starting dynamic subtest: pipe-A-DP-4
[628.745041] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[628.760394] Starting dynamic subtest: pipe-B-DP-4
[628.763589] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[628.775041] Starting dynamic subtest: pipe-C-DP-4
[628.778169] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[628.789566] Starting dynamic subtest: pipe-D-DP-4
[628.792615] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[628.794137] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.013s)
[629.177180] [119/130] (473s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[629.267063] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[629.268629] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[629.485040] [120/130] (472s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[629.721190] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[629.722005] Starting dynamic subtest: pipe-A-DP-4
[636.130240] Dynamic subtest pipe-A-DP-4: SUCCESS (6.407s)
[636.149231] Starting dynamic subtest: pipe-B-DP-4
[637.724595] Dynamic subtest pipe-B-DP-4: SUCCESS (1.590s)
[637.772132] Starting dynamic subtest: pipe-C-DP-4
[639.333664] Dynamic subtest pipe-C-DP-4: SUCCESS (1.600s)
[639.381608] Starting dynamic subtest: pipe-D-DP-4
[640.942911] Dynamic subtest pipe-D-DP-4: SUCCESS (1.600s)
[640.945500] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SUCCESS (11.222s)
[641.271298] [121/130] (461s left) kms_psr (psr2-sprite-mmap-gtt)
[641.515196] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[641.548286] [122/130] (460s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[641.780228] Starting subtest: plane-use-after-nonblocking-unbind
[641.783126] Starting dynamic subtest: pipe-A-DP-4
[641.848808] Dynamic subtest pipe-A-DP-4: SUCCESS (0.066s)
[641.965948] Starting dynamic subtest: pipe-B-DP-4
[642.078915] Dynamic subtest pipe-B-DP-4: SUCCESS (0.152s)
[642.132956] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.352s)
[642.385505] [123/130] (460s left) kms_chamelium_hpd (hdmi-hpd-storm)
[642.709384] Subtest hdmi-hpd-storm: SKIP (0.000s)
[642.829913] [124/130] (459s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[642.909674] Starting subtest: multi-wait-for-submit-submitted-signaled
[642.910566] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[643.040140] [125/130] (459s left) kms_async_flips (async-flip-with-page-flip-events)
[643.289545] Starting subtest: async-flip-with-page-flip-events
[643.474792] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs
[643.738483] Dynamic subtest pipe-A-DP-4-4-mc-ccs: SKIP (0.262s)
[643.752429] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc
[643.896866] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc: SKIP (0.157s)
[643.908790] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs
[644.062998] Dynamic subtest pipe-A-DP-4-4-rc-ccs: SKIP (0.165s)
[644.074569] Starting dynamic subtest: pipe-A-DP-4-4
[646.203636] Dynamic subtest pipe-A-DP-4-4: SUCCESS (2.143s)
[646.215367] Starting dynamic subtest: pipe-A-DP-4-x
[648.368615] Dynamic subtest pipe-A-DP-4-x: SUCCESS (2.166s)
[648.381790] Starting dynamic subtest: pipe-A-DP-4-linear
[650.535265] Dynamic subtest pipe-A-DP-4-linear: SUCCESS (2.166s)
[650.716302] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs
[650.924726] Dynamic subtest pipe-B-DP-4-4-mc-ccs: SKIP (0.219s)
[650.938997] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc
[651.053224] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc: SKIP (0.127s)
[651.064918] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs
[651.203341] Dynamic subtest pipe-B-DP-4-4-rc-ccs: SKIP (0.150s)
[651.214778] Starting dynamic subtest: pipe-B-DP-4-4
[653.326013] Dynamic subtest pipe-B-DP-4-4: SUCCESS (2.124s)
[653.337852] Starting dynamic subtest: pipe-B-DP-4-x
[655.474614] Dynamic subtest pipe-B-DP-4-x: SUCCESS (2.149s)
[655.486660] Starting dynamic subtest: pipe-B-DP-4-linear
[657.607965] Dynamic subtest pipe-B-DP-4-linear: SUCCESS (2.132s)
[657.793298] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs
[658.014378] Dynamic subtest pipe-C-DP-4-4-mc-ccs: SKIP (0.233s)
[658.026505] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc
[658.126982] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc: SKIP (0.112s)
[658.138667] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs
[658.277237] Dynamic subtest pipe-C-DP-4-4-rc-ccs: SKIP (0.150s)
[658.288825] Starting dynamic subtest: pipe-C-DP-4-4
[660.400380] Dynamic subtest pipe-C-DP-4-4: SUCCESS (2.124s)
[660.412293] Starting dynamic subtest: pipe-C-DP-4-x
[662.532190] Dynamic subtest pipe-C-DP-4-x: SUCCESS (2.132s)
[662.544331] Starting dynamic subtest: pipe-C-DP-4-linear
[664.682035] Dynamic subtest pipe-C-DP-4-linear: SUCCESS (2.149s)
[664.867180] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs
[665.073666] Dynamic subtest pipe-D-DP-4-4-mc-ccs: SKIP (0.220s)
[665.091070] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc
[665.213746] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc: SKIP (0.139s)
[665.225683] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs
[665.363894] Dynamic subtest pipe-D-DP-4-4-rc-ccs: SKIP (0.150s)
[665.375510] Starting dynamic subtest: pipe-D-DP-4-4
[667.487353] Dynamic subtest pipe-D-DP-4-4: SUCCESS (2.125s)
[667.500116] Starting dynamic subtest: pipe-D-DP-4-x
[669.619900] Dynamic subtest pipe-D-DP-4-x: SUCCESS (2.132s)
[669.631962] Starting dynamic subtest: pipe-D-DP-4-linear
[671.770357] Dynamic subtest pipe-D-DP-4-linear: SUCCESS (2.149s)
[671.772190] Subtest async-flip-with-page-flip-events: SUCCESS (28.498s)
[672.219571] [126/130] (430s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[672.455633] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[672.457246] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[672.553449] [127/130] (430s left) gem_ctx_persistence (hostile)
[672.650790] Starting subtest: hostile
[674.177992] Subtest hostile: FAIL (1.513s)
[674.296791] [128/130] (428s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[674.524276] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[674.525950] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[674.656353] [129/130] (428s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[674.904485] Starting subtest: plane-upscale-20x20-with-rotation
[674.905398] Starting dynamic subtest: pipe-A
[675.303753] Dynamic subtest pipe-A: SUCCESS (0.399s)
[675.336327] Starting dynamic subtest: pipe-B
[675.795207] Dynamic subtest pipe-B: SUCCESS (0.489s)
[675.822741] Starting dynamic subtest: pipe-C
[676.286005] Dynamic subtest pipe-C: SUCCESS (0.489s)
[676.315432] Starting dynamic subtest: pipe-D
[676.776974] Dynamic subtest pipe-D: SUCCESS (0.489s)
[676.778116] Subtest plane-upscale-20x20-with-rotation: SUCCESS (1.875s)
[677.053602] [130/130] (425s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[677.155153] Starting subtest: yf-tiled-to-vebox-y-tiled
[677.156735] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[677.387570] Closing watchdogs
Done.