[56.591097] Initializing watchdogs
[56.591142]   /dev/watchdog0
[56.605176] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.609273] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.611385] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.614765] [001/131] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[56.747419] Starting subtest: psr-rgb565-draw-mmap-wc
[63.416120] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.712s)
[63.547155] [002/131] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[63.645634] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[71.015072] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.389s)
[71.195280] [003/131] (945s left) i915_drm_fdinfo (virtual-busy-all)
[71.243336] Starting subtest: virtual-busy-all
[71.247621] Subtest virtual-busy-all: SKIP (0.000s)
[71.321786] [004/131] (945s left) kms_addfb_basic (bad-pitch-1024)
[71.379538] Starting subtest: bad-pitch-1024
[71.381624] Subtest bad-pitch-1024: SUCCESS (0.000s)
[71.547942] [005/131] (945s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[71.660858] Starting subtest: cursorA-vs-flipB-varying-size
[71.665220] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[71.827758] [006/131] (945s left) kms_vrr (flip-suspend)
[71.919575] Starting subtest: flip-suspend
[71.925826] Subtest flip-suspend: SKIP (0.000s)
[72.012779] [007/131] (945s left) i915_suspend (basic-s2idle-without-i915)
[72.044633] Starting subtest: basic-s2idle-without-i915
[93.383371] Subtest basic-s2idle-without-i915: SUCCESS (9.406s)
[93.513464] [008/131] (923s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[93.585714] Subtest no-spare-fences-busy: SKIP (0.000s)
[93.655039] [009/131] (923s left) gem_tiled_wc
[93.774732] [010/131] (923s left) perf_pmu (gt-awake)
[93.814790] Starting subtest: gt-awake
[102.842672] Subtest gt-awake: SUCCESS (9.198s)
[102.972362] [011/131] (914s left) gem_ctx_persistence (heartbeat-many)
[103.032267] Starting subtest: heartbeat-many
[103.036894] Subtest heartbeat-many: SKIP (0.000s)
[103.183574] [012/131] (914s left) kms_psr (fbc-psr-cursor-plane-onoff)
[103.280248] Starting subtest: fbc-psr-cursor-plane-onoff
[103.282859] Starting dynamic subtest: eDP-1
[103.287459] Dynamic subtest eDP-1: SKIP (0.000s)
[103.291958] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[103.375399] [013/131] (914s left) api_intel_bb (object-noreloc-keep-cache-simple)
[103.433358] Starting subtest: object-noreloc-keep-cache-simple
[103.437696] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[103.593782] [014/131] (914s left) kms_chamelium_frames (hdmi-crc-fast)
[103.972675] Subtest hdmi-crc-fast: SKIP (0.000s)
[104.765453] [015/131] (912s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[104.889300] Starting subtest: 4-tiled-64bpp-rotate-270
[104.909183] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[105.064511] [016/131] (912s left) kms_setmode (invalid-clone-single-crtc-stealing)
[105.127687] Starting subtest: invalid-clone-single-crtc-stealing
[105.134044] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[105.240952] [017/131] (912s left) gem_ctx_param (invalid-ctx-set)
[105.306866] Starting subtest: invalid-ctx-set
[105.311834] Subtest invalid-ctx-set: SUCCESS (0.003s)
[105.443037] [018/131] (912s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[105.544710] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[105.548740] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[105.663378] [019/131] (912s left) kms_flip (plain-flip-fb-recreate-interruptible)
[105.777402] Starting subtest: plain-flip-fb-recreate-interruptible
[105.779416] Starting dynamic subtest: A-eDP1
[114.665531] Dynamic subtest A-eDP1: SUCCESS (8.924s)
[114.673202] Starting dynamic subtest: B-eDP1
[123.453017] Dynamic subtest B-eDP1: SUCCESS (8.798s)
[123.464357] Starting dynamic subtest: C-eDP1
[132.267626] Dynamic subtest C-eDP1: SUCCESS (8.811s)
[132.277062] Starting dynamic subtest: D-eDP1
[141.106188] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[141.110569] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.379s)
[142.307485] [020/131] (875s left) gem_busy (parallel)
[142.506646] Starting subtest: parallel
[142.508591] Starting dynamic subtest: rcs0
[143.866199] Dynamic subtest rcs0: SUCCESS (1.360s)
[143.877773] Starting dynamic subtest: bcs0
[145.849250] Dynamic subtest bcs0: SUCCESS (1.982s)
[145.860345] Starting dynamic subtest: vcs0
[147.834136] Dynamic subtest vcs0: SUCCESS (1.984s)
[147.845620] Starting dynamic subtest: vcs1
[149.819209] Dynamic subtest vcs1: SUCCESS (1.984s)
[149.830510] Starting dynamic subtest: vecs0
[151.865836] Dynamic subtest vecs0: SUCCESS (2.046s)
[151.876485] Starting dynamic subtest: ccs0
[153.849834] Dynamic subtest ccs0: SUCCESS (1.983s)
[153.852716] Subtest parallel: SUCCESS (11.347s)
[154.130867] [021/131] (863s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[154.249662] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[158.557372] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.314s)
[159.723800] [022/131] (858s left) gem_exec_schedule (preempt-queue)
[159.805945] Subtest preempt-queue: SKIP (0.000s)
[160.112231] [023/131] (857s left) kms_psr (psr-sprite-plane-move)
[160.216419] Starting subtest: psr-sprite-plane-move
[160.218823] Starting dynamic subtest: eDP-1
[161.935694] Dynamic subtest eDP-1: SUCCESS (1.719s)
[161.937648] Subtest psr-sprite-plane-move: SUCCESS (1.720s)
[162.780092] [024/131] (855s left) gem_ctx_isolation (preservation-s3)
[162.846899] Starting subtest: preservation-S3
[162.849220] Starting dynamic subtest: rcs0
[178.984734] Dynamic subtest rcs0: SUCCESS (1.318s)
[178.994547] Starting dynamic subtest: bcs0
[194.972121] Dynamic subtest bcs0: SUCCESS (1.323s)
[194.980576] Starting dynamic subtest: vcs0
[210.985940] Dynamic subtest vcs0: SUCCESS (2.490s)
[210.997174] Starting dynamic subtest: vcs1
[228.965521] Dynamic subtest vcs1: SUCCESS (5.078s)
[228.973733] Starting dynamic subtest: vecs0
[246.968229] Dynamic subtest vecs0: SUCCESS (5.136s)
[246.977705] Starting dynamic subtest: ccs0
[264.964775] Dynamic subtest ccs0: SUCCESS (3.288s)
[264.966996] Subtest preservation-S3: SUCCESS (18.637s)
[265.230400] [025/131] (752s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[265.331684] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[272.053163] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.867s)
[272.185473] [026/131] (745s left) gem_mmap_wc (write)
[272.242434] Subtest write: SKIP (0.000s)
[272.313657] [027/131] (745s left) kms_plane_scaling (planes-downscale-factor-0-5)
[272.411969] Starting subtest: planes-downscale-factor-0-5
[272.414181] Starting dynamic subtest: pipe-A
[272.433240] Dynamic subtest pipe-A: SKIP (0.017s)
[272.442511] Starting dynamic subtest: pipe-B
[272.461242] Dynamic subtest pipe-B: SKIP (0.029s)
[272.468997] Starting dynamic subtest: pipe-C
[272.490782] Dynamic subtest pipe-C: SKIP (0.029s)
[272.500510] Starting dynamic subtest: pipe-D
[272.521209] Dynamic subtest pipe-D: SKIP (0.030s)
[272.525312] Subtest planes-downscale-factor-0-5: SKIP (0.107s)
[272.653290] [028/131] (745s left) kms_invalid_mode (bad-vsync-start)
[272.751110] Starting subtest: bad-vsync-start
[272.753328] Starting dynamic subtest: pipe-A-eDP-1
[273.038388] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[273.047097] Starting dynamic subtest: pipe-B-eDP-1
[273.049440] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[273.058563] Starting dynamic subtest: pipe-C-eDP-1
[273.060852] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[273.068538] Starting dynamic subtest: pipe-D-eDP-1
[273.070584] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[273.072638] Subtest bad-vsync-start: SUCCESS (0.299s)
[273.870330] [029/131] (744s left) kms_cursor_crc (cursor-random-128x128)
[274.070268] Starting subtest: cursor-random-128x128
[274.072734] Starting dynamic subtest: pipe-A-eDP-1
[277.365037] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.321s)
[277.393524] Starting dynamic subtest: pipe-D-eDP-1
[281.347098] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.978s)
[281.349289] Subtest cursor-random-128x128: SUCCESS (7.325s)
[282.174515] [030/131] (736s left) kms_properties (get_properties-sanity-non-atomic)
[282.265935] Starting subtest: get_properties-sanity-non-atomic
[282.268184] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[282.361303] [031/131] (735s left) gem_madvise (dontneed-before-mmap)
[282.406297] Starting subtest: dontneed-before-mmap
[282.428449] Subtest dontneed-before-mmap: SUCCESS (0.024s)
[282.567094] [032/131] (735s left) gem_exec_reloc (basic-write-read-noreloc)
[282.631031] Subtest basic-write-read-noreloc: SKIP (0.000s)
[282.716940] [033/131] (735s left) kms_plane_multiple (tiling-yf)
[282.815275] Starting subtest: tiling-yf
[282.819598] Subtest tiling-yf: SKIP (0.000s)
[282.907732] [034/131] (735s left) gem_exec_reloc (basic-wc-gtt-active)
[282.977138] Subtest basic-wc-gtt-active: SKIP (0.000s)
[283.067881] [035/131] (735s left) i915_hangman (gt-error-state-capture)
[283.137687] Starting subtest: gt-error-state-capture
[283.139349] Starting dynamic subtest: rcs0
[294.636944] Dynamic subtest rcs0: SUCCESS (11.520s)
[294.648278] Starting dynamic subtest: bcs0
[306.669775] Dynamic subtest bcs0: SUCCESS (12.024s)
[306.680701] Starting dynamic subtest: vcs0
[318.637367] Dynamic subtest vcs0: SUCCESS (11.963s)
[318.649562] Starting dynamic subtest: vcs1
[330.605679] Dynamic subtest vcs1: SUCCESS (11.967s)
[330.617029] Starting dynamic subtest: vecs0
[341.613585] Dynamic subtest vecs0: SUCCESS (11.008s)
[341.625344] Starting dynamic subtest: ccs0
[351.661812] Dynamic subtest ccs0: SUCCESS (10.049s)
[351.664690] Subtest gt-error-state-capture: SUCCESS (68.546s)
[351.766922] [036/131] (666s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[351.819499] Subtest tiled-to-untiled: SKIP (0.000s)
[351.913721] [037/131] (666s left) kms_async_flips (invalid-async-flip)
[352.018169] Starting subtest: invalid-async-flip
[352.390170] Starting dynamic subtest: pipe-A-eDP-1
[353.239036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.849s)
[353.593787] Starting dynamic subtest: pipe-B-eDP-1
[354.363284] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.776s)
[354.720562] Starting dynamic subtest: pipe-C-eDP-1
[355.478299] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[355.828874] Starting dynamic subtest: pipe-D-eDP-1
[356.602042] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[356.604419] Subtest invalid-async-flip: SUCCESS (4.587s)
[357.781299] [038/131] (660s left) syncobj_timeline (etime-single-wait-submitted)
[357.862773] Starting subtest: etime-single-wait-submitted
[357.970631] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[358.068650] [039/131] (660s left) gem_tiled_partial_pwrite_pread (writes)
[358.134129] Subtest writes: SKIP (0.000s)
[358.200007] [040/131] (660s left) gem_eio (in-flight-internal-immediate)
[358.383142] Starting subtest: in-flight-internal-immediate
[359.742571] Subtest in-flight-internal-immediate: SUCCESS (1.358s)
[359.900441] [041/131] (658s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[360.007749] Starting subtest: x-tiled-16bpp-rotate-180
[361.297836] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.289s)
[361.465791] [042/131] (657s left) kms_chamelium_color (ctm-0-25)
[361.550172] Subtest ctm-0-25: SKIP (0.000s)
[361.597122] [043/131] (657s left) kms_dp_linktrain_fallback (dsc-fallback)
[361.687831] Starting subtest: dsc-fallback
[361.693031] Subtest dsc-fallback: SKIP (0.000s)
[361.782928] [044/131] (656s left) gem_mmap (pf-nonblock)
[361.849692] Subtest pf-nonblock: SKIP (0.000s)
[361.911655] [045/131] (656s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[362.009493] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[362.011362] Starting dynamic subtest: pipe-A-eDP-1
[362.029892] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[362.039995] Starting dynamic subtest: pipe-B-eDP-1
[362.057563] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[362.065852] Starting dynamic subtest: pipe-C-eDP-1
[362.083173] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[362.091565] Starting dynamic subtest: pipe-D-eDP-1
[362.109836] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[362.113435] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[364.331443] [046/131] (654s left) gem_pxp (reject-modify-context-protection-on)
[364.467560] Starting subtest: reject-modify-context-protection-on
[364.469978] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[364.596472] [047/131] (654s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[369.584287] Starting subtest: pr-overlay-plane-move-continuous-sf
[369.591627] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.004s)
[370.457364] [048/131] (648s left) gem_render_copy_redux (interruptible)
[370.526796] Starting subtest: interruptible
[370.810029] Subtest interruptible: SUCCESS (0.283s)
[370.955301] [049/131] (648s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[371.055631] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[371.059556] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[371.197067] [050/131] (647s left) prime_mmap (test_aperture_limit)
[371.259876] Starting subtest: test_aperture_limit
[371.262176] Starting dynamic subtest: test_aperture_limit-smem
[371.270333] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[371.274834] Subtest test_aperture_limit: SKIP (0.008s)
[371.390733] [051/131] (647s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[371.477927] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[371.479890] Starting dynamic subtest: pipe-A-default-mode
[371.776384] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[371.781101] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.296s)
[372.591645] [052/131] (646s left) api_intel_allocator (two-level-inception-interruptible)
[372.655005] Starting subtest: two-level-inception-interruptible
[378.063918] Subtest two-level-inception-interruptible: SUCCESS (5.408s)
[378.222153] [053/131] (640s left) gem_mmap_offset (mmap-boundaries)
[378.284450] Starting subtest: mmap-boundaries
[378.286282] Starting dynamic subtest: smem0
[378.578883] Dynamic subtest smem0: SUCCESS (0.295s)
[378.581388] Subtest mmap-boundaries: SUCCESS (0.296s)
[378.741869] [054/131] (640s left) gem_readwrite (read-write)
[378.817947] Subtest read-write: SKIP (0.000s)
[378.891377] [055/131] (640s left) syncobj_wait (invalid-signal-zero-handles)
[378.959904] Starting subtest: invalid-signal-zero-handles
[378.962201] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[379.081196] [056/131] (640s left) kms_pm_backlight (brightness-with-dpms)
[379.171166] Starting subtest: brightness-with-dpms
[379.220437] Starting dynamic subtest: eDP-1
[381.663672] Dynamic subtest eDP-1: SUCCESS (2.439s)
[381.666098] Subtest brightness-with-dpms: SUCCESS (2.490s)
[382.559831] [057/131] (636s left) kms_big_fb (linear-64bpp-rotate-270)
[382.657976] Starting subtest: linear-64bpp-rotate-270
[382.676767] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[382.847577] [058/131] (636s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[382.948275] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[382.952305] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[383.083643] [059/131] (636s left) sriov_basic (bind-unbind-vf)
[383.137319] Starting subtest: bind-unbind-vf
[383.139452] Starting dynamic subtest: vf-1
[383.216613] Dynamic subtest vf-1: FAIL (0.027s)
[383.225245] Starting dynamic subtest: vf-2
[383.296782] Dynamic subtest vf-2: FAIL (0.003s)
[383.307379] Starting dynamic subtest: vf-3
[383.379512] Dynamic subtest vf-3: FAIL (0.003s)
[383.389167] Starting dynamic subtest: vf-4
[383.449599] Dynamic subtest vf-4: FAIL (0.003s)
[383.458795] Starting dynamic subtest: vf-5
[383.517351] Dynamic subtest vf-5: FAIL (0.003s)
[383.526530] Starting dynamic subtest: vf-6
[383.585509] Dynamic subtest vf-6: FAIL (0.003s)
[383.594737] Starting dynamic subtest: vf-7
[383.654071] Dynamic subtest vf-7: FAIL (0.004s)
[383.662949] Starting dynamic subtest: vf-random
[383.722651] Dynamic subtest vf-random: FAIL (0.003s)
[383.733126] Starting dynamic subtest: vf-last
[383.792618] Dynamic subtest vf-last: FAIL (0.452s)
[383.794284] Subtest bind-unbind-vf: FAIL (0.510s)
[383.831966] [060/131] (635s left) gem_lmem_swapping (verify-random-ccs)
[383.879198] Subtest verify-random-ccs: SKIP (0.000s)
[383.922962] [061/131] (635s left) gem_exec_fence (syncobj-timeline-repeat)
[384.486974] Starting subtest: syncobj-timeline-repeat
[384.704409] Subtest syncobj-timeline-repeat: SUCCESS (0.217s)
[385.868427] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[385.871467] [062/131] (633s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[385.920721] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[385.922994] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[386.065394] [063/131] (633s left) kms_psr (fbc-pr-primary-mmap-cpu)
[386.159980] Starting subtest: fbc-pr-primary-mmap-cpu
[386.164168] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[386.254913] [064/131] (633s left) kms_hdmi_inject (inject-4k)
[386.599309] Starting subtest: inject-4k
[386.914628] Subtest inject-4k: SUCCESS (0.316s)
[387.527926] [065/131] (632s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[387.625156] Starting subtest: fbcpsr-rgb565-draw-render
[394.545172] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.922s)
[394.706990] [066/131] (624s left) gem_exec_schedule (u-semaphore-codependency)
[394.784832] Starting subtest: u-semaphore-codependency
[394.793453] Subtest u-semaphore-codependency: SUCCESS (0.013s)
[395.172647] [067/131] (624s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[395.277327] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[395.281269] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[395.417209] [068/131] (624s left) sysfs_preempt_timeout (idempotent)
[395.474631] Starting subtest: idempotent
[395.476836] Starting dynamic subtest: vecs0
[395.479036] Dynamic subtest vecs0: SUCCESS (0.000s)
[395.488407] Starting dynamic subtest: ccs0
[395.490170] Dynamic subtest ccs0: SUCCESS (0.000s)
[395.499273] Starting dynamic subtest: vcs0
[395.501336] Dynamic subtest vcs0: SUCCESS (0.000s)
[395.510139] Starting dynamic subtest: bcs0
[395.512008] Dynamic subtest bcs0: SUCCESS (0.000s)
[395.520251] Starting dynamic subtest: rcs0
[395.522112] Dynamic subtest rcs0: SUCCESS (0.000s)
[395.530396] Starting dynamic subtest: vcs1
[395.532261] Dynamic subtest vcs1: SUCCESS (0.000s)
[395.534164] Subtest idempotent: SUCCESS (0.007s)
[395.573394] [069/131] (624s left) gem_spin_batch (spin-all)
[395.626129] Starting subtest: spin-all
[395.641383] Subtest spin-all: SUCCESS (0.013s)
[396.749243] [070/131] (623s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[396.855422] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[396.857802] Starting dynamic subtest: pipe-A-eDP-1
[396.867046] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[396.877523] Starting dynamic subtest: pipe-B-eDP-1
[396.886295] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[396.894938] Starting dynamic subtest: pipe-C-eDP-1
[396.903000] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[396.911439] Starting dynamic subtest: pipe-D-eDP-1
[396.919390] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[396.923309] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[399.084736] [071/131] (620s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[399.181364] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[399.183643] Starting dynamic subtest: pipe-A-eDP-1
[399.207742] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[399.219275] Starting dynamic subtest: pipe-B-eDP-1
[399.240883] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[399.250048] Starting dynamic subtest: pipe-C-eDP-1
[399.271746] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[399.280740] Starting dynamic subtest: pipe-D-eDP-1
[399.303566] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[399.308535] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[401.487668] [072/131] (618s left) core_getversion (basic)
[401.526243] Starting subtest: basic
[401.530342] Subtest basic: SUCCESS (0.000s)
[401.608703] [073/131] (618s left) kms_concurrent (multi-plane-atomic-lowres)
[401.701125] Starting subtest: multi-plane-atomic-lowres
[401.703435] Starting dynamic subtest: pipe-A-eDP-1
[402.202987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.501s)
[402.205425] Subtest multi-plane-atomic-lowres: SUCCESS (0.502s)
[403.089865] [074/131] (616s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[403.188739] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[403.192852] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[403.306999] [075/131] (616s left) gem_wait (wait)
[403.371838] Starting subtest: wait
[403.374272] Starting dynamic subtest: all-engines
[404.687278] Dynamic subtest all-engines: SUCCESS (1.313s)
[404.699979] Starting dynamic subtest: rcs0
[405.732150] Dynamic subtest rcs0: SUCCESS (1.044s)
[405.744606] Starting dynamic subtest: bcs0
[406.778476] Dynamic subtest bcs0: SUCCESS (1.044s)
[406.790898] Starting dynamic subtest: vcs0
[407.822862] Dynamic subtest vcs0: SUCCESS (1.042s)
[407.834398] Starting dynamic subtest: vcs1
[408.868052] Dynamic subtest vcs1: SUCCESS (1.043s)
[408.879468] Starting dynamic subtest: vecs0
[409.913500] Dynamic subtest vecs0: SUCCESS (1.044s)
[409.924913] Starting dynamic subtest: ccs0
[410.960552] Dynamic subtest ccs0: SUCCESS (1.045s)
[410.963032] Subtest wait: SUCCESS (7.590s)
[411.183512] [076/131] (608s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[411.288034] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[411.292473] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[411.424516] [077/131] (608s left) syncobj_timeline (wait-all-for-submit-complex)
[411.480566] Starting subtest: wait-all-for-submit-complex
[411.696332] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[411.794249] [078/131] (608s left) gen9_exec_parse (bb-start-cmd)
[411.861362] Subtest bb-start-cmd: SKIP (0.000s)
[411.947899] [079/131] (608s left) syncobj_wait (wait-all-delayed-signal)
[412.010757] Starting subtest: wait-all-delayed-signal
[412.112608] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[412.224927] [080/131] (607s left) perf (oa-exponents)
[412.366728] Starting subtest: oa-exponents
[412.369269] Starting dynamic subtest: 0-rcs0
[414.139943] Dynamic subtest 0-rcs0: SUCCESS (1.773s)
[414.150709] Starting dynamic subtest: 1-vecs0
[415.972134] Dynamic subtest 1-vecs0: SUCCESS (1.831s)
[415.974772] Subtest oa-exponents: SUCCESS (3.605s)
[416.020891] [081/131] (604s left) gem_tiled_partial_pwrite_pread (reads)
[416.081881] Subtest reads: SKIP (0.000s)
[416.159638] [082/131] (604s left) kms_properties (get_properties-sanity-atomic)
[416.260943] Starting subtest: get_properties-sanity-atomic
[416.263054] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[416.360085] [083/131] (603s left) syncobj_wait (invalid-reset-bad-pad)
[416.414709] Starting subtest: invalid-reset-bad-pad
[416.417017] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[416.553908] [084/131] (603s left) gem_lmem_swapping (massive)
[416.593329] Subtest massive: SKIP (0.000s)
[416.639248] [085/131] (603s left) kms_pipe_crc_basic (read-crc)
[416.728133] Starting subtest: read-crc
[416.730035] Starting dynamic subtest: pipe-A-eDP-1
[417.427437] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s)
[417.438034] Starting dynamic subtest: pipe-B-eDP-1
[418.794409] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.365s)
[418.805102] Starting dynamic subtest: pipe-C-eDP-1
[420.163035] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.367s)
[420.175203] Starting dynamic subtest: pipe-D-eDP-1
[421.452601] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.288s)
[421.454817] Subtest read-crc: SUCCESS (4.727s)
[422.279709] [086/131] (598s left) gem_exec_balancer (hog)
[422.339140] Starting subtest: hog
[422.343459] Subtest hog: SKIP (0.000s)
[422.669804] [087/131] (597s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[422.734868] Starting subtest: multi-wait-all-for-submit-available-submitted
[422.736839] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[422.855624] [088/131] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[422.946188] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[422.950197] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[423.080726] [089/131] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[423.178629] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[423.182831] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[423.307136] [090/131] (597s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[423.423716] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[424.436285] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.012s)
[424.604678] [091/131] (596s left) kms_flip (flip-vs-wf_vblank-interruptible)
[424.703821] Starting subtest: flip-vs-wf_vblank-interruptible
[424.707858] Starting dynamic subtest: A-eDP1
[426.574922] Dynamic subtest A-eDP1: SUCCESS (1.868s)
[426.586525] Starting dynamic subtest: B-eDP1
[428.470453] Dynamic subtest B-eDP1: SUCCESS (1.893s)
[428.483291] Starting dynamic subtest: C-eDP1
[430.364515] Dynamic subtest C-eDP1: SUCCESS (1.894s)
[430.375404] Starting dynamic subtest: D-eDP1
[432.256921] Dynamic subtest D-eDP1: SUCCESS (1.891s)
[432.262504] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.557s)
[433.492059] [092/131] (587s left) kms_prime (basic-modeset-hybrid)
[433.577799] Subtest basic-modeset-hybrid: SKIP (0.000s)
[433.687448] [093/131] (587s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[433.784669] Starting subtest: y-tiled-32bpp-rotate-90
[433.788760] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[433.916034] [094/131] (586s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[434.015456] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[438.184525] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.172s)
[439.382632] [095/131] (581s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[439.484302] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[443.910634] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.431s)
[445.090900] [096/131] (575s left) gem_exec_endless (dispatch)
[445.156004] Starting subtest: dispatch
[445.158289] Starting dynamic subtest: rcs0
[445.162510] Dynamic subtest rcs0: SUCCESS (0.005s)
[445.175380] Starting dynamic subtest: bcs0
[445.179635] Dynamic subtest bcs0: SUCCESS (0.005s)
[445.189179] Starting dynamic subtest: vcs0
[445.193473] Dynamic subtest vcs0: SUCCESS (0.004s)
[445.202095] Starting dynamic subtest: vcs1
[445.206353] Dynamic subtest vcs1: SUCCESS (0.005s)
[445.214978] Starting dynamic subtest: vecs0
[445.218926] Dynamic subtest vecs0: SUCCESS (0.005s)
[445.227727] Starting dynamic subtest: ccs0
[445.231742] Dynamic subtest ccs0: SUCCESS (0.004s)
[445.233668] Subtest dispatch: SUCCESS (0.032s)
[446.797176] [097/131] (574s left) kms_cursor_crc (cursor-size-hints)
[446.937023] Starting subtest: cursor-size-hints
[446.939205] Starting dynamic subtest: pipe-A-eDP-1
[447.559419] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.622s)
[447.568819] Starting dynamic subtest: pipe-D-eDP-1
[448.775512] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s)
[448.777822] Subtest cursor-size-hints: SUCCESS (1.839s)
[449.671043] [098/131] (571s left) gem_exec_async (concurrent-writes)
[449.736252] Starting subtest: concurrent-writes
[449.738190] Starting dynamic subtest: rcs0
[449.748314] Dynamic subtest rcs0: SUCCESS (0.014s)
[449.758820] Starting dynamic subtest: bcs0
[449.761025] Dynamic subtest bcs0: SUCCESS (0.007s)
[449.770167] Starting dynamic subtest: vcs0
[449.772109] Dynamic subtest vcs0: SUCCESS (0.005s)
[449.781344] Starting dynamic subtest: vcs1
[449.783493] Dynamic subtest vcs1: SUCCESS (0.006s)
[449.792365] Starting dynamic subtest: vecs0
[449.794463] Dynamic subtest vecs0: SUCCESS (0.005s)
[449.803198] Starting dynamic subtest: ccs0
[449.805389] Dynamic subtest ccs0: SUCCESS (0.005s)
[449.807506] Subtest concurrent-writes: SUCCESS (0.045s)
[450.048801] [099/131] (570s left) kms_psr (psr-primary-mmap-cpu)
[450.145325] Starting subtest: psr-primary-mmap-cpu
[450.147452] Starting dynamic subtest: eDP-1
[451.917862] Dynamic subtest eDP-1: SUCCESS (1.774s)
[451.920197] Subtest psr-primary-mmap-cpu: SUCCESS (1.775s)
[452.781994] [100/131] (568s left) gem_exec_flush (basic-wb-rw-default)
[452.850113] Starting subtest: basic-wb-rw-default
[458.301548] Subtest basic-wb-rw-default: SUCCESS (5.453s)
[458.514391] [101/131] (562s left) kms_psr (psr2-cursor-blt)
[458.624298] Starting subtest: psr2-cursor-blt
[458.626661] Starting dynamic subtest: eDP-1
[460.292971] Dynamic subtest eDP-1: SUCCESS (1.668s)
[460.294995] Subtest psr2-cursor-blt: SUCCESS (1.669s)
[461.175842] [102/131] (559s left) kms_atomic_transition (plane-toggle-modeset-transition)
[461.277284] Starting subtest: plane-toggle-modeset-transition
[461.279458] Starting dynamic subtest: pipe-A-eDP-1
[474.253945] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.978s)
[474.264347] Starting dynamic subtest: pipe-B-eDP-1
[486.959277] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.707s)
[486.961786] Subtest plane-toggle-modeset-transition: SUCCESS (25.692s)
[487.874672] [103/131] (533s left) gem_cs_tlb (engines)
[487.944763] Starting subtest: engines
[487.947153] Starting dynamic subtest: rcs0
[490.102168] Dynamic subtest rcs0: SUCCESS (2.152s)
[490.114404] Starting dynamic subtest: bcs0
[492.255713] Dynamic subtest bcs0: SUCCESS (2.151s)
[492.268773] Starting dynamic subtest: vcs0
[494.410076] Dynamic subtest vcs0: SUCCESS (2.152s)
[494.422103] Starting dynamic subtest: vcs1
[496.564854] Dynamic subtest vcs1: SUCCESS (2.153s)
[496.577354] Starting dynamic subtest: vecs0
[498.718081] Dynamic subtest vecs0: SUCCESS (2.152s)
[498.729925] Starting dynamic subtest: ccs0
[500.873547] Dynamic subtest ccs0: SUCCESS (2.153s)
[500.875721] Subtest engines: SUCCESS (12.920s)
[501.028327] [104/131] (520s left) kms_pm_rpm (legacy-planes)
[502.860073] Starting subtest: legacy-planes
[502.862276] Starting dynamic subtest: plane-63
[511.451114] Dynamic subtest plane-63: SUCCESS (8.591s)
[511.463471] Starting dynamic subtest: plane-93
[519.773705] Dynamic subtest plane-93: SUCCESS (8.319s)
[519.785356] Starting dynamic subtest: plane-123
[528.357200] Dynamic subtest plane-123: SUCCESS (8.579s)
[528.369823] Starting dynamic subtest: plane-133
[536.955264] Dynamic subtest plane-133: SUCCESS (8.594s)
[536.958033] Subtest legacy-planes: SUCCESS (34.093s)
[537.329677] [105/131] (483s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[537.430962] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[537.435096] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[537.566352] [106/131] (483s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[537.668928] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[541.325252] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.660s)
[542.480319] [107/131] (478s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[542.576487] Starting subtest: fbc-psr2-sprite-mmap-cpu
[542.578865] Starting dynamic subtest: eDP-1
[542.583388] Dynamic subtest eDP-1: SKIP (0.000s)
[542.587835] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[542.695573] [108/131] (478s left) kms_flip (absolute-wf_vblank-interruptible)
[542.786021] Starting subtest: absolute-wf_vblank-interruptible
[542.788405] Starting dynamic subtest: A-eDP1
[551.473305] Dynamic subtest A-eDP1: SUCCESS (8.686s)
[551.485816] Starting dynamic subtest: B-eDP1
[560.170340] Dynamic subtest B-eDP1: SUCCESS (8.694s)
[560.184378] Starting dynamic subtest: C-eDP1
[568.859920] Dynamic subtest C-eDP1: SUCCESS (8.687s)
[568.873099] Starting dynamic subtest: D-eDP1
[577.559862] Dynamic subtest D-eDP1: SUCCESS (8.699s)
[577.562412] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.777s)
[578.766034] [109/131] (442s left) kms_sequence (get-forked)
[578.873233] Starting subtest: get-forked
[578.875497] Starting dynamic subtest: pipe-A-eDP-1
[580.738971] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.866s)
[580.758939] Starting dynamic subtest: pipe-B-eDP-1
[583.246293] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.507s)
[583.257154] Starting dynamic subtest: pipe-C-eDP-1
[585.752629] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.503s)
[585.763101] Starting dynamic subtest: pipe-D-eDP-1
[588.213471] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.459s)
[588.215649] Subtest get-forked: SUCCESS (9.341s)
[589.066246] [110/131] (432s left) gem_render_copy_redux (normal)
[589.126249] Starting subtest: normal
[589.404805] Subtest normal: SUCCESS (0.278s)
[589.560060] [111/131] (431s left) perf (global-sseu-config)
[589.669878] Starting subtest: global-sseu-config
[589.674731] Subtest global-sseu-config: SKIP (0.000s)
[589.716788] [112/131] (431s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[594.709717] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[594.714362] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[595.560689] [113/131] (426s left) gem_linear_blits (interruptible)
[595.958008] Starting subtest: interruptible
[600.201820] Subtest interruptible: SUCCESS (4.243s)
[600.357581] [114/131] (421s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[600.461059] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[600.465919] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[600.674319] [115/131] (421s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[600.774868] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[607.270414] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.499s)
[607.422944] [116/131] (414s left) gem_workarounds (suspend-resume-context)
[607.505767] Starting subtest: suspend-resume-context
[623.922072] Subtest suspend-resume-context: SUCCESS (1.193s)
[624.086317] [117/131] (397s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[624.204393] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[624.210061] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[624.344682] [118/131] (397s left) intel_hwmon (hwmon-write)
[624.415049] Subtest hwmon-write: SKIP (0.000s)
[624.486436] [119/131] (397s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[624.581212] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[624.583855] Starting dynamic subtest: pipe-A-default-mode
[627.233043] Dynamic subtest pipe-A-default-mode: SUCCESS (2.722s)
[627.235634] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.723s)
[628.049309] [120/131] (393s left) kms_addfb_basic (invalid-get-prop-any)
[628.117158] Starting subtest: invalid-get-prop-any
[628.119309] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[628.303857] [121/131] (393s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[628.394716] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[628.396906] Starting dynamic subtest: pipe-A-eDP-1
[628.456400] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[628.467189] Starting dynamic subtest: pipe-B-eDP-1
[628.536283] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[628.547450] Starting dynamic subtest: pipe-C-eDP-1
[628.615518] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[628.626185] Starting dynamic subtest: pipe-D-eDP-1
[628.692438] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[628.697919] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[630.581061] [122/131] (391s left) gem_exec_fence (long-history)
[631.025431] Starting subtest: long-history
[638.623265] Subtest long-history: SUCCESS (7.663s)
[639.268492] [123/131] (382s left) gem_exec_whisper (basic-contexts-priority)
[639.344813] Starting subtest: basic-contexts-priority
[664.238524] Subtest basic-contexts-priority: SUCCESS (24.923s)
[664.452196] [124/131] (357s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[664.558478] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[664.563363] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[664.689732] [125/131] (357s left) kms_lease (lease-get)
[664.786320] Starting subtest: lease-get
[664.789016] Starting dynamic subtest: pipe-A-eDP-1
[664.791433] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[664.802508] Starting dynamic subtest: pipe-B-eDP-1
[664.804874] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[664.815054] Starting dynamic subtest: pipe-C-eDP-1
[664.817335] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[664.826985] Starting dynamic subtest: pipe-D-eDP-1
[664.829375] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[664.832620] Subtest lease-get: SUCCESS (0.008s)
[664.922875] [126/131] (357s left) kms_content_protection (type1)
[665.074104] Starting subtest: type1
[665.078945] Subtest type1: SKIP (0.000s)
[665.239897] [127/131] (356s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[665.300757] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[665.410053] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[665.514223] [128/131] (356s left) i915_pm_rps (engine-order)
[665.578133] Starting subtest: engine-order
[670.372252] Subtest engine-order: SUCCESS (4.792s)
[670.542412] [129/131] (351s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[670.657223] Starting subtest: fbc-dirtyfb-ioctl
[670.659394] Starting dynamic subtest: A-eDP-1
[673.289218] Dynamic subtest A-eDP-1: SUCCESS (2.630s)
[673.291294] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.631s)
[674.174968] [130/131] (348s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[674.556014] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[675.333301] [131/131] (347s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[675.388343] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[675.391168] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[675.506575] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: i915_drm_fdinfo
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_vrr
results: parsing output: 6/ for test: i915_suspend
results: parsing output: 7/ for test: gem_fenced_exec_thrash
results: parsing output: 8/ for test: gem_tiled_wc
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: gem_ctx_persistence
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: api_intel_bb
results: parsing output: 13/ for test: kms_chamelium_frames
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_setmode
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_busy
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_schedule
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_ctx_isolation
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_mmap_wc
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: kms_invalid_mode
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_properties
results: parsing output: 30/ for test: gem_madvise
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_plane_multiple
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: i915_hangman
results: parsing output: 35/ for test: gem_set_tiling_vs_blt
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_chamelium_color
results: parsing output: 42/ for test: kms_dp_linktrain_fallback
results: parsing output: 43/ for test: gem_mmap
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_pxp
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: gem_render_copy_redux
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: prime_mmap
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: gem_mmap_offset
results: parsing output: 53/ for test: gem_readwrite
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_pm_backlight
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: sriov_basic
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: gem_exec_fence
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_hdmi_inject
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: sysfs_preempt_timeout
results: parsing output: 68/ for test: gem_spin_batch
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: core_getversion
results: parsing output: 72/ for test: kms_concurrent
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_wait
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: gen9_exec_parse
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 81/ for test: kms_properties
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: gem_lmem_swapping
results: parsing output: 84/ for test: kms_pipe_crc_basic
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_prime
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_endless
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: gem_exec_async
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_exec_flush
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: gem_cs_tlb
results: parsing output: 103/ for test: kms_pm_rpm
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_sequence
results: parsing output: 109/ for test: gem_render_copy_redux
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: gem_linear_blits
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_workarounds
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: intel_hwmon
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_lease
results: parsing output: 125/ for test: kms_content_protection
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: i915_pm_rps
results: parsing output: 128/ for test: kms_dirtyfb
results: parsing output: 129/ for test: kms_chamelium_hpd
results: parsing output: 130/ for test: syncobj_timeline
Done.