[63.926094] Initializing watchdogs
[63.926160]   /dev/watchdog0
[63.946085] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.957337] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.961064] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.963352] [001/134] (960s left) gem_ccs (block-multicopy-compressed)
[64.100399] Starting subtest: block-multicopy-compressed
[64.101519] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[64.152492] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.051s)
[64.160650] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[64.254246] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.101s)
[64.261918] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[64.270947] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[64.278596] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[64.378392] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.107s)
[64.386130] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[64.395382] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[64.403138] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[64.497331] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.102s)
[64.504992] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[64.514477] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.017s)
[64.522324] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[64.613568] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[64.614491] Subtest block-multicopy-compressed: SUCCESS (0.513s)
[64.821095] [002/134] (959s left) kms_vrr (negative-basic)
[64.998659] Starting subtest: negative-basic
[65.001261] Starting dynamic subtest: pipe-A-DP-3
[70.448914] Dynamic subtest pipe-A-DP-3: SUCCESS (5.446s)
[70.539621] Subtest negative-basic: SUCCESS (5.540s)
[70.851996] [003/134] (953s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[71.034495] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[71.036173] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[71.219941] [004/134] (953s left) gem_mmap_offset (partial-remap)
[71.286971] Starting subtest: partial-remap
[71.287948] Starting dynamic subtest: lmem0
[71.290514] Dynamic subtest lmem0: SUCCESS (0.004s)
[71.298844] Starting dynamic subtest: smem0
[71.301094] Dynamic subtest smem0: SUCCESS (0.004s)
[71.302166] Subtest partial-remap: SUCCESS (0.009s)
[71.519470] [005/134] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[71.701793] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[71.703388] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[71.885228] [006/134] (952s left) kms_plane_scaling (planes-downscale-factor-0-75)
[72.062447] Starting subtest: planes-downscale-factor-0-75
[72.063266] Starting dynamic subtest: pipe-A
[72.157653] Dynamic subtest pipe-A: SUCCESS (0.095s)
[72.170650] Starting dynamic subtest: pipe-B
[72.369844] Dynamic subtest pipe-B: SUCCESS (0.212s)
[72.383185] Starting dynamic subtest: pipe-C
[72.599207] Dynamic subtest pipe-C: SUCCESS (0.229s)
[72.608947] Starting dynamic subtest: pipe-D
[72.795819] Dynamic subtest pipe-D: SUCCESS (0.196s)
[72.796738] Subtest planes-downscale-factor-0-75: SUCCESS (0.734s)
[73.139125] [007/134] (951s left) gem_exec_whisper (basic-queues-all)
[73.218915] Starting subtest: basic-queues-all
[95.036439] Subtest basic-queues-all: SUCCESS (21.815s)
[95.267849] [008/134] (929s left) kms_plane (plane-position-covered)
[95.445976] Starting subtest: plane-position-covered
[95.870703] Starting dynamic subtest: pipe-A-plane-1
[96.301259] Dynamic subtest pipe-A-plane-1: SUCCESS (0.430s)
[96.309686] Starting dynamic subtest: pipe-A-plane-2
[96.752405] Dynamic subtest pipe-A-plane-2: SUCCESS (0.452s)
[96.762487] Starting dynamic subtest: pipe-A-plane-3
[97.208951] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[97.218327] Starting dynamic subtest: pipe-A-plane-4
[97.668163] Dynamic subtest pipe-A-plane-4: SUCCESS (0.459s)
[97.676492] Starting dynamic subtest: pipe-A-plane-5
[97.689603] Dynamic subtest pipe-A-plane-5: SUCCESS (0.021s)
[98.028929] Starting dynamic subtest: pipe-B-plane-1
[98.445123] Dynamic subtest pipe-B-plane-1: SUCCESS (0.425s)
[98.453531] Starting dynamic subtest: pipe-B-plane-2
[98.881144] Dynamic subtest pipe-B-plane-2: SUCCESS (0.436s)
[98.889613] Starting dynamic subtest: pipe-B-plane-3
[99.318030] Dynamic subtest pipe-B-plane-3: SUCCESS (0.436s)
[99.326482] Starting dynamic subtest: pipe-B-plane-4
[99.755182] Dynamic subtest pipe-B-plane-4: SUCCESS (0.437s)
[99.763482] Starting dynamic subtest: pipe-B-plane-5
[99.777168] Dynamic subtest pipe-B-plane-5: SUCCESS (0.021s)
[99.778189] Subtest plane-position-covered: SUCCESS (4.331s)
[100.061989] [009/134] (925s left) gem_ctx_isolation (clean)
[100.147462] Starting subtest: clean
[100.148387] Starting dynamic subtest: rcs0
[100.258774] Dynamic subtest rcs0: SUCCESS (0.111s)
[100.267443] Starting dynamic subtest: bcs0
[100.376408] Dynamic subtest bcs0: SUCCESS (0.116s)
[100.384660] Starting dynamic subtest: vcs0
[100.507030] Dynamic subtest vcs0: SUCCESS (0.131s)
[100.515367] Starting dynamic subtest: vcs1
[100.614360] Dynamic subtest vcs1: SUCCESS (0.107s)
[100.622747] Starting dynamic subtest: vecs0
[100.724481] Dynamic subtest vecs0: SUCCESS (0.110s)
[100.733055] Starting dynamic subtest: vecs1
[100.846013] Dynamic subtest vecs1: SUCCESS (0.121s)
[100.854445] Starting dynamic subtest: ccs0
[100.960195] Dynamic subtest ccs0: SUCCESS (0.114s)
[100.961108] Subtest clean: SUCCESS (0.813s)
[101.282686] [010/134] (923s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[101.470079] Starting subtest: y-tiled-8bpp-rotate-0
[101.471776] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[101.662570] [011/134] (923s left) sw_sync (sync_multi_consumer)
[101.705470] Starting subtest: sync_multi_consumer
[102.044728] Subtest sync_multi_consumer: SUCCESS (0.339s)
[102.161752] [012/134] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[102.346198] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[102.347926] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[102.544473] [013/134] (922s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[102.880132] Starting subtest: cursor-rapid-movement-64x21
[102.885034] Starting dynamic subtest: pipe-A-DP-3
[103.379830] Dynamic subtest pipe-A-DP-3: SUCCESS (0.495s)
[103.424055] Starting dynamic subtest: pipe-D-DP-3
[103.804328] Dynamic subtest pipe-D-DP-3: SUCCESS (0.388s)
[103.805295] Subtest cursor-rapid-movement-64x21: SUCCESS (0.924s)
[104.278517] [014/134] (921s left) kms_chamelium_frames (hdmi-crc-single)
[104.557141] Subtest hdmi-crc-single: SKIP (0.000s)
[104.703776] [015/134] (920s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[104.885472] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[104.887245] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[105.082520] [016/134] (920s left) gem_mmap_wc (invalid-flags)
[105.158988] Subtest invalid-flags: SKIP (0.000s)
[105.270274] [017/134] (920s left) gem_flink_race (flink_name)
[105.312691] Starting subtest: flink_name
[110.716935] Subtest flink_name: SUCCESS (5.403s)
[110.898038] [018/134] (914s left) gem_exec_params (invalid-fence-in)
[111.019407] Starting subtest: invalid-fence-in
[111.020280] Subtest invalid-fence-in: SUCCESS (0.000s)
[111.208990] [019/134] (914s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[111.283422] Starting subtest: rel-constants-invalid-rel-gen5
[111.284419] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[111.459344] [020/134] (914s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[111.633837] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[111.634714] Starting dynamic subtest: pipe-A-DP-3
[111.643016] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[111.651236] Starting dynamic subtest: pipe-B-DP-3
[111.659480] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[111.667525] Starting dynamic subtest: pipe-C-DP-3
[111.675747] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[111.683738] Starting dynamic subtest: pipe-D-DP-3
[111.693032] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[111.695066] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[112.088904] [021/134] (913s left) gem_exec_schedule (preempt-engines)
[112.172263] Starting subtest: preempt-engines
[112.173195] Starting dynamic subtest: rcs0
[114.394653] Dynamic subtest rcs0: SUCCESS (2.221s)
[114.405948] Starting dynamic subtest: bcs0
[116.562773] Dynamic subtest bcs0: SUCCESS (2.166s)
[116.574052] Starting dynamic subtest: vcs0
[118.837587] Dynamic subtest vcs0: SUCCESS (2.273s)
[118.849129] Starting dynamic subtest: vcs1
[121.124572] Dynamic subtest vcs1: SUCCESS (2.285s)
[121.136230] Starting dynamic subtest: vecs0
[123.400941] Dynamic subtest vecs0: SUCCESS (2.275s)
[123.413687] Starting dynamic subtest: vecs1
[125.677600] Dynamic subtest vecs1: SUCCESS (2.275s)
[125.710204] Starting dynamic subtest: ccs0
[127.911866] Dynamic subtest ccs0: SUCCESS (2.233s)
[127.913634] Subtest preempt-engines: SUCCESS (15.740s)
[128.343531] [022/134] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[128.529652] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[128.531285] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[128.711809] [023/134] (897s left) api_intel_bb (blit-reloc-keep-cache)
[128.777230] Starting subtest: blit-reloc-keep-cache
[128.779557] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[128.941975] [024/134] (897s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[129.010175] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[129.119366] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[129.230699] [025/134] (897s left) kms_sequence (get-idle)
[129.409224] Starting subtest: get-idle
[129.410153] Starting dynamic subtest: pipe-A-DP-3
[131.806187] Dynamic subtest pipe-A-DP-3: SUCCESS (2.396s)
[131.817422] Starting dynamic subtest: pipe-B-DP-3
[134.129049] Dynamic subtest pipe-B-DP-3: SUCCESS (2.321s)
[134.140656] Starting dynamic subtest: pipe-C-DP-3
[136.437966] Dynamic subtest pipe-C-DP-3: SUCCESS (2.307s)
[136.448680] Starting dynamic subtest: pipe-D-DP-3
[138.748410] Dynamic subtest pipe-D-DP-3: SUCCESS (2.310s)
[138.749254] Subtest get-idle: SUCCESS (9.339s)
[139.046088] [026/134] (887s left) kms_flip (flip-vs-suspend)
[139.222596] Starting subtest: flip-vs-suspend
[139.226759] Starting dynamic subtest: A-DP3
[178.326647] Dynamic subtest A-DP3: SUCCESS (7.867s)
[178.341379] Starting dynamic subtest: B-DP3
[217.521348] Dynamic subtest B-DP3: SUCCESS (7.390s)
[217.532894] Starting dynamic subtest: C-DP3
[256.724164] Dynamic subtest C-DP3: SUCCESS (7.301s)
[256.734865] Starting dynamic subtest: D-DP3
[295.887969] Dynamic subtest D-DP3: SUCCESS (7.333s)
[295.889889] Subtest flip-vs-suspend: SUCCESS (29.899s)
[296.198835] [027/134] (730s left) intel_hwmon (hwmon-read)
[296.269906] Starting subtest: hwmon-read
[296.271980] Subtest hwmon-read: SUCCESS (0.001s)
[296.462707] [028/134] (730s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[296.672095] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[296.723587] [029/134] (729s left) kms_atomic_interruptible (legacy-setmode)
[296.901648] Starting subtest: legacy-setmode
[296.902572] Starting dynamic subtest: pipe-A-DP-3
[303.450198] Dynamic subtest pipe-A-DP-3: SUCCESS (6.547s)
[303.451179] Subtest legacy-setmode: SUCCESS (6.549s)
[304.090044] [030/134] (722s left) gem_exec_endless (dispatch)
[304.176104] Starting subtest: dispatch
[304.177033] Starting dynamic subtest: rcs0
[304.187121] Dynamic subtest rcs0: SUCCESS (0.011s)
[304.198034] Starting dynamic subtest: bcs0
[304.199960] Dynamic subtest bcs0: SUCCESS (0.006s)
[304.210923] Starting dynamic subtest: vcs0
[304.212681] Dynamic subtest vcs0: SUCCESS (0.006s)
[304.223580] Starting dynamic subtest: vcs1
[304.225376] Dynamic subtest vcs1: SUCCESS (0.006s)
[304.237851] Starting dynamic subtest: vecs0
[304.239616] Dynamic subtest vecs0: SUCCESS (0.007s)
[304.250247] Starting dynamic subtest: vecs1
[304.252272] Dynamic subtest vecs1: SUCCESS (0.009s)
[304.262951] Starting dynamic subtest: ccs0
[304.265036] Dynamic subtest ccs0: SUCCESS (0.006s)
[304.266098] Subtest dispatch: SUCCESS (0.056s)
[304.417762] [031/134] (722s left) kms_addfb_basic (addfb25-bad-modifier)
[304.595590] Starting subtest: addfb25-bad-modifier
[304.596426] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[304.792952] [032/134] (721s left) gem_ctx_param (invalid-size-get)
[304.860062] Starting subtest: invalid-size-get
[304.862011] Subtest invalid-size-get: SUCCESS (0.001s)
[305.049741] [033/134] (721s left) vgem_basic (second-client)
[305.153003] Starting subtest: second-client
[305.186244] Subtest second-client: SUCCESS (0.033s)
[305.335751] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[305.337809] [034/134] (721s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[305.530038] Starting subtest: 4-tiled-16bpp-rotate-180
[307.336991] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.806s)
[307.536508] [035/134] (719s left) gem_render_copy (y-tiled-ccs-to-linear)
[307.624948] Starting subtest: y-tiled-ccs-to-linear
[307.626986] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[307.868976] [036/134] (719s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-cpu)
[308.062476] Starting subtest: fbcpsr-abgr161616f-draw-mmap-cpu
[308.064143] Subtest fbcpsr-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[308.253420] [037/134] (718s left) gem_exec_reloc (basic-wc-read)
[308.335044] Subtest basic-wc-read: SKIP (0.000s)
[308.416595] [038/134] (718s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[308.604244] Starting subtest: psr-rgb101010-draw-pwrite
[308.605833] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[308.771848] [039/134] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[308.959466] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[308.961178] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[309.141557] [040/134] (718s left) gem_exec_reloc (basic-cpu-gtt-active)
[309.238057] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[309.388540] [041/134] (718s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[309.575444] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[309.577090] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[309.735455] [042/134] (717s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[309.927118] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[309.928796] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[310.089067] [043/134] (717s left) kms_psr (psr-dpms)
[310.269085] Subtest psr-dpms: SKIP (0.000s)
[310.330809] [044/134] (717s left) gem_mmap (big-bo)
[310.408924] Subtest big-bo: SKIP (0.000s)
[310.481475] [045/134] (717s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[310.679530] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[310.681224] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[310.872901] [046/134] (716s left) gem_ctx_engines (execute-allforone)
[310.959552] Starting subtest: execute-allforone
[311.002946] Subtest execute-allforone: SUCCESS (0.043s)
[311.336211] [047/134] (716s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[311.523773] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[311.539169] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.015s)
[311.678775] [048/134] (716s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[311.889882] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[311.891730] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[312.088256] [049/134] (715s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[312.281005] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[312.282742] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[312.434243] [050/134] (715s left) kms_content_protection (legacy-hdcp14)
[312.691675] Starting subtest: legacy-hdcp14
[312.973479] Starting dynamic subtest: pipe-A-DP-3
[434.446938] Dynamic subtest pipe-A-DP-3: FAIL (121.202s)
[434.447984] Subtest legacy-hdcp14: FAIL (121.593s)
[434.610901] [051/134] (593s left) i915_pm_freq_api (freq-reset-multiple)
[434.695826] Starting subtest: freq-reset-multiple
[434.696734] Starting dynamic subtest: gt0
[454.762847] Dynamic subtest gt0: SUCCESS (20.065s)
[454.763767] Subtest freq-reset-multiple: SUCCESS (20.066s)
[454.901425] [052/134] (573s left) gem_exec_params (mmapped)
[454.984036] Starting subtest: mmapped
[454.986022] Subtest mmapped: SUCCESS (0.002s)
[455.170860] [053/134] (573s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[455.268525] Starting subtest: x-tiled-to-vebox-y-tiled
[455.270677] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[455.542834] [054/134] (572s left) gen7_exec_parse (load-register-reg)
[455.635795] Subtest load-register-reg: SKIP (0.000s)
[455.720255] [055/134] (572s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[455.913784] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[457.191593] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.277s)
[457.407052] [056/134] (571s left) kms_pm_backlight (fade-with-suspend)
[457.592983] Subtest fade-with-suspend: SKIP (0.000s)
[457.653178] [057/134] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[457.841202] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[457.842809] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[458.019125] [058/134] (570s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[458.202984] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[458.268513] [059/134] (570s left) sysfs_timeslice_duration (timeout)
[458.352678] Starting subtest: timeout
[458.353804] Starting dynamic subtest: vecs0
[460.277653] Dynamic subtest vecs0: SUCCESS (1.924s)
[460.289530] Starting dynamic subtest: ccs0
[462.095785] Dynamic subtest ccs0: SUCCESS (1.817s)
[462.107449] Starting dynamic subtest: vcs0
[463.802668] Dynamic subtest vcs0: SUCCESS (1.706s)
[463.814385] Starting dynamic subtest: bcs0
[464.898666] Dynamic subtest bcs0: SUCCESS (1.095s)
[464.910714] Starting dynamic subtest: vecs1
[466.707838] Dynamic subtest vecs1: SUCCESS (1.808s)
[466.719853] Starting dynamic subtest: rcs0
[468.453773] Dynamic subtest rcs0: SUCCESS (1.745s)
[468.465980] Starting dynamic subtest: vcs1
[470.188236] Dynamic subtest vcs1: SUCCESS (1.733s)
[470.189412] Subtest timeout: SUCCESS (11.836s)
[470.356420] [060/134] (558s left) kms_cdclk (mode-transition-all-outputs)
[470.546315] Starting subtest: mode-transition-all-outputs
[470.637677] Subtest mode-transition-all-outputs: SKIP (0.089s)
[470.893873] [061/134] (557s left) gem_pxp (create-valid-protected-context)
[473.503024] Starting subtest: create-valid-protected-context
[473.505091] Subtest create-valid-protected-context: SKIP (0.000s)
[473.612021] [062/134] (555s left) gem_ctx_shared (exec-shared-gtt)
[473.701755] Starting subtest: exec-shared-gtt
[473.702714] Starting dynamic subtest: rcs0
[473.711907] Dynamic subtest rcs0: SUCCESS (0.010s)
[473.725698] Starting dynamic subtest: bcs0
[473.726581] Dynamic subtest bcs0: SUCCESS (0.008s)
[473.739125] Starting dynamic subtest: vcs0
[473.740004] Dynamic subtest vcs0: SUCCESS (0.008s)
[473.753001] Starting dynamic subtest: vcs1
[473.753910] Dynamic subtest vcs1: SUCCESS (0.008s)
[473.766214] Starting dynamic subtest: vecs0
[473.767173] Dynamic subtest vecs0: SUCCESS (0.006s)
[473.778899] Starting dynamic subtest: vecs1
[473.780234] Dynamic subtest vecs1: SUCCESS (0.006s)
[473.791700] Starting dynamic subtest: ccs0
[473.792865] Dynamic subtest ccs0: SUCCESS (0.009s)
[473.793955] Subtest exec-shared-gtt: SUCCESS (0.061s)
[474.045348] [063/134] (554s left) prime_vgem (basic-fence-flip)
[474.130480] Starting subtest: basic-fence-flip
[474.258879] Subtest basic-fence-flip: SKIP (0.128s)
[474.416859] [064/134] (554s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[474.598455] Starting subtest: cursorA-vs-flipB-varying-size
[474.601602] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[474.763439] [065/134] (554s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[474.949424] Starting subtest: nonblocking-crc-frame-sequence
[474.951705] Starting dynamic subtest: pipe-A-DP-3
[475.703892] Dynamic subtest pipe-A-DP-3: SUCCESS (0.752s)
[475.729907] Starting dynamic subtest: pipe-B-DP-3
[476.336496] Dynamic subtest pipe-B-DP-3: SUCCESS (0.626s)
[476.356103] Starting dynamic subtest: pipe-C-DP-3
[476.965563] Dynamic subtest pipe-C-DP-3: SUCCESS (0.627s)
[476.984129] Starting dynamic subtest: pipe-D-DP-3
[477.597039] Dynamic subtest pipe-D-DP-3: SUCCESS (0.629s)
[477.598022] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.647s)
[477.925637] [066/134] (551s left) syncobj_timeline (etime-single-wait-all-submitted)
[478.002025] Starting subtest: etime-single-wait-all-submitted
[478.107102] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[478.276835] [067/134] (551s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[478.465492] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[478.467690] Starting dynamic subtest: pipe-A-valid-mode
[481.480650] Dynamic subtest pipe-A-valid-mode: SUCCESS (3.010s)
[481.482101] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (3.014s)
[482.026996] [068/134] (547s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[482.103937] Starting subtest: multi-wait-for-submit-submitted-signaled
[482.104838] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[482.260930] [069/134] (547s left) gem_mmap_gtt (cpuset-medium-copy)
[482.340839] Subtest cpuset-medium-copy: SKIP (0.000s)
[482.414474] [070/134] (547s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[482.599759] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[482.656674] [071/134] (546s left) gem_exec_schedule (wide)
[482.861328] Starting subtest: wide
[482.862220] Starting dynamic subtest: rcs0
[495.193916] Dynamic subtest rcs0: SUCCESS (12.331s)
[495.206335] Starting dynamic subtest: bcs0
[508.002573] Dynamic subtest bcs0: SUCCESS (12.807s)
[508.018611] Starting dynamic subtest: vcs0
[521.576870] Dynamic subtest vcs0: SUCCESS (13.573s)
[521.590335] Starting dynamic subtest: vcs1
[534.589557] Dynamic subtest vcs1: SUCCESS (13.011s)
[534.602062] Starting dynamic subtest: vecs0
[547.605197] Dynamic subtest vecs0: SUCCESS (13.014s)
[547.618056] Starting dynamic subtest: vecs1
[560.554611] Dynamic subtest vecs1: SUCCESS (12.948s)
[560.567919] Starting dynamic subtest: ccs0
[574.001000] Dynamic subtest ccs0: SUCCESS (13.445s)
[574.002756] Subtest wide: SUCCESS (91.138s)
[575.995034] [072/134] (453s left) gem_pipe_control_store_loop (fresh-buffer)
[576.075079] Starting subtest: fresh-buffer
[578.251706] Subtest fresh-buffer: SUCCESS (2.176s)
[578.431703] [073/134] (451s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[578.615313] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[578.649364] Starting dynamic subtest: pipe-A-plane-0
[578.651131] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[578.663913] Starting dynamic subtest: pipe-A-plane-3
[578.665666] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[578.677996] Starting dynamic subtest: pipe-A-plane-5
[578.679764] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[578.889084] Starting dynamic subtest: pipe-B-plane-0
[578.891103] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[578.911751] Starting dynamic subtest: pipe-B-plane-3
[578.913705] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[578.927109] Starting dynamic subtest: pipe-B-plane-5
[578.928819] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[578.975478] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.359s)
[579.240399] [074/134] (450s left) gem_eio (hibernate)
[579.551106] Starting subtest: hibernate
[594.933800] Subtest hibernate: SUCCESS (15.383s)
[606.705707] [075/134] (434s left) kms_psr (fbc-psr-sprite-plane-onoff)
[606.894174] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[606.956466] [076/134] (433s left) kms_cursor_crc (cursor-onscreen-128x42)
[607.347764] Starting subtest: cursor-onscreen-128x42
[607.351413] Starting dynamic subtest: pipe-A-DP-3
[610.163171] Dynamic subtest pipe-A-DP-3: SUCCESS (2.810s)
[610.218912] Starting dynamic subtest: pipe-D-DP-3
[612.910127] Dynamic subtest pipe-D-DP-3: SUCCESS (2.703s)
[612.911061] Subtest cursor-onscreen-128x42: SUCCESS (5.563s)
[613.338314] [077/134] (427s left) kms_cursor_crc (cursor-sliding-max-size)
[613.852754] Starting subtest: cursor-sliding-max-size
[613.855693] Subtest cursor-sliding-max-size: SKIP (0.000s)
[614.085753] [078/134] (426s left) gem_softpin (noreloc-s3)
[614.171023] Starting subtest: noreloc-S3
[634.456603] Subtest noreloc-S3: SUCCESS (5.516s)
[634.610205] [079/134] (406s left) syncobj_timeline (wait-all-complex)
[634.689124] Starting subtest: wait-all-complex
[634.905728] Subtest wait-all-complex: SUCCESS (0.215s)
[635.078728] [080/134] (406s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[635.278025] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[635.279717] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[635.475138] [081/134] (405s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[635.578305] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[635.580370] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[635.832492] [082/134] (405s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[636.020199] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[636.021946] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[636.345395] [083/134] (405s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[636.530070] Starting subtest: multiplane-rotation-cropping-top
[664.447104] Subtest multiplane-rotation-cropping-top: SUCCESS (27.917s)
[664.647489] [084/134] (376s left) gem_pread (display)
[664.729838] Subtest display: SKIP (0.000s)
[664.819384] [085/134] (376s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[665.544357] Starting subtest: syncobj-timeline-invalid-wait
[665.545572] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.002s)
[665.879342] [086/134] (375s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[666.075770] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[666.077762] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[666.228143] [087/134] (375s left) gem_exec_balancer (full-pulse)
[666.314516] Starting subtest: full-pulse
[668.345152] Subtest full-pulse: SUCCESS (2.031s)
[668.810083] [088/134] (373s left) gem_exec_reloc (basic-gtt-wc)
[668.895078] Subtest basic-gtt-wc: SKIP (0.000s)
[668.975874] [089/134] (372s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[669.160326] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[669.194018] Starting dynamic subtest: pipe-A-plane-0
[669.195839] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[669.209754] Starting dynamic subtest: pipe-A-plane-3
[669.211555] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[669.225266] Starting dynamic subtest: pipe-A-plane-5
[669.227011] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[669.429709] Starting dynamic subtest: pipe-B-plane-0
[669.431793] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[669.452177] Starting dynamic subtest: pipe-B-plane-3
[669.453929] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[669.468016] Starting dynamic subtest: pipe-B-plane-5
[669.469797] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[669.515808] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.354s)
[669.783134] [090/134] (372s left) kms_big_fb (linear-8bpp-rotate-90)
[669.975274] Starting subtest: linear-8bpp-rotate-90
[670.030885] Subtest linear-8bpp-rotate-90: SKIP (0.055s)
[670.250893] [091/134] (371s left) gem_eio (in-flight-contexts-10ms)
[670.531852] Starting subtest: in-flight-contexts-10ms
[684.483421] Subtest in-flight-contexts-10ms: SUCCESS (13.952s)
[684.786439] [092/134] (357s left) gem_spin_batch (spin-all-new)
[684.882630] Starting subtest: spin-all-new
[684.936615] Subtest spin-all-new: SUCCESS (0.054s)
[685.237498] [093/134] (357s left) api_intel_bb (destroy-bb)
[685.311133] Starting subtest: destroy-bb
[685.348232] Subtest destroy-bb: SUCCESS (0.036s)
[685.601781] [094/134] (356s left) gem_exec_schedule (thriceslice)
[685.691911] Starting subtest: thriceslice
[685.692877] Starting dynamic subtest: rcs0
[685.744450] Dynamic subtest rcs0: SUCCESS (0.052s)
[685.767082] Starting dynamic subtest: bcs0
[685.778746] Dynamic subtest bcs0: SUCCESS (0.033s)
[685.801263] Starting dynamic subtest: vcs0
[685.815883] Dynamic subtest vcs0: SUCCESS (0.035s)
[685.835849] Starting dynamic subtest: vcs1
[685.871631] Dynamic subtest vcs1: SUCCESS (0.054s)
[685.895192] Starting dynamic subtest: vecs0
[685.907572] Dynamic subtest vecs0: SUCCESS (0.034s)
[685.931039] Starting dynamic subtest: vecs1
[685.944757] Dynamic subtest vecs1: SUCCESS (0.035s)
[685.963448] Starting dynamic subtest: ccs0
[685.998888] Dynamic subtest ccs0: SUCCESS (0.053s)
[685.999960] Subtest thriceslice: SUCCESS (0.308s)
[686.421640] [095/134] (356s left) syncobj_wait (reset-signaled)
[686.501050] Starting subtest: reset-signaled
[686.501963] Subtest reset-signaled: SUCCESS (0.000s)
[686.686429] [096/134] (355s left) gem_ctx_persistence (process)
[686.778078] Starting subtest: process
[686.973345] Subtest process: SUCCESS (0.195s)
[687.137965] [097/134] (355s left) kms_joiner (basic-max-non-joiner)
[687.326002] Starting subtest: basic-max-non-joiner
[687.327719] Subtest basic-max-non-joiner: SKIP (0.000s)
[687.488089] [098/134] (355s left) kms_getfb (getfb-reject-nv12)
[687.677197] Starting subtest: getfb-reject-nv12
[687.678104] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[687.883876] [099/134] (354s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[688.076979] Starting subtest: fbc-indfb-scaledprimary
[690.632100] Subtest fbc-indfb-scaledprimary: SUCCESS (2.555s)
[690.882797] [100/134] (351s left) perf_pmu (most-busy-idle-check-all)
[690.951187] Starting subtest: most-busy-idle-check-all
[690.952189] Starting dynamic subtest: rcs0
[691.656463] Dynamic subtest rcs0: SUCCESS (0.704s)
[691.676329] Starting dynamic subtest: bcs0
[692.313245] Dynamic subtest bcs0: SUCCESS (0.654s)
[692.329993] Starting dynamic subtest: vcs0
[692.968554] Dynamic subtest vcs0: SUCCESS (0.653s)
[692.987977] Starting dynamic subtest: vcs1
[693.627257] Dynamic subtest vcs1: SUCCESS (0.654s)
[693.643283] Starting dynamic subtest: vecs0
[694.280250] Dynamic subtest vecs0: SUCCESS (0.652s)
[694.296945] Starting dynamic subtest: vecs1
[694.937300] Dynamic subtest vecs1: SUCCESS (0.656s)
[694.953426] Starting dynamic subtest: ccs0
[695.591247] Dynamic subtest ccs0: SUCCESS (0.653s)
[695.592152] Subtest most-busy-idle-check-all: SUCCESS (4.641s)
[695.746768] [101/134] (347s left) gen9_exec_parse (unaligned-jump)
[695.828034] Subtest unaligned-jump: SKIP (0.000s)
[695.896272] [102/134] (347s left) kms_prime (basic-modeset-hybrid)
[696.081672] Subtest basic-modeset-hybrid: SKIP (0.000s)
[696.304329] [103/134] (346s left) kms_flip (dpms-off-confusion)
[696.489264] Starting subtest: dpms-off-confusion
[696.493998] Starting dynamic subtest: A-DP3
[704.351176] Dynamic subtest A-DP3: SUCCESS (7.857s)
[704.368359] Starting dynamic subtest: B-DP3
[712.120245] Dynamic subtest B-DP3: SUCCESS (7.767s)
[712.136190] Starting dynamic subtest: C-DP3
[719.892129] Dynamic subtest C-DP3: SUCCESS (7.770s)
[719.908441] Starting dynamic subtest: D-DP3
[727.663237] Dynamic subtest D-DP3: SUCCESS (7.770s)
[727.665560] Subtest dpms-off-confusion: SUCCESS (31.176s)
[728.014834] [104/134] (315s left) i915_pm_rps (waitboost)
[728.100151] Starting subtest: waitboost
[731.946129] Subtest waitboost: SUCCESS (3.847s)
[732.115365] [105/134] (311s left) kms_color (degamma)
[732.301051] Starting subtest: degamma
[732.301947] Starting dynamic subtest: pipe-A-DP-3
[732.995353] Dynamic subtest pipe-A-DP-3: SUCCESS (0.692s)
[733.025163] Starting dynamic subtest: pipe-B-DP-3
[733.629859] Dynamic subtest pipe-B-DP-3: SUCCESS (0.633s)
[733.654143] Starting dynamic subtest: pipe-C-DP-3
[734.230634] Dynamic subtest pipe-C-DP-3: SUCCESS (0.597s)
[734.254843] Starting dynamic subtest: pipe-D-DP-3
[734.815609] Dynamic subtest pipe-D-DP-3: SUCCESS (0.584s)
[734.816605] Subtest degamma: SUCCESS (2.515s)
[735.166491] [106/134] (308s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[735.357807] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[735.359484] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[735.515616] [107/134] (307s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[735.791309] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[735.951591] [108/134] (307s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[736.135104] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[736.135991] Starting dynamic subtest: pipe-A-DP-3
[736.144350] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[736.158878] Starting dynamic subtest: pipe-B-DP-3
[736.167266] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[736.181361] Starting dynamic subtest: pipe-C-DP-3
[736.189670] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[736.203909] Starting dynamic subtest: pipe-D-DP-3
[736.214759] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[736.216896] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[736.642771] [109/134] (306s left) kms_fb_coherency (memset-crc)
[736.828065] Starting subtest: memset-crc
[736.828945] Starting dynamic subtest: mmap-offset-fixed
[737.370080] Dynamic subtest mmap-offset-fixed: SUCCESS (0.541s)
[737.460604] Subtest memset-crc: SUCCESS (0.633s)
[737.793992] [110/134] (305s left) kms_vblank (wait-forked-busy-hang)
[737.977202] Starting subtest: wait-forked-busy-hang
[737.978089] Starting dynamic subtest: pipe-A-DP-3
[764.132304] Dynamic subtest pipe-A-DP-3: SUCCESS (26.153s)
[764.149494] Starting dynamic subtest: pipe-D-DP-3
[789.073340] Dynamic subtest pipe-D-DP-3: SUCCESS (24.937s)
[789.074226] Subtest wait-forked-busy-hang: SUCCESS (51.097s)
[789.429422] [111/134] (254s left) syncobj_eventfd (binary-wait-signaled)
[789.514058] Starting subtest: binary-wait-signaled
[789.514970] Subtest binary-wait-signaled: SUCCESS (0.000s)
[789.696726] [112/134] (254s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[789.779172] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[789.858331] [113/134] (254s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[790.055572] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[790.123443] [114/134] (253s left) kms_psr (pr-sprite-plane-move)
[790.312134] Subtest pr-sprite-plane-move: SKIP (0.000s)
[790.374037] [115/134] (253s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[790.568996] Starting subtest: x-tiled-16bpp-rotate-180
[792.309896] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.740s)
[792.578867] [116/134] (251s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[792.773478] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[792.775808] Starting dynamic subtest: pipe-A-DP-3
[792.796892] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[792.811012] Starting dynamic subtest: pipe-B-DP-3
[792.832510] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[792.846569] Starting dynamic subtest: pipe-C-DP-3
[792.871885] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[792.885591] Starting dynamic subtest: pipe-D-DP-3
[792.909685] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[792.911905] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.015s)
[793.255285] [117/134] (250s left) gem_exec_params (no-vebox)
[793.338494] Starting subtest: no-vebox
[793.341219] Subtest no-vebox: SUCCESS (0.003s)
[793.521242] [118/134] (250s left) kms_force_connector_basic (prune-stale-modes)
[793.626337] Starting subtest: prune-stale-modes
[793.649743] Subtest prune-stale-modes: SUCCESS (0.023s)
[793.991164] [119/134] (250s left) i915_pm_rpm (system-suspend-execbuf)
[795.607574] Starting subtest: system-suspend-execbuf
[856.002610] Subtest system-suspend-execbuf: SUCCESS (44.987s)
[856.422521] [120/134] (187s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[856.498803] Starting subtest: invalid-single-wait-unsubmitted
[856.499721] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[856.676455] [121/134] (187s left) kms_addfb_basic (small-bo)
[856.866732] Starting subtest: small-bo
[856.867637] Subtest small-bo: SUCCESS (0.000s)
[857.053115] [122/134] (187s left) gem_mmap_wc (write-gtt-read-wc)
[857.130608] Subtest write-gtt-read-wc: SKIP (0.000s)
[857.200864] [123/134] (187s left) kms_force_connector_basic (force-load-detect)
[857.304341] Starting subtest: force-load-detect
[857.306081] Subtest force-load-detect: SKIP (0.000s)
[857.593997] [124/134] (187s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[857.782803] Starting subtest: fb-8bpc-vs-panel-8bpc
[857.783699] Starting dynamic subtest: pipe-A-DP-3
[858.198727] Dynamic subtest pipe-A-DP-3: SUCCESS (0.412s)
[858.200088] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.416s)
[858.487955] [125/134] (186s left) kms_big_fb (4-tiled-addfb)
[858.681315] Starting subtest: 4-tiled-addfb
[858.682208] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[858.872175] [126/134] (186s left) gen7_exec_parse (basic-allocation)
[858.968738] Subtest basic-allocation: SKIP (0.000s)
[859.029574] [127/134] (185s left) gem_userptr_blits (unsync-overlap)
[859.112566] Subtest unsync-overlap: SKIP (0.000s)
[859.338344] [128/134] (185s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[859.535855] Starting subtest: basic-flip-before-cursor-varying-size
[860.590770] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.056s)
[860.910960] [129/134] (184s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[861.097935] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[863.121176] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (2.024s)
[863.291019] [130/134] (181s left) gem_ctx_bad_destroy (double-destroy)
[863.366247] Starting subtest: double-destroy
[863.367281] Subtest double-destroy: SUCCESS (0.000s)
[863.503169] [131/134] (181s left) core_setmaster (master-drop-set-root)
[863.621087] Starting subtest: master-drop-set-root
[863.653055] Subtest master-drop-set-root: SUCCESS (0.032s)
[863.737386] [132/134] (181s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[863.950087] Starting subtest: extended-modeset-hang-newfb-with-reset
[863.950951] Starting dynamic subtest: pipe-A
[884.923379] Dynamic subtest pipe-A: SUCCESS (20.970s)
[884.956100] Starting dynamic subtest: pipe-D
[905.899391] Dynamic subtest pipe-D: SUCCESS (20.967s)
[905.900798] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (41.951s)
[906.207138] [133/134] (139s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-render)
[906.396483] Starting subtest: fbc-abgr161616f-draw-render
[906.398104] Subtest fbc-abgr161616f-draw-render: SKIP (0.000s)
[906.596800] [134/134] (138s left) kms_lease (possible-crtcs-filtering)
[906.794826] Starting subtest: possible-crtcs-filtering
[906.802270] Subtest possible-crtcs-filtering: SUCCESS (0.008s)
[906.993774] 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.