[63.010777] Initializing watchdogs
[63.010841]   /dev/watchdog0
[63.030154] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.040306] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.043858] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.047304] [001/134] (960s left) gem_ccs (block-multicopy-compressed)
[63.129229] Starting subtest: block-multicopy-compressed
[63.130169] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[63.178403] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.049s)
[63.185802] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[63.272388] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.094s)
[63.279803] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[63.289097] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[63.296527] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[63.390326] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.101s)
[63.397510] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[63.406781] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[63.414261] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[63.504774] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.098s)
[63.512231] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[63.524056] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.019s)
[63.532060] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[63.630569] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.106s)
[63.631456] Subtest block-multicopy-compressed: SUCCESS (0.503s)
[63.839229] [002/134] (959s left) kms_vrr (negative-basic)
[64.016607] Starting subtest: negative-basic
[64.019117] Starting dynamic subtest: pipe-A-DP-3
[69.496958] Dynamic subtest pipe-A-DP-3: SUCCESS (5.484s)
[69.586420] Subtest negative-basic: SUCCESS (5.577s)
[69.899617] [003/134] (953s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[70.080473] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[70.082157] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[70.234620] [004/134] (953s left) gem_mmap_offset (partial-remap)
[70.305205] Starting subtest: partial-remap
[70.306127] Starting dynamic subtest: lmem0
[70.308709] Dynamic subtest lmem0: SUCCESS (0.003s)
[70.317221] Starting dynamic subtest: smem0
[70.319367] Dynamic subtest smem0: SUCCESS (0.004s)
[70.320480] Subtest partial-remap: SUCCESS (0.008s)
[70.511488] [005/134] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[70.694496] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[70.696173] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[70.849188] [006/134] (953s left) kms_plane_scaling (planes-downscale-factor-0-75)
[71.031542] Starting subtest: planes-downscale-factor-0-75
[71.032269] Starting dynamic subtest: pipe-A
[71.119905] Dynamic subtest pipe-A: SUCCESS (0.090s)
[71.129936] Starting dynamic subtest: pipe-B
[71.344286] Dynamic subtest pipe-B: SUCCESS (0.224s)
[71.359965] Starting dynamic subtest: pipe-C
[71.573327] Dynamic subtest pipe-C: SUCCESS (0.229s)
[71.582059] Starting dynamic subtest: pipe-D
[71.770075] Dynamic subtest pipe-D: SUCCESS (0.196s)
[71.771038] Subtest planes-downscale-factor-0-75: SUCCESS (0.741s)
[72.125172] [007/134] (951s left) gem_exec_whisper (basic-queues-all)
[72.213059] Starting subtest: basic-queues-all
[94.019915] Subtest basic-queues-all: SUCCESS (21.808s)
[94.266370] [008/134] (929s left) kms_plane (plane-position-covered)
[94.441580] Starting subtest: plane-position-covered
[94.870091] Starting dynamic subtest: pipe-A-plane-1
[95.311654] Dynamic subtest pipe-A-plane-1: SUCCESS (0.441s)
[95.324718] Starting dynamic subtest: pipe-A-plane-2
[95.775184] Dynamic subtest pipe-A-plane-2: SUCCESS (0.464s)
[95.784114] Starting dynamic subtest: pipe-A-plane-3
[96.250552] Dynamic subtest pipe-A-plane-3: SUCCESS (0.475s)
[96.261112] Starting dynamic subtest: pipe-A-plane-4
[96.714898] Dynamic subtest pipe-A-plane-4: SUCCESS (0.464s)
[96.723146] Starting dynamic subtest: pipe-A-plane-5
[96.735945] Dynamic subtest pipe-A-plane-5: SUCCESS (0.021s)
[97.092547] Starting dynamic subtest: pipe-B-plane-1
[97.508197] Dynamic subtest pipe-B-plane-1: SUCCESS (0.424s)
[97.516631] Starting dynamic subtest: pipe-B-plane-2
[97.945135] Dynamic subtest pipe-B-plane-2: SUCCESS (0.437s)
[97.953388] Starting dynamic subtest: pipe-B-plane-3
[98.383414] Dynamic subtest pipe-B-plane-3: SUCCESS (0.438s)
[98.391666] Starting dynamic subtest: pipe-B-plane-4
[98.841277] Dynamic subtest pipe-B-plane-4: SUCCESS (0.457s)
[98.849496] Starting dynamic subtest: pipe-B-plane-5
[98.863909] Dynamic subtest pipe-B-plane-5: SUCCESS (0.022s)
[98.864935] Subtest plane-position-covered: SUCCESS (4.421s)
[99.157251] [009/134] (925s left) gem_ctx_isolation (clean)
[99.237689] Starting subtest: clean
[99.238527] Starting dynamic subtest: rcs0
[99.362143] Dynamic subtest rcs0: SUCCESS (0.124s)
[99.370557] Starting dynamic subtest: bcs0
[99.492953] Dynamic subtest bcs0: SUCCESS (0.131s)
[99.501210] Starting dynamic subtest: vcs0
[99.614966] Dynamic subtest vcs0: SUCCESS (0.122s)
[99.623180] Starting dynamic subtest: vcs1
[99.749286] Dynamic subtest vcs1: SUCCESS (0.134s)
[99.757379] Starting dynamic subtest: vecs0
[99.876552] Dynamic subtest vecs0: SUCCESS (0.127s)
[99.884598] Starting dynamic subtest: vecs1
[100.007101] Dynamic subtest vecs1: SUCCESS (0.130s)
[100.015229] Starting dynamic subtest: ccs0
[100.128764] Dynamic subtest ccs0: SUCCESS (0.121s)
[100.129591] Subtest clean: SUCCESS (0.891s)
[100.427921] [010/134] (923s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[100.616452] Starting subtest: y-tiled-8bpp-rotate-0
[100.618328] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[100.781578] [011/134] (923s left) sw_sync (sync_multi_consumer)
[100.825237] Starting subtest: sync_multi_consumer
[101.169514] Subtest sync_multi_consumer: SUCCESS (0.345s)
[101.298387] [012/134] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[101.482902] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[101.484557] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[101.646968] [013/134] (922s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[101.992927] Starting subtest: cursor-rapid-movement-64x21
[101.995859] Starting dynamic subtest: pipe-A-DP-3
[102.487174] Dynamic subtest pipe-A-DP-3: SUCCESS (0.491s)
[102.518232] Starting dynamic subtest: pipe-D-DP-3
[102.882916] Dynamic subtest pipe-D-DP-3: SUCCESS (0.371s)
[102.883905] Subtest cursor-rapid-movement-64x21: SUCCESS (0.890s)
[103.397576] [014/134] (921s left) kms_chamelium_frames (hdmi-crc-single)
[103.657857] Subtest hdmi-crc-single: SKIP (0.000s)
[103.800689] [015/134] (920s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[103.983530] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[103.985256] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[104.145528] [016/134] (920s left) gem_mmap_wc (invalid-flags)
[104.213957] Subtest invalid-flags: SKIP (0.000s)
[104.299276] [017/134] (920s left) gem_flink_race (flink_name)
[104.340410] Starting subtest: flink_name
[109.738259] Subtest flink_name: SUCCESS (5.397s)
[109.886698] [018/134] (914s left) gem_exec_params (invalid-fence-in)
[110.011473] Starting subtest: invalid-fence-in
[110.012440] Subtest invalid-fence-in: SUCCESS (0.000s)
[110.186618] [019/134] (914s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[110.266487] Starting subtest: rel-constants-invalid-rel-gen5
[110.267405] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[110.455659] [020/134] (914s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[110.631998] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[110.632963] Starting dynamic subtest: pipe-A-DP-3
[110.641376] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[110.649362] Starting dynamic subtest: pipe-B-DP-3
[110.657802] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[110.665622] Starting dynamic subtest: pipe-C-DP-3
[110.673882] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[110.681713] Starting dynamic subtest: pipe-D-DP-3
[110.690360] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[110.692467] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[111.115424] [021/134] (913s left) gem_exec_schedule (preempt-engines)
[111.197231] Starting subtest: preempt-engines
[111.198157] Starting dynamic subtest: rcs0
[113.420444] Dynamic subtest rcs0: SUCCESS (2.222s)
[113.453891] Starting dynamic subtest: bcs0
[115.623201] Dynamic subtest bcs0: SUCCESS (2.201s)
[115.635648] Starting dynamic subtest: vcs0
[117.901314] Dynamic subtest vcs0: SUCCESS (2.277s)
[117.913693] Starting dynamic subtest: vcs1
[120.178220] Dynamic subtest vcs1: SUCCESS (2.275s)
[120.210806] Starting dynamic subtest: vecs0
[122.483787] Dynamic subtest vecs0: SUCCESS (2.304s)
[122.496748] Starting dynamic subtest: vecs1
[124.760824] Dynamic subtest vecs1: SUCCESS (2.275s)
[124.773916] Starting dynamic subtest: ccs0
[126.967459] Dynamic subtest ccs0: SUCCESS (2.206s)
[126.968484] Subtest preempt-engines: SUCCESS (15.770s)
[127.359659] [022/134] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[127.540490] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[127.542171] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[127.734643] [023/134] (897s left) api_intel_bb (blit-reloc-keep-cache)
[127.803023] Starting subtest: blit-reloc-keep-cache
[127.804766] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[127.951111] [024/134] (897s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[128.021503] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[128.125550] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[128.306106] [025/134] (897s left) kms_sequence (get-idle)
[128.487005] Starting subtest: get-idle
[128.487933] Starting dynamic subtest: pipe-A-DP-3
[130.882448] Dynamic subtest pipe-A-DP-3: SUCCESS (2.395s)
[130.893205] Starting dynamic subtest: pipe-B-DP-3
[133.202986] Dynamic subtest pipe-B-DP-3: SUCCESS (2.319s)
[133.214057] Starting dynamic subtest: pipe-C-DP-3
[135.493284] Dynamic subtest pipe-C-DP-3: SUCCESS (2.289s)
[135.505137] Starting dynamic subtest: pipe-D-DP-3
[137.789436] Dynamic subtest pipe-D-DP-3: SUCCESS (2.295s)
[137.790301] Subtest get-idle: SUCCESS (9.304s)
[138.182871] [026/134] (887s left) kms_flip (flip-vs-suspend)
[138.360245] Starting subtest: flip-vs-suspend
[138.364225] Starting dynamic subtest: A-DP3
[177.548462] Dynamic subtest A-DP3: SUCCESS (7.802s)
[177.559375] Starting dynamic subtest: B-DP3
[216.915012] Dynamic subtest B-DP3: SUCCESS (7.344s)
[216.926269] Starting dynamic subtest: C-DP3
[256.307787] Dynamic subtest C-DP3: SUCCESS (7.245s)
[256.318703] Starting dynamic subtest: D-DP3
[295.704480] Dynamic subtest D-DP3: SUCCESS (7.149s)
[295.712080] Subtest flip-vs-suspend: SUCCESS (29.549s)
[295.994204] [027/134] (729s left) intel_hwmon (hwmon-read)
[296.069996] Starting subtest: hwmon-read
[296.072012] Subtest hwmon-read: SUCCESS (0.001s)
[296.258719] [028/134] (729s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[296.443962] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[296.489441] [029/134] (729s left) kms_atomic_interruptible (legacy-setmode)
[296.670614] Starting subtest: legacy-setmode
[296.671547] Starting dynamic subtest: pipe-A-DP-3
[303.246812] Dynamic subtest pipe-A-DP-3: SUCCESS (6.575s)
[303.247730] Subtest legacy-setmode: SUCCESS (6.577s)
[303.859246] [030/134] (721s left) gem_exec_endless (dispatch)
[303.945471] Starting subtest: dispatch
[303.946452] Starting dynamic subtest: rcs0
[303.953002] Dynamic subtest rcs0: SUCCESS (0.007s)
[303.963708] Starting dynamic subtest: bcs0
[303.965557] Dynamic subtest bcs0: SUCCESS (0.009s)
[303.976305] Starting dynamic subtest: vcs0
[303.978115] Dynamic subtest vcs0: SUCCESS (0.006s)
[303.988420] Starting dynamic subtest: vcs1
[303.990308] Dynamic subtest vcs1: SUCCESS (0.006s)
[304.001026] Starting dynamic subtest: vecs0
[304.002804] Dynamic subtest vecs0: SUCCESS (0.007s)
[304.013656] Starting dynamic subtest: vecs1
[304.015780] Dynamic subtest vecs1: SUCCESS (0.006s)
[304.026359] Starting dynamic subtest: ccs0
[304.028658] Dynamic subtest ccs0: SUCCESS (0.008s)
[304.029704] Subtest dispatch: SUCCESS (0.054s)
[304.144825] [031/134] (721s left) kms_addfb_basic (addfb25-bad-modifier)
[304.324588] Starting subtest: addfb25-bad-modifier
[304.325476] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[304.484040] [032/134] (721s left) gem_ctx_param (invalid-size-get)
[304.550007] Starting subtest: invalid-size-get
[304.551952] Subtest invalid-size-get: SUCCESS (0.002s)
[304.731361] [033/134] (721s left) vgem_basic (second-client)
[304.834339] Starting subtest: second-client
[304.867741] Subtest second-client: SUCCESS (0.033s)
[305.011631] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[305.013699] [034/134] (721s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[305.219803] Starting subtest: 4-tiled-16bpp-rotate-180
[307.051633] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.831s)
[307.314747] [035/134] (718s left) gem_render_copy (y-tiled-ccs-to-linear)
[307.401928] Starting subtest: y-tiled-ccs-to-linear
[307.404074] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[307.688072] [036/134] (718s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-cpu)
[307.876437] Starting subtest: fbcpsr-abgr161616f-draw-mmap-cpu
[307.878127] Subtest fbcpsr-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[308.068264] [037/134] (718s left) gem_exec_reloc (basic-wc-read)
[308.149043] Subtest basic-wc-read: SKIP (0.000s)
[308.210579] [038/134] (718s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[308.399476] Starting subtest: psr-rgb101010-draw-pwrite
[308.401182] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[308.609791] [039/134] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[308.796927] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[308.798630] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[309.010279] [040/134] (717s left) gem_exec_reloc (basic-cpu-gtt-active)
[309.092152] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[309.186545] [041/134] (717s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[309.376356] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[309.377963] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[309.568314] [042/134] (717s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[309.756059] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[309.757701] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[309.951976] [043/134] (716s left) kms_psr (psr-dpms)
[310.145379] Subtest psr-dpms: SKIP (0.000s)
[310.210878] [044/134] (716s left) gem_mmap (big-bo)
[310.285536] Subtest big-bo: SKIP (0.000s)
[310.367734] [045/134] (716s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[310.556335] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[310.557954] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[310.722050] [046/134] (716s left) gem_ctx_engines (execute-allforone)
[310.807495] Starting subtest: execute-allforone
[310.849913] Subtest execute-allforone: SUCCESS (0.042s)
[311.204344] [047/134] (715s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[311.395095] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[311.410432] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.014s)
[311.538482] [048/134] (715s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[311.740671] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[311.742490] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[311.934140] [049/134] (715s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[312.127103] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[312.128772] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[312.282849] [050/134] (714s left) kms_content_protection (legacy-hdcp14)
[312.535586] Starting subtest: legacy-hdcp14
[312.820898] Starting dynamic subtest: pipe-A-DP-3
[434.266732] Dynamic subtest pipe-A-DP-3: FAIL (121.187s)
[434.267620] Subtest legacy-hdcp14: FAIL (121.582s)
[434.436408] [051/134] (592s left) i915_pm_freq_api (freq-reset-multiple)
[434.520706] Starting subtest: freq-reset-multiple
[434.521624] Starting dynamic subtest: gt0
[455.795920] Dynamic subtest gt0: SUCCESS (21.274s)
[455.796729] Subtest freq-reset-multiple: SUCCESS (21.275s)
[455.904024] [052/134] (571s left) gem_exec_params (mmapped)
[455.984084] Starting subtest: mmapped
[455.986064] Subtest mmapped: SUCCESS (0.002s)
[456.202109] [053/134] (571s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[456.285970] Starting subtest: x-tiled-to-vebox-y-tiled
[456.288133] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[456.571931] [054/134] (571s left) gen7_exec_parse (load-register-reg)
[456.657690] Subtest load-register-reg: SKIP (0.000s)
[456.748563] [055/134] (570s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[456.946746] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[458.235731] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.288s)
[458.417923] [056/134] (569s left) kms_pm_backlight (fade-with-suspend)
[458.606089] Subtest fade-with-suspend: SKIP (0.000s)
[458.662277] [057/134] (569s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[458.856386] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[458.858055] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[459.024961] [058/134] (568s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[459.215378] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[459.279338] [059/134] (568s left) sysfs_timeslice_duration (timeout)
[459.362625] Starting subtest: timeout
[459.363510] Starting dynamic subtest: vecs0
[461.273572] Dynamic subtest vecs0: SUCCESS (1.910s)
[461.284721] Starting dynamic subtest: ccs0
[463.134729] Dynamic subtest ccs0: SUCCESS (1.860s)
[463.146867] Starting dynamic subtest: vcs0
[464.881718] Dynamic subtest vcs0: SUCCESS (1.746s)
[464.893075] Starting dynamic subtest: bcs0
[466.128764] Dynamic subtest bcs0: SUCCESS (1.246s)
[466.140003] Starting dynamic subtest: vecs1
[467.968573] Dynamic subtest vecs1: SUCCESS (1.839s)
[467.979899] Starting dynamic subtest: rcs0
[469.731710] Dynamic subtest rcs0: SUCCESS (1.762s)
[469.743734] Starting dynamic subtest: vcs1
[471.415673] Dynamic subtest vcs1: SUCCESS (1.683s)
[471.416665] Subtest timeout: SUCCESS (12.053s)
[471.577517] [060/134] (556s left) kms_cdclk (mode-transition-all-outputs)
[471.762996] Starting subtest: mode-transition-all-outputs
[471.846428] Subtest mode-transition-all-outputs: SKIP (0.082s)
[472.101616] [061/134] (555s left) gem_pxp (create-valid-protected-context)
[474.714306] Starting subtest: create-valid-protected-context
[474.716134] Subtest create-valid-protected-context: SKIP (0.000s)
[474.817785] [062/134] (553s left) gem_ctx_shared (exec-shared-gtt)
[474.903750] Starting subtest: exec-shared-gtt
[474.904670] Starting dynamic subtest: rcs0
[474.912750] Dynamic subtest rcs0: SUCCESS (0.009s)
[474.925170] Starting dynamic subtest: bcs0
[474.926013] Dynamic subtest bcs0: SUCCESS (0.008s)
[474.938270] Starting dynamic subtest: vcs0
[474.939157] Dynamic subtest vcs0: SUCCESS (0.006s)
[474.950767] Starting dynamic subtest: vcs1
[474.951740] Dynamic subtest vcs1: SUCCESS (0.007s)
[474.963691] Starting dynamic subtest: vecs0
[474.964673] Dynamic subtest vecs0: SUCCESS (0.008s)
[474.977147] Starting dynamic subtest: vecs1
[474.978289] Dynamic subtest vecs1: SUCCESS (0.006s)
[474.989570] Starting dynamic subtest: ccs0
[474.990660] Dynamic subtest ccs0: SUCCESS (0.006s)
[474.991870] Subtest exec-shared-gtt: SUCCESS (0.056s)
[475.223332] [063/134] (552s left) prime_vgem (basic-fence-flip)
[475.320691] Starting subtest: basic-fence-flip
[475.445691] Subtest basic-fence-flip: SKIP (0.125s)
[475.635611] [064/134] (552s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[475.826384] Starting subtest: cursorA-vs-flipB-varying-size
[475.829446] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[475.950244] [065/134] (552s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[476.134698] Starting subtest: nonblocking-crc-frame-sequence
[476.135619] Starting dynamic subtest: pipe-A-DP-3
[476.875533] Dynamic subtest pipe-A-DP-3: SUCCESS (0.740s)
[476.891118] Starting dynamic subtest: pipe-B-DP-3
[477.479776] Dynamic subtest pipe-B-DP-3: SUCCESS (0.601s)
[477.498940] Starting dynamic subtest: pipe-C-DP-3
[478.110814] Dynamic subtest pipe-C-DP-3: SUCCESS (0.629s)
[478.131871] Starting dynamic subtest: pipe-D-DP-3
[478.747534] Dynamic subtest pipe-D-DP-3: SUCCESS (0.633s)
[478.748486] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.613s)
[479.083519] [066/134] (549s left) syncobj_timeline (etime-single-wait-all-submitted)
[479.161984] Starting subtest: etime-single-wait-all-submitted
[479.266991] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[479.431045] [067/134] (549s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[479.615856] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[479.616767] Starting dynamic subtest: pipe-A-valid-mode
[482.575014] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.955s)
[482.576730] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (2.958s)
[483.095074] [068/134] (545s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[483.173911] Starting subtest: multi-wait-for-submit-submitted-signaled
[483.174815] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[483.363348] [069/134] (545s left) gem_mmap_gtt (cpuset-medium-copy)
[483.438650] Subtest cpuset-medium-copy: SKIP (0.000s)
[483.506729] [070/134] (545s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[483.693857] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[483.758822] [071/134] (544s left) gem_exec_schedule (wide)
[483.973542] Starting subtest: wide
[483.974700] Starting dynamic subtest: rcs0
[496.194529] Dynamic subtest rcs0: SUCCESS (12.226s)
[496.221540] Starting dynamic subtest: bcs0
[509.183790] Dynamic subtest bcs0: SUCCESS (12.990s)
[509.197986] Starting dynamic subtest: vcs0
[522.354882] Dynamic subtest vcs0: SUCCESS (13.171s)
[522.367099] Starting dynamic subtest: vcs1
[535.631390] Dynamic subtest vcs1: SUCCESS (13.274s)
[535.643130] Starting dynamic subtest: vecs0
[548.649967] Dynamic subtest vecs0: SUCCESS (13.017s)
[548.662641] Starting dynamic subtest: vecs1
[561.691680] Dynamic subtest vecs1: SUCCESS (13.040s)
[561.704035] Starting dynamic subtest: ccs0
[574.938174] Dynamic subtest ccs0: SUCCESS (13.245s)
[574.939073] Subtest wide: SUCCESS (90.970s)
[576.956451] [072/134] (451s left) gem_pipe_control_store_loop (fresh-buffer)
[577.037301] Starting subtest: fresh-buffer
[579.215728] Subtest fresh-buffer: SUCCESS (2.178s)
[579.398180] [073/134] (449s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[579.580429] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[579.601911] Starting dynamic subtest: pipe-A-plane-0
[579.603732] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[579.615384] Starting dynamic subtest: pipe-A-plane-3
[579.617502] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[579.628874] Starting dynamic subtest: pipe-A-plane-5
[579.630659] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[579.833006] Starting dynamic subtest: pipe-B-plane-0
[579.834978] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[579.852766] Starting dynamic subtest: pipe-B-plane-3
[579.854682] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[579.867287] Starting dynamic subtest: pipe-B-plane-5
[579.868965] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[579.922745] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.341s)
[580.205984] [074/134] (448s left) gem_eio (hibernate)
[580.507324] Starting subtest: hibernate
[595.850580] Subtest hibernate: SUCCESS (15.343s)
[602.642276] [075/134] (432s left) kms_psr (fbc-psr-sprite-plane-onoff)
[602.847976] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[602.939683] [076/134] (432s left) kms_cursor_crc (cursor-onscreen-128x42)
[603.334730] Starting subtest: cursor-onscreen-128x42
[603.339912] Starting dynamic subtest: pipe-A-DP-3
[606.060357] Dynamic subtest pipe-A-DP-3: SUCCESS (2.720s)
[606.106184] Starting dynamic subtest: pipe-D-DP-3
[608.766279] Dynamic subtest pipe-D-DP-3: SUCCESS (2.672s)
[608.767189] Subtest cursor-onscreen-128x42: SUCCESS (5.432s)
[609.226604] [077/134] (425s left) kms_cursor_crc (cursor-sliding-max-size)
[609.749392] Starting subtest: cursor-sliding-max-size
[609.752014] Subtest cursor-sliding-max-size: SKIP (0.000s)
[609.990182] [078/134] (425s left) gem_softpin (noreloc-s3)
[610.074311] Starting subtest: noreloc-S3
[631.438418] Subtest noreloc-S3: SUCCESS (5.387s)
[631.584835] [079/134] (403s left) syncobj_timeline (wait-all-complex)
[631.670065] Starting subtest: wait-all-complex
[631.887154] Subtest wait-all-complex: SUCCESS (0.216s)
[632.013810] [080/134] (403s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[632.206886] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[632.208611] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[632.407271] [081/134] (403s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[632.492170] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[632.494142] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[632.767052] [082/134] (402s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[632.952223] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[632.953978] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[633.291857] [083/134] (402s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[633.477969] Starting subtest: multiplane-rotation-cropping-top
[661.445996] Subtest multiplane-rotation-cropping-top: SUCCESS (27.968s)
[661.688948] [084/134] (374s left) gem_pread (display)
[661.767887] Subtest display: SKIP (0.000s)
[661.865830] [085/134] (373s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[662.603208] Starting subtest: syncobj-timeline-invalid-wait
[662.604265] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.005s)
[662.977590] [086/134] (372s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[663.162821] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[663.164641] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[663.362313] [087/134] (372s left) gem_exec_balancer (full-pulse)
[663.448223] Starting subtest: full-pulse
[665.488054] Subtest full-pulse: SUCCESS (2.040s)
[665.896488] [088/134] (370s left) gem_exec_reloc (basic-gtt-wc)
[665.988559] Subtest basic-gtt-wc: SKIP (0.000s)
[666.079137] [089/134] (370s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[666.263032] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[666.293125] Starting dynamic subtest: pipe-A-plane-0
[666.294888] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[666.308288] Starting dynamic subtest: pipe-A-plane-3
[666.310054] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[666.323281] Starting dynamic subtest: pipe-A-plane-5
[666.324962] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[666.533836] Starting dynamic subtest: pipe-B-plane-0
[666.535978] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[666.557490] Starting dynamic subtest: pipe-B-plane-3
[666.559201] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[666.573217] Starting dynamic subtest: pipe-B-plane-5
[666.574972] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[666.618399] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.355s)
[666.890098] [090/134] (369s left) kms_big_fb (linear-8bpp-rotate-90)
[667.089103] Starting subtest: linear-8bpp-rotate-90
[667.155269] Subtest linear-8bpp-rotate-90: SKIP (0.065s)
[667.409678] [091/134] (368s left) gem_eio (in-flight-contexts-10ms)
[667.692789] Starting subtest: in-flight-contexts-10ms
[681.669813] Subtest in-flight-contexts-10ms: SUCCESS (13.979s)
[681.942889] [092/134] (354s left) gem_spin_batch (spin-all-new)
[682.031353] Starting subtest: spin-all-new
[682.086235] Subtest spin-all-new: SUCCESS (0.055s)
[682.426058] [093/134] (354s left) api_intel_bb (destroy-bb)
[682.503190] Starting subtest: destroy-bb
[682.539053] Subtest destroy-bb: SUCCESS (0.035s)
[682.774464] [094/134] (353s left) gem_exec_schedule (thriceslice)
[682.861341] Starting subtest: thriceslice
[682.862216] Starting dynamic subtest: rcs0
[682.914518] Dynamic subtest rcs0: SUCCESS (0.052s)
[682.934300] Starting dynamic subtest: bcs0
[682.970154] Dynamic subtest bcs0: SUCCESS (0.054s)
[683.010015] Starting dynamic subtest: vcs0
[683.037967] Dynamic subtest vcs0: SUCCESS (0.065s)
[683.062085] Starting dynamic subtest: vcs1
[683.099911] Dynamic subtest vcs1: SUCCESS (0.058s)
[683.127319] Starting dynamic subtest: vecs0
[683.159813] Dynamic subtest vecs0: SUCCESS (0.060s)
[683.191294] Starting dynamic subtest: vecs1
[683.222535] Dynamic subtest vecs1: SUCCESS (0.061s)
[683.248394] Starting dynamic subtest: ccs0
[683.262075] Dynamic subtest ccs0: SUCCESS (0.038s)
[683.263111] Subtest thriceslice: SUCCESS (0.401s)
[683.658639] [095/134] (352s left) syncobj_wait (reset-signaled)
[683.739127] Starting subtest: reset-signaled
[683.740080] Subtest reset-signaled: SUCCESS (0.000s)
[683.925282] [096/134] (352s left) gem_ctx_persistence (process)
[684.010211] Starting subtest: process
[684.223039] Subtest process: SUCCESS (0.212s)
[684.360801] [097/134] (352s left) kms_joiner (basic-max-non-joiner)
[684.547474] Starting subtest: basic-max-non-joiner
[684.549064] Subtest basic-max-non-joiner: SKIP (0.000s)
[684.701024] [098/134] (352s left) kms_getfb (getfb-reject-nv12)
[684.886078] Starting subtest: getfb-reject-nv12
[684.886939] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[685.081803] [099/134] (351s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[685.272851] Starting subtest: fbc-indfb-scaledprimary
[686.954389] Subtest fbc-indfb-scaledprimary: SUCCESS (1.682s)
[687.220320] [100/134] (349s left) perf_pmu (most-busy-idle-check-all)
[687.290737] Starting subtest: most-busy-idle-check-all
[687.291647] Starting dynamic subtest: rcs0
[687.992054] Dynamic subtest rcs0: SUCCESS (0.701s)
[688.010590] Starting dynamic subtest: bcs0
[688.652575] Dynamic subtest bcs0: SUCCESS (0.658s)
[688.673902] Starting dynamic subtest: vcs0
[689.313228] Dynamic subtest vcs0: SUCCESS (0.655s)
[689.361270] Starting dynamic subtest: vcs1
[689.987424] Dynamic subtest vcs1: SUCCESS (0.669s)
[690.012027] Starting dynamic subtest: vecs0
[690.656229] Dynamic subtest vecs0: SUCCESS (0.663s)
[690.674730] Starting dynamic subtest: vecs1
[691.313465] Dynamic subtest vecs1: SUCCESS (0.652s)
[691.331984] Starting dynamic subtest: ccs0
[691.972348] Dynamic subtest ccs0: SUCCESS (0.654s)
[691.978474] Subtest most-busy-idle-check-all: SUCCESS (4.684s)
[692.190436] [101/134] (344s left) gen9_exec_parse (unaligned-jump)
[692.273905] Subtest unaligned-jump: SKIP (0.000s)
[692.371126] [102/134] (344s left) kms_prime (basic-modeset-hybrid)
[692.560484] Subtest basic-modeset-hybrid: SKIP (0.000s)
[692.773933] [103/134] (344s left) kms_flip (dpms-off-confusion)
[692.962656] Starting subtest: dpms-off-confusion
[692.966051] Starting dynamic subtest: A-DP3
[700.798964] Dynamic subtest A-DP3: SUCCESS (7.833s)
[700.823556] Starting dynamic subtest: B-DP3
[708.562030] Dynamic subtest B-DP3: SUCCESS (7.761s)
[708.577892] Starting dynamic subtest: C-DP3
[716.330029] Dynamic subtest C-DP3: SUCCESS (7.767s)
[716.346157] Starting dynamic subtest: D-DP3
[724.106074] Dynamic subtest D-DP3: SUCCESS (7.775s)
[724.108282] Subtest dpms-off-confusion: SUCCESS (31.147s)
[724.476239] [104/134] (312s left) i915_pm_rps (waitboost)
[724.562136] Starting subtest: waitboost
[728.403518] Subtest waitboost: SUCCESS (3.842s)
[728.627784] [105/134] (308s left) kms_color (degamma)
[728.824972] Starting subtest: degamma
[728.825850] Starting dynamic subtest: pipe-A-DP-3
[729.517241] Dynamic subtest pipe-A-DP-3: SUCCESS (0.692s)
[729.548011] Starting dynamic subtest: pipe-B-DP-3
[730.102990] Dynamic subtest pipe-B-DP-3: SUCCESS (0.583s)
[730.126206] Starting dynamic subtest: pipe-C-DP-3
[730.682877] Dynamic subtest pipe-C-DP-3: SUCCESS (0.578s)
[730.701178] Starting dynamic subtest: pipe-D-DP-3
[731.298449] Dynamic subtest pipe-D-DP-3: SUCCESS (0.615s)
[731.299430] Subtest degamma: SUCCESS (2.475s)
[731.593720] [106/134] (305s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[731.786935] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[731.788616] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[731.992950] [107/134] (305s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[732.251903] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[732.403638] [108/134] (305s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[732.587333] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[732.589759] Starting dynamic subtest: pipe-A-DP-3
[732.598193] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[732.611877] Starting dynamic subtest: pipe-B-DP-3
[732.620288] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[732.633791] Starting dynamic subtest: pipe-C-DP-3
[732.641960] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[732.655598] Starting dynamic subtest: pipe-D-DP-3
[732.667184] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[732.669141] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[733.062607] [109/134] (304s left) kms_fb_coherency (memset-crc)
[733.248118] Starting subtest: memset-crc
[733.248964] Starting dynamic subtest: mmap-offset-fixed
[733.786509] Dynamic subtest mmap-offset-fixed: SUCCESS (0.538s)
[733.881747] Subtest memset-crc: SUCCESS (0.633s)
[734.223025] [110/134] (303s left) kms_vblank (wait-forked-busy-hang)
[734.413444] Starting subtest: wait-forked-busy-hang
[734.415830] Starting dynamic subtest: pipe-A-DP-3
[762.346120] Dynamic subtest pipe-A-DP-3: SUCCESS (27.930s)
[762.362987] Starting dynamic subtest: pipe-D-DP-3
[787.341035] Dynamic subtest pipe-D-DP-3: SUCCESS (24.990s)
[787.341926] Subtest wait-forked-busy-hang: SUCCESS (52.926s)
[787.624445] [111/134] (250s left) syncobj_eventfd (binary-wait-signaled)
[787.702924] Starting subtest: binary-wait-signaled
[787.703849] Subtest binary-wait-signaled: SUCCESS (0.000s)
[787.879980] [112/134] (250s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[787.959878] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[788.040016] [113/134] (250s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[788.229079] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[788.289638] [114/134] (249s left) kms_psr (pr-sprite-plane-move)
[788.478434] Subtest pr-sprite-plane-move: SKIP (0.000s)
[788.541627] [115/134] (249s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[788.737567] Starting subtest: x-tiled-16bpp-rotate-180
[790.476985] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.739s)
[790.748603] [116/134] (247s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[790.935985] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[790.936897] Starting dynamic subtest: pipe-A-DP-3
[790.958098] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[790.971920] Starting dynamic subtest: pipe-B-DP-3
[790.993148] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[791.007032] Starting dynamic subtest: pipe-C-DP-3
[791.032091] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[791.045713] Starting dynamic subtest: pipe-D-DP-3
[791.068842] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[791.070354] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.014s)
[791.423043] [117/134] (246s left) gem_exec_params (no-vebox)
[791.503214] Starting subtest: no-vebox
[791.506250] Subtest no-vebox: SUCCESS (0.003s)
[791.662031] [118/134] (246s left) kms_force_connector_basic (prune-stale-modes)
[791.767105] Starting subtest: prune-stale-modes
[791.789480] Subtest prune-stale-modes: SUCCESS (0.024s)
[792.156404] [119/134] (246s left) i915_pm_rpm (system-suspend-execbuf)
[793.855826] Starting subtest: system-suspend-execbuf
[854.223889] Subtest system-suspend-execbuf: SUCCESS (44.977s)
[854.644121] [120/134] (183s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[854.726963] Starting subtest: invalid-single-wait-unsubmitted
[854.727933] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[854.918269] [121/134] (183s left) kms_addfb_basic (small-bo)
[855.103775] Starting subtest: small-bo
[855.104677] Subtest small-bo: SUCCESS (0.000s)
[855.301135] [122/134] (183s left) gem_mmap_wc (write-gtt-read-wc)
[855.378789] Subtest write-gtt-read-wc: SKIP (0.000s)
[855.476950] [123/134] (183s left) kms_force_connector_basic (force-load-detect)
[855.579105] Starting subtest: force-load-detect
[855.580858] Subtest force-load-detect: SKIP (0.000s)
[855.827185] [124/134] (183s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[856.013753] Starting subtest: fb-8bpc-vs-panel-8bpc
[856.014648] Starting dynamic subtest: pipe-A-DP-3
[856.393245] Dynamic subtest pipe-A-DP-3: SUCCESS (0.375s)
[856.394663] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.379s)
[856.661219] [125/134] (182s left) kms_big_fb (4-tiled-addfb)
[856.866965] Starting subtest: 4-tiled-addfb
[856.867900] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[857.062214] [126/134] (182s left) gen7_exec_parse (basic-allocation)
[857.144655] Subtest basic-allocation: SKIP (0.000s)
[857.246161] [127/134] (181s left) gem_userptr_blits (unsync-overlap)
[857.338106] Subtest unsync-overlap: SKIP (0.000s)
[857.512820] [128/134] (181s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[857.698905] Starting subtest: basic-flip-before-cursor-varying-size
[858.750008] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.050s)
[859.057496] [129/134] (180s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[859.252825] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[861.365781] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (2.114s)
[861.619033] [130/134] (177s left) gem_ctx_bad_destroy (double-destroy)
[861.696094] Starting subtest: double-destroy
[861.696955] Subtest double-destroy: SUCCESS (0.000s)
[861.868116] [131/134] (177s left) core_setmaster (master-drop-set-root)
[862.022180] Starting subtest: master-drop-set-root
[862.047118] Subtest master-drop-set-root: SUCCESS (0.025s)
[862.130665] [132/134] (177s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[862.341089] Starting subtest: extended-modeset-hang-newfb-with-reset
[862.343415] Starting dynamic subtest: pipe-A
[883.570322] Dynamic subtest pipe-A: SUCCESS (21.226s)
[883.601691] Starting dynamic subtest: pipe-D
[904.550053] Dynamic subtest pipe-D: SUCCESS (20.970s)
[904.551356] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (42.210s)
[904.873786] [133/134] (134s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-render)
[905.063742] Starting subtest: fbc-abgr161616f-draw-render
[905.065480] Subtest fbc-abgr161616f-draw-render: SKIP (0.000s)
[905.271294] [134/134] (134s left) kms_lease (possible-crtcs-filtering)
[905.463402] Starting subtest: possible-crtcs-filtering
[905.472733] Subtest possible-crtcs-filtering: SUCCESS (0.009s)
[905.635959] 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.