[65.266416] Initializing watchdogs
[65.266483]   /dev/watchdog0
[65.287878] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[65.302590] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.306243] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.308574] [001/134] (960s left) gem_ccs (block-multicopy-compressed)
[65.392308] Starting subtest: block-multicopy-compressed
[65.393222] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[65.442385] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.049s)
[65.450134] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[65.543940] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.101s)
[65.551377] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[65.560479] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[65.567994] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[65.668343] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.107s)
[65.675853] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[65.686689] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.018s)
[65.694309] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[65.790539] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.103s)
[65.798028] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[65.807620] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.017s)
[65.816155] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[65.907018] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[65.908045] Subtest block-multicopy-compressed: SUCCESS (0.513s)
[66.125646] [002/134] (959s left) kms_vrr (negative-basic)
[66.310163] Starting subtest: negative-basic
[66.312857] Starting dynamic subtest: pipe-A-DP-3
[71.753922] Dynamic subtest pipe-A-DP-3: SUCCESS (5.428s)
[71.843471] Subtest negative-basic: SUCCESS (5.521s)
[72.140312] [003/134] (953s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[72.324361] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[72.326066] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[72.499739] [004/134] (953s left) gem_mmap_offset (partial-remap)
[72.566835] Starting subtest: partial-remap
[72.567777] Starting dynamic subtest: lmem0
[72.571229] Dynamic subtest lmem0: SUCCESS (0.003s)
[72.580012] Starting dynamic subtest: smem0
[72.582208] Dynamic subtest smem0: SUCCESS (0.004s)
[72.583415] Subtest partial-remap: SUCCESS (0.008s)
[72.720963] [005/134] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[72.909399] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[72.911160] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[73.091093] [006/134] (953s left) kms_plane_scaling (planes-downscale-factor-0-75)
[73.269139] Starting subtest: planes-downscale-factor-0-75
[73.269930] Starting dynamic subtest: pipe-A
[73.361164] Dynamic subtest pipe-A: SUCCESS (0.092s)
[73.372323] Starting dynamic subtest: pipe-B
[73.601419] Dynamic subtest pipe-B: SUCCESS (0.240s)
[73.611651] Starting dynamic subtest: pipe-C
[73.814562] Dynamic subtest pipe-C: SUCCESS (0.213s)
[73.823513] Starting dynamic subtest: pipe-D
[74.010923] Dynamic subtest pipe-D: SUCCESS (0.196s)
[74.011885] Subtest planes-downscale-factor-0-75: SUCCESS (0.741s)
[74.371859] [007/134] (951s left) gem_exec_whisper (basic-queues-all)
[74.450753] Starting subtest: basic-queues-all
[96.274786] Subtest basic-queues-all: SUCCESS (21.805s)
[96.534021] [008/134] (929s left) kms_plane (plane-position-covered)
[96.721921] Starting subtest: plane-position-covered
[97.161193] Starting dynamic subtest: pipe-A-plane-1
[97.617976] Dynamic subtest pipe-A-plane-1: SUCCESS (0.457s)
[97.629466] Starting dynamic subtest: pipe-A-plane-2
[98.079433] Dynamic subtest pipe-A-plane-2: SUCCESS (0.460s)
[98.089467] Starting dynamic subtest: pipe-A-plane-3
[98.539150] Dynamic subtest pipe-A-plane-3: SUCCESS (0.460s)
[98.548312] Starting dynamic subtest: pipe-A-plane-4
[98.996280] Dynamic subtest pipe-A-plane-4: SUCCESS (0.456s)
[99.004482] Starting dynamic subtest: pipe-A-plane-5
[99.015252] Dynamic subtest pipe-A-plane-5: SUCCESS (0.019s)
[99.372607] Starting dynamic subtest: pipe-B-plane-1
[99.774926] Dynamic subtest pipe-B-plane-1: SUCCESS (0.410s)
[99.785274] Starting dynamic subtest: pipe-B-plane-2
[100.214263] Dynamic subtest pipe-B-plane-2: SUCCESS (0.440s)
[100.222496] Starting dynamic subtest: pipe-B-plane-3
[100.669231] Dynamic subtest pipe-B-plane-3: SUCCESS (0.454s)
[100.677601] Starting dynamic subtest: pipe-B-plane-4
[101.108122] Dynamic subtest pipe-B-plane-4: SUCCESS (0.439s)
[101.116533] Starting dynamic subtest: pipe-B-plane-5
[101.129044] Dynamic subtest pipe-B-plane-5: SUCCESS (0.020s)
[101.130088] Subtest plane-position-covered: SUCCESS (4.405s)
[101.417370] [009/134] (925s left) gem_ctx_isolation (clean)
[101.501514] Starting subtest: clean
[101.502417] Starting dynamic subtest: rcs0
[101.623227] Dynamic subtest rcs0: SUCCESS (0.121s)
[101.631579] Starting dynamic subtest: bcs0
[101.751764] Dynamic subtest bcs0: SUCCESS (0.129s)
[101.760067] Starting dynamic subtest: vcs0
[101.848928] Dynamic subtest vcs0: SUCCESS (0.097s)
[101.857059] Starting dynamic subtest: vcs1
[101.965203] Dynamic subtest vcs1: SUCCESS (0.116s)
[101.973385] Starting dynamic subtest: vecs0
[102.054692] Dynamic subtest vecs0: SUCCESS (0.089s)
[102.062780] Starting dynamic subtest: vecs1
[102.163836] Dynamic subtest vecs1: SUCCESS (0.109s)
[102.172013] Starting dynamic subtest: ccs0
[102.284646] Dynamic subtest ccs0: SUCCESS (0.121s)
[102.285535] Subtest clean: SUCCESS (0.783s)
[102.548555] [010/134] (923s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[102.746479] Starting subtest: y-tiled-8bpp-rotate-0
[102.748299] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[102.916855] [011/134] (923s left) sw_sync (sync_multi_consumer)
[102.958962] Starting subtest: sync_multi_consumer
[103.300370] Subtest sync_multi_consumer: SUCCESS (0.342s)
[103.426611] [012/134] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[103.608298] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[103.609969] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[103.788641] [013/134] (922s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[104.127659] Starting subtest: cursor-rapid-movement-64x21
[104.132156] Starting dynamic subtest: pipe-A-DP-3
[104.606184] Dynamic subtest pipe-A-DP-3: SUCCESS (0.472s)
[104.636212] Starting dynamic subtest: pipe-D-DP-3
[105.031237] Dynamic subtest pipe-D-DP-3: SUCCESS (0.402s)
[105.032073] Subtest cursor-rapid-movement-64x21: SUCCESS (0.903s)
[105.523341] [014/134] (921s left) kms_chamelium_frames (hdmi-crc-single)
[105.772298] Subtest hdmi-crc-single: SKIP (0.000s)
[105.912088] [015/134] (920s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[106.104518] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[106.106205] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[106.289759] [016/134] (920s left) gem_mmap_wc (invalid-flags)
[106.356977] Subtest invalid-flags: SKIP (0.000s)
[106.415847] [017/134] (920s left) gem_flink_race (flink_name)
[106.457274] Starting subtest: flink_name
[111.854978] Subtest flink_name: SUCCESS (5.396s)
[112.047174] [018/134] (915s left) gem_exec_params (invalid-fence-in)
[112.169067] Starting subtest: invalid-fence-in
[112.170245] Subtest invalid-fence-in: SUCCESS (0.000s)
[112.350517] [019/134] (914s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[112.429203] Starting subtest: rel-constants-invalid-rel-gen5
[112.430108] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[112.635586] [020/134] (914s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[112.812768] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[112.813638] Starting dynamic subtest: pipe-A-DP-3
[112.821936] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[112.830097] Starting dynamic subtest: pipe-B-DP-3
[112.838269] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[112.846513] Starting dynamic subtest: pipe-C-DP-3
[112.854561] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[112.862359] Starting dynamic subtest: pipe-D-DP-3
[112.871442] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[112.873515] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[113.263389] [021/134] (914s left) gem_exec_schedule (preempt-engines)
[113.348355] Starting subtest: preempt-engines
[113.349277] Starting dynamic subtest: rcs0
[115.579297] Dynamic subtest rcs0: SUCCESS (2.229s)
[115.591520] Starting dynamic subtest: bcs0
[117.753896] Dynamic subtest bcs0: SUCCESS (2.173s)
[117.765816] Starting dynamic subtest: vcs0
[120.028896] Dynamic subtest vcs0: SUCCESS (2.274s)
[120.053529] Starting dynamic subtest: vcs1
[122.322622] Dynamic subtest vcs1: SUCCESS (2.291s)
[122.333704] Starting dynamic subtest: vecs0
[124.599497] Dynamic subtest vecs0: SUCCESS (2.275s)
[124.611041] Starting dynamic subtest: vecs1
[126.874582] Dynamic subtest vecs1: SUCCESS (2.274s)
[126.883444] Starting dynamic subtest: ccs0
[129.077350] Dynamic subtest ccs0: SUCCESS (2.201s)
[129.079126] Subtest preempt-engines: SUCCESS (15.726s)
[129.501407] [022/134] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[129.679460] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[129.681151] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[129.840770] [023/134] (897s left) api_intel_bb (blit-reloc-keep-cache)
[129.911069] Starting subtest: blit-reloc-keep-cache
[129.913059] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[130.102189] [024/134] (897s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[130.175224] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[130.277547] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[130.434203] [025/134] (897s left) kms_sequence (get-idle)
[130.610737] Starting subtest: get-idle
[130.611575] Starting dynamic subtest: pipe-A-DP-3
[133.016211] Dynamic subtest pipe-A-DP-3: SUCCESS (2.404s)
[133.027074] Starting dynamic subtest: pipe-B-DP-3
[135.335344] Dynamic subtest pipe-B-DP-3: SUCCESS (2.317s)
[135.346022] Starting dynamic subtest: pipe-C-DP-3
[137.650265] Dynamic subtest pipe-C-DP-3: SUCCESS (2.313s)
[137.661172] Starting dynamic subtest: pipe-D-DP-3
[139.941306] Dynamic subtest pipe-D-DP-3: SUCCESS (2.289s)
[139.942303] Subtest get-idle: SUCCESS (9.329s)
[140.217735] [026/134] (887s left) kms_flip (flip-vs-suspend)
[140.393305] Starting subtest: flip-vs-suspend
[140.397343] Starting dynamic subtest: A-DP3
[179.536574] Dynamic subtest A-DP3: SUCCESS (7.784s)
[179.553640] Starting dynamic subtest: B-DP3
[218.380111] Dynamic subtest B-DP3: SUCCESS (7.220s)
[218.395184] Starting dynamic subtest: C-DP3
[256.269827] Dynamic subtest C-DP3: SUCCESS (7.386s)
[256.282398] Starting dynamic subtest: D-DP3
[294.361034] Dynamic subtest D-DP3: SUCCESS (7.297s)
[294.361954] Subtest flip-vs-suspend: SUCCESS (29.698s)
[294.633531] [027/134] (733s left) intel_hwmon (hwmon-read)
[294.705639] Starting subtest: hwmon-read
[294.706636] Subtest hwmon-read: SUCCESS (0.001s)
[294.886214] [028/134] (732s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[295.070592] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[295.129019] [029/134] (732s left) kms_atomic_interruptible (legacy-setmode)
[295.307400] Starting subtest: legacy-setmode
[295.308303] Starting dynamic subtest: pipe-A-DP-3
[302.044681] Dynamic subtest pipe-A-DP-3: SUCCESS (6.736s)
[302.045788] Subtest legacy-setmode: SUCCESS (6.737s)
[302.535555] [030/134] (725s left) gem_exec_endless (dispatch)
[302.624913] Starting subtest: dispatch
[302.625831] Starting dynamic subtest: rcs0
[302.632274] Dynamic subtest rcs0: SUCCESS (0.007s)
[302.642635] Starting dynamic subtest: bcs0
[302.644373] Dynamic subtest bcs0: SUCCESS (0.006s)
[302.654675] Starting dynamic subtest: vcs0
[302.656514] Dynamic subtest vcs0: SUCCESS (0.006s)
[302.666786] Starting dynamic subtest: vcs1
[302.668507] Dynamic subtest vcs1: SUCCESS (0.006s)
[302.678724] Starting dynamic subtest: vecs0
[302.680513] Dynamic subtest vecs0: SUCCESS (0.008s)
[302.691723] Starting dynamic subtest: vecs1
[302.693686] Dynamic subtest vecs1: SUCCESS (0.009s)
[302.703748] Starting dynamic subtest: ccs0
[302.705836] Dynamic subtest ccs0: SUCCESS (0.006s)
[302.706790] Subtest dispatch: SUCCESS (0.054s)
[302.900529] [031/134] (725s left) kms_addfb_basic (addfb25-bad-modifier)
[303.079434] Starting subtest: addfb25-bad-modifier
[303.080381] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[303.272716] [032/134] (724s left) gem_ctx_param (invalid-size-get)
[303.348907] Starting subtest: invalid-size-get
[303.350805] Subtest invalid-size-get: SUCCESS (0.001s)
[303.490135] [033/134] (724s left) vgem_basic (second-client)
[303.587521] Starting subtest: second-client
[303.620781] Subtest second-client: SUCCESS (0.033s)
[303.739174] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[303.741315] [034/134] (724s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[303.935250] Starting subtest: 4-tiled-16bpp-rotate-180
[305.804909] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.869s)
[306.004674] [035/134] (722s left) gem_render_copy (y-tiled-ccs-to-linear)
[306.086820] Starting subtest: y-tiled-ccs-to-linear
[306.088744] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[306.390364] [036/134] (721s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-cpu)
[306.580174] Starting subtest: fbcpsr-abgr161616f-draw-mmap-cpu
[306.581784] Subtest fbcpsr-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[306.788016] [037/134] (721s left) gem_exec_reloc (basic-wc-read)
[306.868562] Subtest basic-wc-read: SKIP (0.000s)
[306.947397] [038/134] (721s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[307.133750] Starting subtest: psr-rgb101010-draw-pwrite
[307.135362] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[307.282991] [039/134] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[307.474191] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[307.475877] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[307.642234] [040/134] (721s left) gem_exec_reloc (basic-cpu-gtt-active)
[307.727943] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[307.814454] [041/134] (720s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[308.004311] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[308.006039] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[308.185155] [042/134] (720s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[308.376854] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[308.378555] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[308.545681] [043/134] (720s left) kms_psr (psr-dpms)
[308.735744] Subtest psr-dpms: SKIP (0.000s)
[308.798285] [044/134] (720s left) gem_mmap (big-bo)
[308.877513] Subtest big-bo: SKIP (0.000s)
[308.947123] [045/134] (720s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[309.138806] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[309.140516] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[309.339024] [046/134] (719s left) gem_ctx_engines (execute-allforone)
[309.435244] Starting subtest: execute-allforone
[309.480179] Subtest execute-allforone: SUCCESS (0.045s)
[309.806227] [047/134] (719s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[309.995605] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[310.009802] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.015s)
[310.176626] [048/134] (719s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[310.372804] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[310.374652] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[310.543754] [049/134] (718s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[310.735251] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[310.736842] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[310.917064] [050/134] (718s left) kms_content_protection (legacy-hdcp14)
[311.164702] Starting subtest: legacy-hdcp14
[311.441250] Starting dynamic subtest: pipe-A-DP-3
[433.051840] Dynamic subtest pipe-A-DP-3: FAIL (121.353s)
[433.053010] Subtest legacy-hdcp14: FAIL (121.735s)
[433.191422] [051/134] (596s left) i915_pm_freq_api (freq-reset-multiple)
[433.276499] Starting subtest: freq-reset-multiple
[433.277518] Starting dynamic subtest: gt0
[453.216880] Dynamic subtest gt0: SUCCESS (19.938s)
[453.217766] Subtest freq-reset-multiple: SUCCESS (19.939s)
[453.329828] [052/134] (576s left) gem_exec_params (mmapped)
[453.418522] Starting subtest: mmapped
[453.419404] Subtest mmapped: SUCCESS (0.002s)
[453.596129] [053/134] (575s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[453.677364] Starting subtest: x-tiled-to-vebox-y-tiled
[453.679584] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[453.964959] [054/134] (575s left) gen7_exec_parse (load-register-reg)
[454.045512] Subtest load-register-reg: SKIP (0.000s)
[454.120723] [055/134] (575s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[454.315716] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[455.611279] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.294s)
[455.880221] [056/134] (573s left) kms_pm_backlight (fade-with-suspend)
[456.066926] Subtest fade-with-suspend: SKIP (0.000s)
[456.120726] [057/134] (573s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[456.309201] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[456.310856] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[456.510834] [058/134] (573s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[456.696787] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[456.754080] [059/134] (573s left) sysfs_timeslice_duration (timeout)
[456.836485] Starting subtest: timeout
[456.837516] Starting dynamic subtest: vecs0
[458.727640] Dynamic subtest vecs0: SUCCESS (1.890s)
[458.741452] Starting dynamic subtest: ccs0
[460.563602] Dynamic subtest ccs0: SUCCESS (1.835s)
[460.575053] Starting dynamic subtest: vcs0
[462.324652] Dynamic subtest vcs0: SUCCESS (1.760s)
[462.336561] Starting dynamic subtest: bcs0
[463.491613] Dynamic subtest bcs0: SUCCESS (1.166s)
[463.502812] Starting dynamic subtest: vecs1
[465.363735] Dynamic subtest vecs1: SUCCESS (1.872s)
[465.375738] Starting dynamic subtest: rcs0
[467.120674] Dynamic subtest rcs0: SUCCESS (1.756s)
[467.132483] Starting dynamic subtest: vcs1
[468.861638] Dynamic subtest vcs1: SUCCESS (1.740s)
[468.862556] Subtest timeout: SUCCESS (12.026s)
[469.043513] [060/134] (561s left) kms_cdclk (mode-transition-all-outputs)
[469.230770] Starting subtest: mode-transition-all-outputs
[469.322168] Subtest mode-transition-all-outputs: SKIP (0.089s)
[469.627854] [061/134] (560s left) gem_pxp (create-valid-protected-context)
[472.231419] Starting subtest: create-valid-protected-context
[472.233798] Subtest create-valid-protected-context: SKIP (0.000s)
[472.348819] [062/134] (557s left) gem_ctx_shared (exec-shared-gtt)
[472.448827] Starting subtest: exec-shared-gtt
[472.449800] Starting dynamic subtest: rcs0
[472.460853] Dynamic subtest rcs0: SUCCESS (0.012s)
[472.473741] Starting dynamic subtest: bcs0
[472.474641] Dynamic subtest bcs0: SUCCESS (0.007s)
[472.486031] Starting dynamic subtest: vcs0
[472.486913] Dynamic subtest vcs0: SUCCESS (0.006s)
[472.498357] Starting dynamic subtest: vcs1
[472.499304] Dynamic subtest vcs1: SUCCESS (0.008s)
[472.510783] Starting dynamic subtest: vecs0
[472.511797] Dynamic subtest vecs0: SUCCESS (0.006s)
[472.523241] Starting dynamic subtest: vecs1
[472.524506] Dynamic subtest vecs1: SUCCESS (0.006s)
[472.536006] Starting dynamic subtest: ccs0
[472.537200] Dynamic subtest ccs0: SUCCESS (0.006s)
[472.538408] Subtest exec-shared-gtt: SUCCESS (0.058s)
[472.781590] [063/134] (557s left) prime_vgem (basic-fence-flip)
[472.882314] Starting subtest: basic-fence-flip
[473.010763] Subtest basic-fence-flip: SKIP (0.128s)
[473.221008] [064/134] (557s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[473.407695] Starting subtest: cursorA-vs-flipB-varying-size
[473.409382] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[473.562165] [065/134] (556s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[473.747889] Starting subtest: nonblocking-crc-frame-sequence
[473.750042] Starting dynamic subtest: pipe-A-DP-3
[474.487422] Dynamic subtest pipe-A-DP-3: SUCCESS (0.737s)
[474.502836] Starting dynamic subtest: pipe-B-DP-3
[475.131011] Dynamic subtest pipe-B-DP-3: SUCCESS (0.642s)
[475.144316] Starting dynamic subtest: pipe-C-DP-3
[475.752768] Dynamic subtest pipe-C-DP-3: SUCCESS (0.618s)
[475.772009] Starting dynamic subtest: pipe-D-DP-3
[476.385972] Dynamic subtest pipe-D-DP-3: SUCCESS (0.630s)
[476.386931] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.638s)
[476.724656] [066/134] (553s left) syncobj_timeline (etime-single-wait-all-submitted)
[476.802806] Starting subtest: etime-single-wait-all-submitted
[476.917536] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s)
[477.091632] [067/134] (553s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[477.274310] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[477.276530] Starting dynamic subtest: pipe-A-valid-mode
[480.241371] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.965s)
[480.243065] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (2.968s)
[480.773011] [068/134] (549s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[480.850682] Starting subtest: multi-wait-for-submit-submitted-signaled
[480.851603] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[481.053627] [069/134] (549s left) gem_mmap_gtt (cpuset-medium-copy)
[481.130487] Subtest cpuset-medium-copy: SKIP (0.000s)
[481.198373] [070/134] (549s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[481.384614] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[481.449486] [071/134] (549s left) gem_exec_schedule (wide)
[481.691848] Starting subtest: wide
[481.693283] Starting dynamic subtest: rcs0
[493.907772] Dynamic subtest rcs0: SUCCESS (12.217s)
[493.919819] Starting dynamic subtest: bcs0
[506.819717] Dynamic subtest bcs0: SUCCESS (12.911s)
[506.831685] Starting dynamic subtest: vcs0
[519.997869] Dynamic subtest vcs0: SUCCESS (13.176s)
[520.019284] Starting dynamic subtest: vcs1
[533.090810] Dynamic subtest vcs1: SUCCESS (13.092s)
[533.102884] Starting dynamic subtest: vecs0
[546.009260] Dynamic subtest vecs0: SUCCESS (12.917s)
[546.021458] Starting dynamic subtest: vecs1
[559.132179] Dynamic subtest vecs1: SUCCESS (13.117s)
[559.145812] Starting dynamic subtest: ccs0
[572.369009] Dynamic subtest ccs0: SUCCESS (13.239s)
[572.369857] Subtest wide: SUCCESS (90.678s)
[574.380384] [072/134] (456s left) gem_pipe_control_store_loop (fresh-buffer)
[574.471515] Starting subtest: fresh-buffer
[576.647675] Subtest fresh-buffer: SUCCESS (2.176s)
[576.826637] [073/134] (454s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[577.009123] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[577.041909] Starting dynamic subtest: pipe-A-plane-0
[577.043753] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[577.055572] Starting dynamic subtest: pipe-A-plane-3
[577.057709] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[577.069145] Starting dynamic subtest: pipe-A-plane-5
[577.070844] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[577.270836] Starting dynamic subtest: pipe-B-plane-0
[577.272857] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[577.290405] Starting dynamic subtest: pipe-B-plane-3
[577.292262] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[577.304965] Starting dynamic subtest: pipe-B-plane-5
[577.307186] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[577.343923] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.334s)
[577.630165] [074/134] (453s left) gem_eio (hibernate)
[577.926944] Starting subtest: hibernate
[593.258539] Subtest hibernate: SUCCESS (15.331s)
[603.020432] [075/134] (437s left) kms_psr (fbc-psr-sprite-plane-onoff)
[603.219782] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[603.288971] [076/134] (437s left) kms_cursor_crc (cursor-onscreen-128x42)
[603.679584] Starting subtest: cursor-onscreen-128x42
[603.683173] Starting dynamic subtest: pipe-A-DP-3
[606.485643] Dynamic subtest pipe-A-DP-3: SUCCESS (2.803s)
[606.529725] Starting dynamic subtest: pipe-D-DP-3
[609.169616] Dynamic subtest pipe-D-DP-3: SUCCESS (2.653s)
[609.170603] Subtest cursor-onscreen-128x42: SUCCESS (5.491s)
[609.577679] [077/134] (430s left) kms_cursor_crc (cursor-sliding-max-size)
[610.082702] Starting subtest: cursor-sliding-max-size
[610.085293] Subtest cursor-sliding-max-size: SKIP (0.000s)
[610.320841] [078/134] (430s left) gem_softpin (noreloc-s3)
[610.421276] Starting subtest: noreloc-S3
[630.736011] Subtest noreloc-S3: SUCCESS (5.432s)
[630.941743] [079/134] (409s left) syncobj_timeline (wait-all-complex)
[631.019052] Starting subtest: wait-all-complex
[631.236794] Subtest wait-all-complex: SUCCESS (0.216s)
[631.387008] [080/134] (409s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[631.573760] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[631.575434] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[631.784442] [081/134] (408s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[631.873203] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[631.875198] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[632.112983] [082/134] (408s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[632.298035] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[632.299817] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[632.636580] [083/134] (408s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[632.820907] Starting subtest: multiplane-rotation-cropping-top
[660.811291] Subtest multiplane-rotation-cropping-top: SUCCESS (27.988s)
[661.047170] [084/134] (379s left) gem_pread (display)
[661.124810] Subtest display: SKIP (0.000s)
[661.204703] [085/134] (379s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[661.940933] Starting subtest: syncobj-timeline-invalid-wait
[661.942123] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[662.277659] [086/134] (378s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[662.467598] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[662.469290] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[662.680015] [087/134] (378s left) gem_exec_balancer (full-pulse)
[662.770765] Starting subtest: full-pulse
[664.828833] Subtest full-pulse: SUCCESS (2.058s)
[665.312335] [088/134] (375s left) gem_exec_reloc (basic-gtt-wc)
[665.394116] Subtest basic-gtt-wc: SKIP (0.000s)
[665.502533] [089/134] (375s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[665.700949] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[665.725375] Starting dynamic subtest: pipe-A-plane-0
[665.727088] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[665.740678] Starting dynamic subtest: pipe-A-plane-3
[665.742447] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[665.755763] Starting dynamic subtest: pipe-A-plane-5
[665.757337] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[665.957552] Starting dynamic subtest: pipe-B-plane-0
[665.959654] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[665.980166] Starting dynamic subtest: pipe-B-plane-3
[665.982216] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[665.996378] Starting dynamic subtest: pipe-B-plane-5
[665.998625] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[666.027890] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.326s)
[666.261375] [090/134] (375s left) kms_big_fb (linear-8bpp-rotate-90)
[666.455197] Starting subtest: linear-8bpp-rotate-90
[666.517174] Subtest linear-8bpp-rotate-90: SKIP (0.061s)
[666.720840] [091/134] (374s left) gem_eio (in-flight-contexts-10ms)
[667.003523] Starting subtest: in-flight-contexts-10ms
[681.069291] Subtest in-flight-contexts-10ms: SUCCESS (14.066s)
[681.346681] [092/134] (360s left) gem_spin_batch (spin-all-new)
[681.433204] Starting subtest: spin-all-new
[681.493112] Subtest spin-all-new: SUCCESS (0.060s)
[681.836300] [093/134] (359s left) api_intel_bb (destroy-bb)
[681.913217] Starting subtest: destroy-bb
[681.952050] Subtest destroy-bb: SUCCESS (0.039s)
[682.151333] [094/134] (359s left) gem_exec_schedule (thriceslice)
[682.242080] Starting subtest: thriceslice
[682.243044] Starting dynamic subtest: rcs0
[682.273269] Dynamic subtest rcs0: SUCCESS (0.030s)
[682.288212] Starting dynamic subtest: bcs0
[682.325654] Dynamic subtest bcs0: SUCCESS (0.051s)
[682.360778] Starting dynamic subtest: vcs0
[682.390771] Dynamic subtest vcs0: SUCCESS (0.063s)
[682.422219] Starting dynamic subtest: vcs1
[682.432201] Dynamic subtest vcs1: SUCCESS (0.039s)
[682.451689] Starting dynamic subtest: vecs0
[682.490439] Dynamic subtest vecs0: SUCCESS (0.057s)
[682.510680] Starting dynamic subtest: vecs1
[682.546090] Dynamic subtest vecs1: SUCCESS (0.054s)
[682.583053] Starting dynamic subtest: ccs0
[682.612831] Dynamic subtest ccs0: SUCCESS (0.064s)
[682.613927] Subtest thriceslice: SUCCESS (0.372s)
[683.040268] [095/134] (358s left) syncobj_wait (reset-signaled)
[683.115240] Starting subtest: reset-signaled
[683.116130] Subtest reset-signaled: SUCCESS (0.000s)
[683.256799] [096/134] (358s left) gem_ctx_persistence (process)
[683.342198] Starting subtest: process
[683.569180] Subtest process: SUCCESS (0.227s)
[683.756483] [097/134] (358s left) kms_joiner (basic-max-non-joiner)
[683.942482] Starting subtest: basic-max-non-joiner
[683.944107] Subtest basic-max-non-joiner: SKIP (0.000s)
[684.065201] [098/134] (357s left) kms_getfb (getfb-reject-nv12)
[684.249563] Starting subtest: getfb-reject-nv12
[684.252013] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[684.462302] [099/134] (357s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[684.654591] Starting subtest: fbc-indfb-scaledprimary
[687.385377] Subtest fbc-indfb-scaledprimary: SUCCESS (2.731s)
[687.647315] [100/134] (354s left) perf_pmu (most-busy-idle-check-all)
[687.715822] Starting subtest: most-busy-idle-check-all
[687.716752] Starting dynamic subtest: rcs0
[688.411147] Dynamic subtest rcs0: SUCCESS (0.695s)
[688.428820] Starting dynamic subtest: bcs0
[689.067090] Dynamic subtest bcs0: SUCCESS (0.654s)
[689.082984] Starting dynamic subtest: vcs0
[689.723234] Dynamic subtest vcs0: SUCCESS (0.655s)
[689.739166] Starting dynamic subtest: vcs1
[690.376149] Dynamic subtest vcs1: SUCCESS (0.652s)
[690.392186] Starting dynamic subtest: vecs0
[691.030169] Dynamic subtest vecs0: SUCCESS (0.653s)
[691.045748] Starting dynamic subtest: vecs1
[691.686143] Dynamic subtest vecs1: SUCCESS (0.655s)
[691.701974] Starting dynamic subtest: ccs0
[692.339240] Dynamic subtest ccs0: SUCCESS (0.652s)
[692.340116] Subtest most-busy-idle-check-all: SUCCESS (4.624s)
[692.502931] [101/134] (349s left) gen9_exec_parse (unaligned-jump)
[692.586838] Subtest unaligned-jump: SKIP (0.000s)
[692.712104] [102/134] (349s left) kms_prime (basic-modeset-hybrid)
[692.898076] Subtest basic-modeset-hybrid: SKIP (0.000s)
[693.076705] [103/134] (349s left) kms_flip (dpms-off-confusion)
[693.262660] Starting subtest: dpms-off-confusion
[693.267362] Starting dynamic subtest: A-DP3
[701.122462] Dynamic subtest A-DP3: SUCCESS (7.854s)
[701.139797] Starting dynamic subtest: B-DP3
[708.893734] Dynamic subtest B-DP3: SUCCESS (7.768s)
[708.911360] Starting dynamic subtest: C-DP3
[716.664940] Dynamic subtest C-DP3: SUCCESS (7.765s)
[716.687059] Starting dynamic subtest: D-DP3
[724.430689] Dynamic subtest D-DP3: SUCCESS (7.760s)
[724.433026] Subtest dpms-off-confusion: SUCCESS (31.167s)
[724.783227] [104/134] (317s left) i915_pm_rps (waitboost)
[724.868977] Starting subtest: waitboost
[728.715007] Subtest waitboost: SUCCESS (3.846s)
[728.880458] [105/134] (313s left) kms_color (degamma)
[729.067919] Starting subtest: degamma
[729.068917] Starting dynamic subtest: pipe-A-DP-3
[729.762301] Dynamic subtest pipe-A-DP-3: SUCCESS (0.692s)
[729.792930] Starting dynamic subtest: pipe-B-DP-3
[730.399081] Dynamic subtest pipe-B-DP-3: SUCCESS (0.634s)
[730.420134] Starting dynamic subtest: pipe-C-DP-3
[731.009786] Dynamic subtest pipe-C-DP-3: SUCCESS (0.610s)
[731.023798] Starting dynamic subtest: pipe-D-DP-3
[731.618276] Dynamic subtest pipe-D-DP-3: SUCCESS (0.608s)
[731.619243] Subtest degamma: SUCCESS (2.552s)
[731.952508] [106/134] (310s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[732.158611] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[732.160447] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[732.315669] [107/134] (310s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[732.575282] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[732.727046] [108/134] (310s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[732.912248] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[732.914529] Starting dynamic subtest: pipe-A-DP-3
[732.922869] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[732.936411] Starting dynamic subtest: pipe-B-DP-3
[732.944739] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[732.958241] Starting dynamic subtest: pipe-C-DP-3
[732.966557] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[732.980334] Starting dynamic subtest: pipe-D-DP-3
[732.990790] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[732.993125] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[733.423427] [109/134] (309s left) kms_fb_coherency (memset-crc)
[733.615880] Starting subtest: memset-crc
[733.616768] Starting dynamic subtest: mmap-offset-fixed
[734.167459] Dynamic subtest mmap-offset-fixed: SUCCESS (0.551s)
[734.264059] Subtest memset-crc: SUCCESS (0.648s)
[734.591787] [110/134] (308s left) kms_vblank (wait-forked-busy-hang)
[734.774194] Starting subtest: wait-forked-busy-hang
[734.776755] Starting dynamic subtest: pipe-A-DP-3
[761.744874] Dynamic subtest pipe-A-DP-3: SUCCESS (26.969s)
[761.761494] Starting dynamic subtest: pipe-D-DP-3
[786.669780] Dynamic subtest pipe-D-DP-3: SUCCESS (24.920s)
[786.670692] Subtest wait-forked-busy-hang: SUCCESS (51.896s)
[786.950522] [111/134] (256s left) syncobj_eventfd (binary-wait-signaled)
[787.027986] Starting subtest: binary-wait-signaled
[787.028917] Subtest binary-wait-signaled: SUCCESS (0.000s)
[787.218193] [112/134] (255s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[787.294773] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[787.361840] [113/134] (255s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[787.553836] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[787.612374] [114/134] (255s left) kms_psr (pr-sprite-plane-move)
[787.802109] Subtest pr-sprite-plane-move: SKIP (0.000s)
[787.861917] [115/134] (255s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[788.061616] Starting subtest: x-tiled-16bpp-rotate-180
[789.866339] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.804s)
[790.072715] [116/134] (253s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[790.276213] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[790.278549] Starting dynamic subtest: pipe-A-DP-3
[790.300255] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[790.314511] Starting dynamic subtest: pipe-B-DP-3
[790.335864] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[790.349351] Starting dynamic subtest: pipe-C-DP-3
[790.372325] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[790.387406] Starting dynamic subtest: pipe-D-DP-3
[790.411537] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[790.413351] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.014s)
[790.780641] [117/134] (252s left) gem_exec_params (no-vebox)
[790.870006] Starting subtest: no-vebox
[790.872190] Subtest no-vebox: SUCCESS (0.002s)
[791.099266] [118/134] (252s left) kms_force_connector_basic (prune-stale-modes)
[791.212989] Starting subtest: prune-stale-modes
[791.235542] Subtest prune-stale-modes: SUCCESS (0.024s)
[791.566360] [119/134] (252s left) i915_pm_rpm (system-suspend-execbuf)
[793.174246] Starting subtest: system-suspend-execbuf
[853.365650] Subtest system-suspend-execbuf: SUCCESS (45.036s)
[853.767446] [120/134] (189s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[853.849579] Starting subtest: invalid-single-wait-unsubmitted
[853.850489] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[854.041447] [121/134] (189s left) kms_addfb_basic (small-bo)
[854.226478] Starting subtest: small-bo
[854.227389] Subtest small-bo: SUCCESS (0.000s)
[854.437730] [122/134] (189s left) gem_mmap_wc (write-gtt-read-wc)
[854.514328] Subtest write-gtt-read-wc: SKIP (0.000s)
[854.582732] [123/134] (189s left) kms_force_connector_basic (force-load-detect)
[854.688485] Starting subtest: force-load-detect
[854.690228] Subtest force-load-detect: SKIP (0.000s)
[854.936187] [124/134] (189s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[855.119033] Starting subtest: fb-8bpc-vs-panel-8bpc
[855.121474] Starting dynamic subtest: pipe-A-DP-3
[855.519059] Dynamic subtest pipe-A-DP-3: SUCCESS (0.395s)
[855.520486] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.399s)
[855.816574] [125/134] (188s left) kms_big_fb (4-tiled-addfb)
[856.017345] Starting subtest: 4-tiled-addfb
[856.018258] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[856.232839] [126/134] (187s left) gen7_exec_parse (basic-allocation)
[856.317405] Subtest basic-allocation: SKIP (0.000s)
[856.374143] [127/134] (187s left) gem_userptr_blits (unsync-overlap)
[856.462774] Subtest unsync-overlap: SKIP (0.000s)
[856.702641] [128/134] (187s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[856.889555] Starting subtest: basic-flip-before-cursor-varying-size
[857.950564] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.061s)
[858.286605] [129/134] (186s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[858.476338] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[860.481005] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (2.005s)
[860.748770] [130/134] (183s left) gem_ctx_bad_destroy (double-destroy)
[860.824126] Starting subtest: double-destroy
[860.825081] Subtest double-destroy: SUCCESS (0.000s)
[860.961041] [131/134] (183s left) core_setmaster (master-drop-set-root)
[861.093560] Starting subtest: master-drop-set-root
[861.124962] Subtest master-drop-set-root: SUCCESS (0.031s)
[861.210780] [132/134] (183s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[861.420108] Starting subtest: extended-modeset-hang-newfb-with-reset
[861.421063] Starting dynamic subtest: pipe-A
[882.306682] Dynamic subtest pipe-A: SUCCESS (20.883s)
[882.339146] Starting dynamic subtest: pipe-D
[903.229165] Dynamic subtest pipe-D: SUCCESS (20.911s)
[903.230214] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (41.808s)
[903.550743] [133/134] (141s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-render)
[903.743301] Starting subtest: fbc-abgr161616f-draw-render
[903.745096] Subtest fbc-abgr161616f-draw-render: SKIP (0.000s)
[903.919773] [134/134] (140s left) kms_lease (possible-crtcs-filtering)
[904.105918] Starting subtest: possible-crtcs-filtering
[904.115598] Subtest possible-crtcs-filtering: SUCCESS (0.010s)
[904.328334] 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.