[65.624989] Initializing watchdogs
[65.625245]   /dev/watchdog0
[65.644750] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[65.655406] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.659083] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.662039] [001/134] (960s left) gem_ccs (block-multicopy-compressed)
[65.746384] Starting subtest: block-multicopy-compressed
[65.747296] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[65.801826] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.055s)
[65.809606] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[65.902378] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.100s)
[65.909902] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[65.918943] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[65.926456] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[66.032966] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.113s)
[66.040410] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[66.049052] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[66.056506] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[66.149913] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.101s)
[66.157382] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[66.167369] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.017s)
[66.174854] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[66.270560] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.103s)
[66.271479] Subtest block-multicopy-compressed: SUCCESS (0.524s)
[66.441446] [002/134] (959s left) kms_vrr (negative-basic)
[66.620923] Starting subtest: negative-basic
[66.623474] Starting dynamic subtest: pipe-A-DP-3
[72.070123] Dynamic subtest pipe-A-DP-3: SUCCESS (5.445s)
[72.160489] Subtest negative-basic: SUCCESS (5.539s)
[72.424180] [003/134] (953s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[72.602582] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[72.604268] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[72.807460] [004/134] (953s left) gem_mmap_offset (partial-remap)
[72.876938] Starting subtest: partial-remap
[72.877855] Starting dynamic subtest: lmem0
[72.880608] Dynamic subtest lmem0: SUCCESS (0.004s)
[72.889237] Starting dynamic subtest: smem0
[72.891582] Dynamic subtest smem0: SUCCESS (0.004s)
[72.892591] Subtest partial-remap: SUCCESS (0.009s)
[73.100386] [005/134] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[73.278438] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[73.280120] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[73.472291] [006/134] (953s left) kms_plane_scaling (planes-downscale-factor-0-75)
[73.651475] Starting subtest: planes-downscale-factor-0-75
[73.652300] Starting dynamic subtest: pipe-A
[73.746343] Dynamic subtest pipe-A: SUCCESS (0.095s)
[73.757383] Starting dynamic subtest: pipe-B
[73.945411] Dynamic subtest pipe-B: SUCCESS (0.199s)
[73.958038] Starting dynamic subtest: pipe-C
[74.174303] Dynamic subtest pipe-C: SUCCESS (0.229s)
[74.182808] Starting dynamic subtest: pipe-D
[74.370834] Dynamic subtest pipe-D: SUCCESS (0.196s)
[74.371759] Subtest planes-downscale-factor-0-75: SUCCESS (0.719s)
[74.730945] [007/134] (951s left) gem_exec_whisper (basic-queues-all)
[74.812693] Starting subtest: basic-queues-all
[96.497889] Subtest basic-queues-all: SUCCESS (21.684s)
[96.758807] [008/134] (929s left) kms_plane (plane-position-covered)
[96.931917] Starting subtest: plane-position-covered
[97.352230] Starting dynamic subtest: pipe-A-plane-1
[97.800263] Dynamic subtest pipe-A-plane-1: SUCCESS (0.447s)
[97.818968] Starting dynamic subtest: pipe-A-plane-2
[98.265451] Dynamic subtest pipe-A-plane-2: SUCCESS (0.466s)
[98.275220] Starting dynamic subtest: pipe-A-plane-3
[98.722414] Dynamic subtest pipe-A-plane-3: SUCCESS (0.456s)
[98.732240] Starting dynamic subtest: pipe-A-plane-4
[99.163640] Dynamic subtest pipe-A-plane-4: SUCCESS (0.441s)
[99.174359] Starting dynamic subtest: pipe-A-plane-5
[99.190450] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[99.529735] Starting dynamic subtest: pipe-B-plane-1
[99.944155] Dynamic subtest pipe-B-plane-1: SUCCESS (0.422s)
[99.952629] Starting dynamic subtest: pipe-B-plane-2
[100.363082] Dynamic subtest pipe-B-plane-2: SUCCESS (0.418s)
[100.371282] Starting dynamic subtest: pipe-B-plane-3
[100.815154] Dynamic subtest pipe-B-plane-3: SUCCESS (0.452s)
[100.823471] Starting dynamic subtest: pipe-B-plane-4
[101.253164] Dynamic subtest pipe-B-plane-4: SUCCESS (0.438s)
[101.261369] Starting dynamic subtest: pipe-B-plane-5
[101.273585] Dynamic subtest pipe-B-plane-5: SUCCESS (0.020s)
[101.274444] Subtest plane-position-covered: SUCCESS (4.342s)
[101.592968] [009/134] (925s left) gem_ctx_isolation (clean)
[101.672402] Starting subtest: clean
[101.673302] Starting dynamic subtest: rcs0
[101.793151] Dynamic subtest rcs0: SUCCESS (0.121s)
[101.801616] Starting dynamic subtest: bcs0
[101.927445] Dynamic subtest bcs0: SUCCESS (0.133s)
[101.935581] Starting dynamic subtest: vcs0
[102.046640] Dynamic subtest vcs0: SUCCESS (0.120s)
[102.054713] Starting dynamic subtest: vcs1
[102.172707] Dynamic subtest vcs1: SUCCESS (0.126s)
[102.180937] Starting dynamic subtest: vecs0
[102.281329] Dynamic subtest vecs0: SUCCESS (0.108s)
[102.289532] Starting dynamic subtest: vecs1
[102.407416] Dynamic subtest vecs1: SUCCESS (0.126s)
[102.415545] Starting dynamic subtest: ccs0
[102.525582] Dynamic subtest ccs0: SUCCESS (0.118s)
[102.526456] Subtest clean: SUCCESS (0.853s)
[102.810173] [010/134] (923s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[102.997065] Starting subtest: y-tiled-8bpp-rotate-0
[102.998927] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[103.193470] [011/134] (923s left) sw_sync (sync_multi_consumer)
[103.236465] Starting subtest: sync_multi_consumer
[103.561666] Subtest sync_multi_consumer: SUCCESS (0.326s)
[103.676051] [012/134] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[103.862577] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[103.864326] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[104.014520] [013/134] (922s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[104.374101] Starting subtest: cursor-rapid-movement-64x21
[104.377922] Starting dynamic subtest: pipe-A-DP-3
[104.881728] Dynamic subtest pipe-A-DP-3: SUCCESS (0.503s)
[104.927434] Starting dynamic subtest: pipe-D-DP-3
[105.292629] Dynamic subtest pipe-D-DP-3: SUCCESS (0.372s)
[105.293594] Subtest cursor-rapid-movement-64x21: SUCCESS (0.918s)
[105.773455] [014/134] (921s left) kms_chamelium_frames (hdmi-crc-single)
[106.037374] Subtest hdmi-crc-single: SKIP (0.000s)
[106.186713] [015/134] (920s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[106.365522] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[106.367251] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[106.559504] [016/134] (920s left) gem_mmap_wc (invalid-flags)
[106.630171] Subtest invalid-flags: SKIP (0.000s)
[106.686770] [017/134] (920s left) gem_flink_race (flink_name)
[106.729168] Starting subtest: flink_name
[112.126471] Subtest flink_name: SUCCESS (5.397s)
[112.312430] [018/134] (915s left) gem_exec_params (invalid-fence-in)
[112.430531] Starting subtest: invalid-fence-in
[112.431441] Subtest invalid-fence-in: SUCCESS (0.000s)
[112.607473] [019/134] (914s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[112.679391] Starting subtest: rel-constants-invalid-rel-gen5
[112.680343] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[112.858259] [020/134] (914s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[113.035861] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[113.036751] Starting dynamic subtest: pipe-A-DP-3
[113.045122] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[113.053299] Starting dynamic subtest: pipe-B-DP-3
[113.061470] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[113.069482] Starting dynamic subtest: pipe-C-DP-3
[113.077584] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[113.085525] Starting dynamic subtest: pipe-D-DP-3
[113.095120] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[113.097138] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[113.500901] [021/134] (914s left) gem_exec_schedule (preempt-engines)
[113.584384] Starting subtest: preempt-engines
[113.585342] Starting dynamic subtest: rcs0
[115.807893] Dynamic subtest rcs0: SUCCESS (2.222s)
[115.819624] Starting dynamic subtest: bcs0
[117.977946] Dynamic subtest bcs0: SUCCESS (2.168s)
[117.989507] Starting dynamic subtest: vcs0
[120.253121] Dynamic subtest vcs0: SUCCESS (2.274s)
[120.265467] Starting dynamic subtest: vcs1
[122.530630] Dynamic subtest vcs1: SUCCESS (2.276s)
[122.543270] Starting dynamic subtest: vecs0
[124.808202] Dynamic subtest vecs0: SUCCESS (2.276s)
[124.820430] Starting dynamic subtest: vecs1
[127.091693] Dynamic subtest vecs1: SUCCESS (2.282s)
[127.104273] Starting dynamic subtest: ccs0
[129.298532] Dynamic subtest ccs0: SUCCESS (2.205s)
[129.300245] Subtest preempt-engines: SUCCESS (15.714s)
[129.740964] [022/134] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[129.924551] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[129.926201] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[130.105531] [023/134] (897s left) api_intel_bb (blit-reloc-keep-cache)
[130.173198] Starting subtest: blit-reloc-keep-cache
[130.175164] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[130.334726] [024/134] (897s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[130.401844] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[130.511344] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[130.673272] [025/134] (897s left) kms_sequence (get-idle)
[130.852816] Starting subtest: get-idle
[130.853706] Starting dynamic subtest: pipe-A-DP-3
[133.252275] Dynamic subtest pipe-A-DP-3: SUCCESS (2.398s)
[133.261908] Starting dynamic subtest: pipe-B-DP-3
[135.570568] Dynamic subtest pipe-B-DP-3: SUCCESS (2.317s)
[135.578920] Starting dynamic subtest: pipe-C-DP-3
[137.856869] Dynamic subtest pipe-C-DP-3: SUCCESS (2.285s)
[137.865230] Starting dynamic subtest: pipe-D-DP-3
[140.165288] Dynamic subtest pipe-D-DP-3: SUCCESS (2.307s)
[140.166340] Subtest get-idle: SUCCESS (9.312s)
[140.461328] [026/134] (887s left) kms_flip (flip-vs-suspend)
[140.637474] Starting subtest: flip-vs-suspend
[140.641522] Starting dynamic subtest: A-DP3
[179.906169] Dynamic subtest A-DP3: SUCCESS (7.845s)
[179.918220] Starting dynamic subtest: B-DP3
[219.025013] Dynamic subtest B-DP3: SUCCESS (7.193s)
[219.035450] Starting dynamic subtest: C-DP3
[258.275191] Dynamic subtest C-DP3: SUCCESS (7.201s)
[258.288277] Starting dynamic subtest: D-DP3
[298.293250] Dynamic subtest D-DP3: SUCCESS (7.264s)
[298.294004] Subtest flip-vs-suspend: SUCCESS (29.512s)
[298.581421] [027/134] (729s left) intel_hwmon (hwmon-read)
[298.658513] Starting subtest: hwmon-read
[298.660581] Subtest hwmon-read: SUCCESS (0.001s)
[298.834099] [028/134] (729s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[299.019339] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[299.101021] [029/134] (729s left) kms_atomic_interruptible (legacy-setmode)
[299.282240] Starting subtest: legacy-setmode
[299.283153] Starting dynamic subtest: pipe-A-DP-3
[306.175246] Dynamic subtest pipe-A-DP-3: SUCCESS (6.889s)
[306.176121] Subtest legacy-setmode: SUCCESS (6.890s)
[306.526784] [030/134] (721s left) gem_exec_endless (dispatch)
[306.620063] Starting subtest: dispatch
[306.620991] Starting dynamic subtest: rcs0
[306.629340] Dynamic subtest rcs0: SUCCESS (0.009s)
[306.640128] Starting dynamic subtest: bcs0
[306.641975] Dynamic subtest bcs0: SUCCESS (0.009s)
[306.652591] Starting dynamic subtest: vcs0
[306.654320] Dynamic subtest vcs0: SUCCESS (0.006s)
[306.664709] Starting dynamic subtest: vcs1
[306.666458] Dynamic subtest vcs1: SUCCESS (0.006s)
[306.677010] Starting dynamic subtest: vecs0
[306.678719] Dynamic subtest vecs0: SUCCESS (0.006s)
[306.690063] Starting dynamic subtest: vecs1
[306.691860] Dynamic subtest vecs1: SUCCESS (0.006s)
[306.702278] Starting dynamic subtest: ccs0
[306.704346] Dynamic subtest ccs0: SUCCESS (0.009s)
[306.705311] Subtest dispatch: SUCCESS (0.057s)
[306.861613] [031/134] (721s left) kms_addfb_basic (addfb25-bad-modifier)
[307.038305] Starting subtest: addfb25-bad-modifier
[307.039221] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[307.181611] [032/134] (721s left) gem_ctx_param (invalid-size-get)
[307.249733] Starting subtest: invalid-size-get
[307.251622] Subtest invalid-size-get: SUCCESS (0.001s)
[307.391934] [033/134] (721s left) vgem_basic (second-client)
[307.488538] Starting subtest: second-client
[307.522128] Subtest second-client: SUCCESS (0.033s)
[307.686335] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[307.688328] [034/134] (720s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[307.889155] Starting subtest: 4-tiled-16bpp-rotate-180
[309.756736] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.866s)
[309.961889] [035/134] (718s left) gem_render_copy (y-tiled-ccs-to-linear)
[310.048569] Starting subtest: y-tiled-ccs-to-linear
[310.050575] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[310.342409] [036/134] (718s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-cpu)
[310.529778] Starting subtest: fbcpsr-abgr161616f-draw-mmap-cpu
[310.531406] Subtest fbcpsr-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[310.724312] [037/134] (718s left) gem_exec_reloc (basic-wc-read)
[310.809829] Subtest basic-wc-read: SKIP (0.000s)
[310.904603] [038/134] (717s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[311.109488] Starting subtest: psr-rgb101010-draw-pwrite
[311.111498] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[311.323358] [039/134] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[311.513865] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[311.515578] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[311.674718] [040/134] (717s left) gem_exec_reloc (basic-cpu-gtt-active)
[311.758614] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[311.863106] [041/134] (717s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[312.055088] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[312.056718] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[312.239048] [042/134] (716s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[312.430009] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[312.431635] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[312.615482] [043/134] (716s left) kms_psr (psr-dpms)
[312.799608] Subtest psr-dpms: SKIP (0.000s)
[312.865433] [044/134] (716s left) gem_mmap (big-bo)
[312.941215] Subtest big-bo: SKIP (0.000s)
[313.019734] [045/134] (716s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[313.209310] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[313.211064] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[313.425960] [046/134] (715s left) gem_ctx_engines (execute-allforone)
[313.518371] Starting subtest: execute-allforone
[313.559582] Subtest execute-allforone: SUCCESS (0.042s)
[313.890833] [047/134] (715s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[314.078668] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[314.094157] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.015s)
[314.227237] [048/134] (715s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[314.422533] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[314.424349] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[314.607889] [049/134] (715s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[314.800794] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[314.802441] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[315.008009] [050/134] (714s left) kms_content_protection (legacy-hdcp14)
[315.268587] Starting subtest: legacy-hdcp14
[315.544384] Starting dynamic subtest: pipe-A-DP-3
[436.769223] Dynamic subtest pipe-A-DP-3: FAIL (120.955s)
[436.770324] Subtest legacy-hdcp14: FAIL (121.341s)
[436.944963] [051/134] (592s left) i915_pm_freq_api (freq-reset-multiple)
[437.036551] Starting subtest: freq-reset-multiple
[437.037452] Starting dynamic subtest: gt0
[458.858755] Dynamic subtest gt0: SUCCESS (21.821s)
[458.859635] Subtest freq-reset-multiple: SUCCESS (21.822s)
[458.983586] [052/134] (570s left) gem_exec_params (mmapped)
[459.066953] Starting subtest: mmapped
[459.069035] Subtest mmapped: SUCCESS (0.002s)
[459.225443] [053/134] (570s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[459.306773] Starting subtest: x-tiled-to-vebox-y-tiled
[459.308826] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[459.597665] [054/134] (570s left) gen7_exec_parse (load-register-reg)
[459.685259] Subtest load-register-reg: SKIP (0.000s)
[459.755053] [055/134] (570s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[459.954934] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[461.196148] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.240s)
[461.393532] [056/134] (568s left) kms_pm_backlight (fade-with-suspend)
[461.576295] Subtest fade-with-suspend: SKIP (0.000s)
[461.639330] [057/134] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[461.830807] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[461.832433] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[462.006757] [058/134] (568s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[462.197644] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[462.254502] [059/134] (568s left) sysfs_timeslice_duration (timeout)
[462.336755] Starting subtest: timeout
[462.337648] Starting dynamic subtest: vecs0
[464.188554] Dynamic subtest vecs0: SUCCESS (1.851s)
[464.199843] Starting dynamic subtest: ccs0
[466.044156] Dynamic subtest ccs0: SUCCESS (1.854s)
[466.056349] Starting dynamic subtest: vcs0
[467.804372] Dynamic subtest vcs0: SUCCESS (1.759s)
[467.815824] Starting dynamic subtest: bcs0
[468.983391] Dynamic subtest bcs0: SUCCESS (1.178s)
[468.994813] Starting dynamic subtest: vecs1
[470.810375] Dynamic subtest vecs1: SUCCESS (1.826s)
[470.822323] Starting dynamic subtest: rcs0
[472.599484] Dynamic subtest rcs0: SUCCESS (1.788s)
[472.611356] Starting dynamic subtest: vcs1
[474.345543] Dynamic subtest vcs1: SUCCESS (1.745s)
[474.346461] Subtest timeout: SUCCESS (12.008s)
[474.531949] [060/134] (555s left) kms_cdclk (mode-transition-all-outputs)
[474.716392] Starting subtest: mode-transition-all-outputs
[474.789792] Subtest mode-transition-all-outputs: SKIP (0.073s)
[475.020514] [061/134] (555s left) gem_pxp (create-valid-protected-context)
[477.625362] Starting subtest: create-valid-protected-context
[477.627547] Subtest create-valid-protected-context: SKIP (0.000s)
[477.775213] [062/134] (552s left) gem_ctx_shared (exec-shared-gtt)
[477.864374] Starting subtest: exec-shared-gtt
[477.865244] Starting dynamic subtest: rcs0
[477.872121] Dynamic subtest rcs0: SUCCESS (0.008s)
[477.883560] Starting dynamic subtest: bcs0
[477.884453] Dynamic subtest bcs0: SUCCESS (0.008s)
[477.896584] Starting dynamic subtest: vcs0
[477.897467] Dynamic subtest vcs0: SUCCESS (0.006s)
[477.908612] Starting dynamic subtest: vcs1
[477.909561] Dynamic subtest vcs1: SUCCESS (0.006s)
[477.920848] Starting dynamic subtest: vecs0
[477.921903] Dynamic subtest vecs0: SUCCESS (0.006s)
[477.933758] Starting dynamic subtest: vecs1
[477.934966] Dynamic subtest vecs1: SUCCESS (0.006s)
[477.946091] Starting dynamic subtest: ccs0
[477.947401] Dynamic subtest ccs0: SUCCESS (0.007s)
[477.948661] Subtest exec-shared-gtt: SUCCESS (0.054s)
[478.239759] [063/134] (552s left) prime_vgem (basic-fence-flip)
[478.329911] Starting subtest: basic-fence-flip
[478.453955] Subtest basic-fence-flip: SKIP (0.123s)
[478.659931] [064/134] (552s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[478.844409] Starting subtest: cursorA-vs-flipB-varying-size
[478.846339] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[479.010984] [065/134] (551s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[479.197330] Starting subtest: nonblocking-crc-frame-sequence
[479.198213] Starting dynamic subtest: pipe-A-DP-3
[479.898070] Dynamic subtest pipe-A-DP-3: SUCCESS (0.699s)
[479.910784] Starting dynamic subtest: pipe-B-DP-3
[480.548051] Dynamic subtest pipe-B-DP-3: SUCCESS (0.648s)
[480.562485] Starting dynamic subtest: pipe-C-DP-3
[481.204683] Dynamic subtest pipe-C-DP-3: SUCCESS (0.655s)
[481.220310] Starting dynamic subtest: pipe-D-DP-3
[481.831884] Dynamic subtest pipe-D-DP-3: SUCCESS (0.625s)
[481.832790] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.635s)
[482.132651] [066/134] (548s left) syncobj_timeline (etime-single-wait-all-submitted)
[482.211638] Starting subtest: etime-single-wait-all-submitted
[482.315683] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[482.479582] [067/134] (548s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[482.662894] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[482.665251] Starting dynamic subtest: pipe-A-valid-mode
[485.669459] Dynamic subtest pipe-A-valid-mode: SUCCESS (3.004s)
[485.674026] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (3.008s)
[486.208755] [068/134] (544s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[486.289434] Starting subtest: multi-wait-for-submit-submitted-signaled
[486.290389] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[486.478587] [069/134] (544s left) gem_mmap_gtt (cpuset-medium-copy)
[486.560340] Subtest cpuset-medium-copy: SKIP (0.000s)
[486.636834] [070/134] (544s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[486.825774] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[486.889175] [071/134] (544s left) gem_exec_schedule (wide)
[487.096559] Starting subtest: wide
[487.097522] Starting dynamic subtest: rcs0
[499.505520] Dynamic subtest rcs0: SUCCESS (12.408s)
[499.517432] Starting dynamic subtest: bcs0
[512.322670] Dynamic subtest bcs0: SUCCESS (12.815s)
[512.334536] Starting dynamic subtest: vcs0
[525.522013] Dynamic subtest vcs0: SUCCESS (13.199s)
[525.534914] Starting dynamic subtest: vcs1
[538.816201] Dynamic subtest vcs1: SUCCESS (13.293s)
[538.828007] Starting dynamic subtest: vecs0
[551.823499] Dynamic subtest vecs0: SUCCESS (13.006s)
[551.835389] Starting dynamic subtest: vecs1
[564.715106] Dynamic subtest vecs1: SUCCESS (12.891s)
[564.727283] Starting dynamic subtest: ccs0
[578.077365] Dynamic subtest ccs0: SUCCESS (13.361s)
[578.078331] Subtest wide: SUCCESS (90.979s)
[580.001968] [072/134] (451s left) gem_pipe_control_store_loop (fresh-buffer)
[580.087325] Starting subtest: fresh-buffer
[582.267517] Subtest fresh-buffer: SUCCESS (2.180s)
[582.532749] [073/134] (448s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[582.722090] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[582.747528] Starting dynamic subtest: pipe-A-plane-0
[582.749355] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[582.761244] Starting dynamic subtest: pipe-A-plane-3
[582.763171] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[582.774627] Starting dynamic subtest: pipe-A-plane-5
[582.776390] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[582.978977] Starting dynamic subtest: pipe-B-plane-0
[582.981089] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[583.001305] Starting dynamic subtest: pipe-B-plane-3
[583.003234] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[583.016860] Starting dynamic subtest: pipe-B-plane-5
[583.018581] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[583.069113] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.345s)
[583.327485] [074/134] (448s left) gem_eio (hibernate)
[583.658762] Starting subtest: hibernate
[598.943912] Subtest hibernate: SUCCESS (15.286s)
[608.786394] [075/134] (431s left) kms_psr (fbc-psr-sprite-plane-onoff)
[608.987432] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[609.077896] [076/134] (431s left) kms_cursor_crc (cursor-onscreen-128x42)
[609.470074] Starting subtest: cursor-onscreen-128x42
[609.475173] Starting dynamic subtest: pipe-A-DP-3
[612.157343] Dynamic subtest pipe-A-DP-3: SUCCESS (2.681s)
[612.196111] Starting dynamic subtest: pipe-D-DP-3
[614.888492] Dynamic subtest pipe-D-DP-3: SUCCESS (2.703s)
[614.889442] Subtest cursor-onscreen-128x42: SUCCESS (5.418s)
[615.310793] [077/134] (425s left) kms_cursor_crc (cursor-sliding-max-size)
[615.811724] Starting subtest: cursor-sliding-max-size
[615.814319] Subtest cursor-sliding-max-size: SKIP (0.000s)
[616.089883] [078/134] (424s left) gem_softpin (noreloc-s3)
[616.173687] Starting subtest: noreloc-S3
[636.888901] Subtest noreloc-S3: SUCCESS (5.481s)
[637.106171] [079/134] (403s left) syncobj_timeline (wait-all-complex)
[637.202329] Starting subtest: wait-all-complex
[637.419805] Subtest wait-all-complex: SUCCESS (0.216s)
[637.576629] [080/134] (403s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[637.773090] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[637.775432] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[637.977470] [081/134] (403s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[638.060445] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[638.062334] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[638.333453] [082/134] (402s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[638.517144] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[638.518871] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[638.838854] [083/134] (402s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[639.023378] Starting subtest: multiplane-rotation-cropping-top
[666.823706] Subtest multiplane-rotation-cropping-top: SUCCESS (27.799s)
[667.060481] [084/134] (374s left) gem_pread (display)
[667.141031] Subtest display: SKIP (0.000s)
[667.234050] [085/134] (374s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[667.960109] Starting subtest: syncobj-timeline-invalid-wait
[667.961246] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.006s)
[668.287014] [086/134] (373s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[668.472022] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[668.473789] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[668.652977] [087/134] (373s left) gem_exec_balancer (full-pulse)
[668.747509] Starting subtest: full-pulse
[670.835241] Subtest full-pulse: SUCCESS (2.088s)
[671.252264] [088/134] (370s left) gem_exec_reloc (basic-gtt-wc)
[671.334310] Subtest basic-gtt-wc: SKIP (0.000s)
[671.447264] [089/134] (370s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[671.631332] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[671.653402] Starting dynamic subtest: pipe-A-plane-0
[671.655171] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[671.669052] Starting dynamic subtest: pipe-A-plane-3
[671.670810] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[671.684251] Starting dynamic subtest: pipe-A-plane-5
[671.686030] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[671.890291] Starting dynamic subtest: pipe-B-plane-0
[671.892254] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[671.912251] Starting dynamic subtest: pipe-B-plane-3
[671.914107] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[671.928092] Starting dynamic subtest: pipe-B-plane-5
[671.929897] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[671.976759] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.345s)
[672.251110] [090/134] (369s left) kms_big_fb (linear-8bpp-rotate-90)
[672.455120] Starting subtest: linear-8bpp-rotate-90
[672.513752] Subtest linear-8bpp-rotate-90: SKIP (0.057s)
[672.762721] [091/134] (369s left) gem_eio (in-flight-contexts-10ms)
[673.061791] Starting subtest: in-flight-contexts-10ms
[686.326097] Subtest in-flight-contexts-10ms: SUCCESS (13.266s)
[686.605779] [092/134] (355s left) gem_spin_batch (spin-all-new)
[686.688370] Starting subtest: spin-all-new
[686.745098] Subtest spin-all-new: SUCCESS (0.057s)
[687.099959] [093/134] (355s left) api_intel_bb (destroy-bb)
[687.174563] Starting subtest: destroy-bb
[687.211361] Subtest destroy-bb: SUCCESS (0.037s)
[687.431782] [094/134] (354s left) gem_exec_schedule (thriceslice)
[687.518362] Starting subtest: thriceslice
[687.519271] Starting dynamic subtest: rcs0
[687.549814] Dynamic subtest rcs0: SUCCESS (0.031s)
[687.566835] Starting dynamic subtest: bcs0
[687.603361] Dynamic subtest bcs0: SUCCESS (0.052s)
[687.627820] Starting dynamic subtest: vcs0
[687.639407] Dynamic subtest vcs0: SUCCESS (0.034s)
[687.663419] Starting dynamic subtest: vcs1
[687.676420] Dynamic subtest vcs1: SUCCESS (0.035s)
[687.695341] Starting dynamic subtest: vecs0
[687.711574] Dynamic subtest vecs0: SUCCESS (0.034s)
[687.729007] Starting dynamic subtest: vecs1
[687.765597] Dynamic subtest vecs1: SUCCESS (0.053s)
[687.785992] Starting dynamic subtest: ccs0
[687.799549] Dynamic subtest ccs0: SUCCESS (0.032s)
[687.800507] Subtest thriceslice: SUCCESS (0.282s)
[688.316892] [095/134] (354s left) syncobj_wait (reset-signaled)
[688.400186] Starting subtest: reset-signaled
[688.401155] Subtest reset-signaled: SUCCESS (0.000s)
[688.546669] [096/134] (353s left) gem_ctx_persistence (process)
[688.630534] Starting subtest: process
[688.857436] Subtest process: SUCCESS (0.227s)
[689.048477] [097/134] (353s left) kms_joiner (basic-max-non-joiner)
[689.234279] Starting subtest: basic-max-non-joiner
[689.235928] Subtest basic-max-non-joiner: SKIP (0.000s)
[689.405728] [098/134] (353s left) kms_getfb (getfb-reject-nv12)
[689.590769] Starting subtest: getfb-reject-nv12
[689.593104] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[689.795349] [099/134] (352s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[689.985778] Starting subtest: fbc-indfb-scaledprimary
[692.328427] Subtest fbc-indfb-scaledprimary: SUCCESS (2.343s)
[692.516308] [100/134] (350s left) perf_pmu (most-busy-idle-check-all)
[692.585130] Starting subtest: most-busy-idle-check-all
[692.586061] Starting dynamic subtest: rcs0
[693.283412] Dynamic subtest rcs0: SUCCESS (0.698s)
[693.301967] Starting dynamic subtest: bcs0
[693.942561] Dynamic subtest bcs0: SUCCESS (0.657s)
[693.958622] Starting dynamic subtest: vcs0
[694.598511] Dynamic subtest vcs0: SUCCESS (0.655s)
[694.614734] Starting dynamic subtest: vcs1
[695.250489] Dynamic subtest vcs1: SUCCESS (0.651s)
[695.266923] Starting dynamic subtest: vecs0
[695.907572] Dynamic subtest vecs0: SUCCESS (0.656s)
[695.930799] Starting dynamic subtest: vecs1
[696.561571] Dynamic subtest vecs1: SUCCESS (0.653s)
[696.577707] Starting dynamic subtest: ccs0
[697.215459] Dynamic subtest ccs0: SUCCESS (0.653s)
[697.216386] Subtest most-busy-idle-check-all: SUCCESS (4.631s)
[697.415629] [101/134] (345s left) gen9_exec_parse (unaligned-jump)
[697.499312] Subtest unaligned-jump: SKIP (0.000s)
[697.592689] [102/134] (345s left) kms_prime (basic-modeset-hybrid)
[697.778716] Subtest basic-modeset-hybrid: SKIP (0.000s)
[697.979986] [103/134] (344s left) kms_flip (dpms-off-confusion)
[698.175829] Starting subtest: dpms-off-confusion
[698.180429] Starting dynamic subtest: A-DP3
[706.023938] Dynamic subtest A-DP3: SUCCESS (7.843s)
[706.050081] Starting dynamic subtest: B-DP3
[713.788278] Dynamic subtest B-DP3: SUCCESS (7.762s)
[713.806062] Starting dynamic subtest: C-DP3
[721.553222] Dynamic subtest C-DP3: SUCCESS (7.761s)
[721.569534] Starting dynamic subtest: D-DP3
[729.324334] Dynamic subtest D-DP3: SUCCESS (7.770s)
[729.327462] Subtest dpms-off-confusion: SUCCESS (31.152s)
[729.708912] [104/134] (313s left) i915_pm_rps (waitboost)
[729.793064] Starting subtest: waitboost
[733.383347] Subtest waitboost: SUCCESS (3.590s)
[733.579882] [105/134] (309s left) kms_color (degamma)
[733.767815] Starting subtest: degamma
[733.768742] Starting dynamic subtest: pipe-A-DP-3
[734.461751] Dynamic subtest pipe-A-DP-3: SUCCESS (0.690s)
[734.480014] Starting dynamic subtest: pipe-B-DP-3
[735.066095] Dynamic subtest pipe-B-DP-3: SUCCESS (0.602s)
[735.082328] Starting dynamic subtest: pipe-C-DP-3
[735.655133] Dynamic subtest pipe-C-DP-3: SUCCESS (0.588s)
[735.681273] Starting dynamic subtest: pipe-D-DP-3
[736.294256] Dynamic subtest pipe-D-DP-3: SUCCESS (0.637s)
[736.295294] Subtest degamma: SUCCESS (2.526s)
[736.624290] [106/134] (306s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[736.815955] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[736.817681] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[737.001551] [107/134] (306s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[737.259266] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[737.441264] [108/134] (305s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[737.625454] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[737.627826] Starting dynamic subtest: pipe-A-DP-3
[737.636098] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[737.649909] Starting dynamic subtest: pipe-B-DP-3
[737.658117] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[737.671653] Starting dynamic subtest: pipe-C-DP-3
[737.679840] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[737.693619] Starting dynamic subtest: pipe-D-DP-3
[737.704321] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[737.706305] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[738.098237] [109/134] (305s left) kms_fb_coherency (memset-crc)
[738.284159] Starting subtest: memset-crc
[738.285060] Starting dynamic subtest: mmap-offset-fixed
[738.812009] Dynamic subtest mmap-offset-fixed: SUCCESS (0.526s)
[738.908109] Subtest memset-crc: SUCCESS (0.623s)
[739.250896] [110/134] (304s left) kms_vblank (wait-forked-busy-hang)
[739.432820] Starting subtest: wait-forked-busy-hang
[739.435251] Starting dynamic subtest: pipe-A-DP-3
[765.972488] Dynamic subtest pipe-A-DP-3: SUCCESS (26.536s)
[765.989866] Starting dynamic subtest: pipe-D-DP-3
[790.912851] Dynamic subtest pipe-D-DP-3: SUCCESS (24.935s)
[790.913792] Subtest wait-forked-busy-hang: SUCCESS (51.477s)
[791.199340] [111/134] (252s left) syncobj_eventfd (binary-wait-signaled)
[791.276334] Starting subtest: binary-wait-signaled
[791.277521] Subtest binary-wait-signaled: SUCCESS (0.000s)
[791.461746] [112/134] (252s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[791.539031] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[791.625958] [113/134] (252s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[791.819428] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[791.873000] [114/134] (252s left) kms_psr (pr-sprite-plane-move)
[792.064424] Subtest pr-sprite-plane-move: SKIP (0.000s)
[792.133028] [115/134] (251s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[792.326597] Starting subtest: x-tiled-16bpp-rotate-180
[794.077715] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.750s)
[794.293536] [116/134] (249s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[794.477571] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[794.479896] Starting dynamic subtest: pipe-A-DP-3
[794.500998] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[794.514756] Starting dynamic subtest: pipe-B-DP-3
[794.536149] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[794.549940] Starting dynamic subtest: pipe-C-DP-3
[794.575725] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[794.589487] Starting dynamic subtest: pipe-D-DP-3
[794.612136] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[794.613736] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.015s)
[794.955959] [117/134] (249s left) gem_exec_params (no-vebox)
[795.035332] Starting subtest: no-vebox
[795.037483] Subtest no-vebox: SUCCESS (0.001s)
[795.217841] [118/134] (248s left) kms_force_connector_basic (prune-stale-modes)
[795.323519] Starting subtest: prune-stale-modes
[795.347310] Subtest prune-stale-modes: SUCCESS (0.024s)
[795.667899] [119/134] (248s left) i915_pm_rpm (system-suspend-execbuf)
[797.479022] Starting subtest: system-suspend-execbuf
[857.404696] Subtest system-suspend-execbuf: SUCCESS (44.982s)
[857.868883] [120/134] (186s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[857.944245] Starting subtest: invalid-single-wait-unsubmitted
[857.945182] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[858.121782] [121/134] (186s left) kms_addfb_basic (small-bo)
[858.312224] Starting subtest: small-bo
[858.313097] Subtest small-bo: SUCCESS (0.000s)
[858.499583] [122/134] (185s left) gem_mmap_wc (write-gtt-read-wc)
[858.585177] Subtest write-gtt-read-wc: SKIP (0.000s)
[858.718064] [123/134] (185s left) kms_force_connector_basic (force-load-detect)
[858.820498] Starting subtest: force-load-detect
[858.822201] Subtest force-load-detect: SKIP (0.000s)
[859.082494] [124/134] (185s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[859.265618] Starting subtest: fb-8bpc-vs-panel-8bpc
[859.267914] Starting dynamic subtest: pipe-A-DP-3
[859.695079] Dynamic subtest pipe-A-DP-3: SUCCESS (0.424s)
[859.696529] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.428s)
[859.952086] [125/134] (184s left) kms_big_fb (4-tiled-addfb)
[860.149139] Starting subtest: 4-tiled-addfb
[860.150033] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[860.350913] [126/134] (184s left) gen7_exec_parse (basic-allocation)
[860.433234] Subtest basic-allocation: SKIP (0.000s)
[860.492361] [127/134] (184s left) gem_userptr_blits (unsync-overlap)
[860.578889] Subtest unsync-overlap: SKIP (0.000s)
[860.801535] [128/134] (184s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[860.986292] Starting subtest: basic-flip-before-cursor-varying-size
[862.070246] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.083s)
[862.399652] [129/134] (182s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[862.587002] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[864.598095] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (2.011s)
[864.867294] [130/134] (180s left) gem_ctx_bad_destroy (double-destroy)
[864.941747] Starting subtest: double-destroy
[864.942564] Subtest double-destroy: SUCCESS (0.000s)
[865.072737] [131/134] (180s left) core_setmaster (master-drop-set-root)
[865.206383] Starting subtest: master-drop-set-root
[865.241876] Subtest master-drop-set-root: SUCCESS (0.036s)
[865.326516] [132/134] (179s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[865.539001] Starting subtest: extended-modeset-hang-newfb-with-reset
[865.539924] Starting dynamic subtest: pipe-A
[886.281378] Dynamic subtest pipe-A: SUCCESS (20.740s)
[886.305727] Starting dynamic subtest: pipe-D
[907.274555] Dynamic subtest pipe-D: SUCCESS (20.987s)
[907.275798] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (41.737s)
[907.617225] [133/134] (137s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-render)
[907.813106] Starting subtest: fbc-abgr161616f-draw-render
[907.814918] Subtest fbc-abgr161616f-draw-render: SKIP (0.000s)
[908.023644] [134/134] (137s left) kms_lease (possible-crtcs-filtering)
[908.218237] Starting subtest: possible-crtcs-filtering
[908.225746] Subtest possible-crtcs-filtering: SUCCESS (0.008s)
[908.418031] Closing watchdogs
results: parsing output: 0/ for test: gem_ccs
results: parsing output: 1/ for test: kms_vrr
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_mmap_offset
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: gem_ctx_isolation
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: sw_sync
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: kms_chamelium_frames
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: gem_flink_race
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_sequence
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: intel_hwmon
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: kms_atomic_interruptible
results: parsing output: 29/ for test: gem_exec_endless
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: gem_ctx_param
results: parsing output: 32/ for test: vgem_basic
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_mmap
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_ctx_engines
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: i915_pm_freq_api
results: parsing output: 51/ for test: gem_exec_params
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: gen7_exec_parse
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_pm_backlight
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: sysfs_timeslice_duration
results: parsing output: 59/ for test: kms_cdclk
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: gem_ctx_shared
results: parsing output: 62/ for test: prime_vgem
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_pipe_crc_basic
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_flip_scaled_crc
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: gem_pipe_control_store_loop
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: gem_softpin
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: gem_pread
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: kms_plane
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: gem_spin_batch
results: parsing output: 92/ for test: api_intel_bb
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: kms_joiner
results: parsing output: 97/ for test: kms_getfb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gen9_exec_parse
results: parsing output: 101/ for test: kms_prime
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: i915_pm_rps
results: parsing output: 104/ for test: kms_color
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_chamelium_hpd
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_fb_coherency
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: syncobj_eventfd
results: parsing output: 111/ for test: kms_pipe_b_c_ivb
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_force_connector_basic
results: parsing output: 118/ for test: i915_pm_rpm
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: gem_mmap_wc
results: parsing output: 122/ for test: kms_force_connector_basic
results: parsing output: 123/ for test: kms_dither
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gen7_exec_parse
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_ctx_bad_destroy
results: parsing output: 130/ for test: core_setmaster
results: parsing output: 131/ for test: kms_busy
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_lease
Done.