[59.502438] Initializing watchdogs
[59.502490]   /dev/watchdog0
[59.517671] [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]
[59.522659] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.524988] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.526987] [001/131] (960s left) gem_wait (busy)
[59.600265] Starting subtest: busy
[59.601934] Starting dynamic subtest: all-engines
[60.895036] Dynamic subtest all-engines: SUCCESS (1.282s)
[60.902875] Starting dynamic subtest: rcs0
[61.438330] Dynamic subtest rcs0: SUCCESS (0.550s)
[61.445709] Starting dynamic subtest: bcs0
[61.979380] Dynamic subtest bcs0: SUCCESS (0.539s)
[61.987693] Starting dynamic subtest: vcs0
[63.902826] Dynamic subtest vcs0: SUCCESS (1.909s)
[63.910980] Starting dynamic subtest: vcs1
[65.887267] Dynamic subtest vcs1: SUCCESS (1.980s)
[65.894084] Starting dynamic subtest: vecs0
[67.935337] Dynamic subtest vecs0: SUCCESS (2.044s)
[67.942436] Starting dynamic subtest: ccs0
[68.469034] Dynamic subtest ccs0: SUCCESS (0.541s)
[68.470247] Subtest busy: SUCCESS (8.851s)
[68.651973] [002/131] (951s left) gem_create (create-ext-placement-all)
[68.805679] Starting subtest: create-ext-placement-all
[68.806919] Subtest create-ext-placement-all: SUCCESS (0.000s)
[68.913437] [003/131] (951s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[69.009027] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[73.234276] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.223s)
[74.426419] [004/131] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[74.517665] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[74.519451] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[74.633604] [005/131] (945s left) gem_bad_reloc (negative-reloc-bltcopy)
[74.682951] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[74.746065] [006/131] (945s left) kms_invalid_mode (uint-max-clock)
[74.831815] Starting subtest: uint-max-clock
[74.832767] Starting dynamic subtest: pipe-A-eDP-1
[75.118918] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[75.125220] Starting dynamic subtest: pipe-B-eDP-1
[75.126087] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[75.131785] Starting dynamic subtest: pipe-C-eDP-1
[75.132794] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[75.138277] Starting dynamic subtest: pipe-D-eDP-1
[75.139215] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[75.140285] Subtest uint-max-clock: SUCCESS (0.290s)
[75.942956] [007/131] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[76.030717] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[76.032577] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[76.117582] [008/131] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[76.222810] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[76.224538] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[76.308858] [009/131] (943s left) kms_psr (fbc-psr-cursor-plane-onoff)
[76.388961] Starting subtest: fbc-psr-cursor-plane-onoff
[76.389893] Starting dynamic subtest: eDP-1
[76.391705] Dynamic subtest eDP-1: SKIP (0.000s)
[76.393586] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[76.453059] [010/131] (943s left) gem_exec_parallel (basic)
[76.516785] Starting subtest: basic
[76.517859] Starting dynamic subtest: rcs0
[77.930150] Dynamic subtest rcs0: SUCCESS (1.413s)
[77.936253] Starting dynamic subtest: bcs0
[79.402832] Dynamic subtest bcs0: SUCCESS (1.471s)
[79.410241] Starting dynamic subtest: vcs0
[80.893372] Dynamic subtest vcs0: SUCCESS (1.480s)
[80.901544] Starting dynamic subtest: vcs1
[82.847567] Dynamic subtest vcs1: SUCCESS (1.952s)
[82.856395] Starting dynamic subtest: vecs0
[84.894826] Dynamic subtest vecs0: SUCCESS (2.046s)
[84.902151] Starting dynamic subtest: ccs0
[86.365902] Dynamic subtest ccs0: SUCCESS (1.478s)
[86.367334] Subtest basic: SUCCESS (9.846s)
[86.549692] [011/131] (933s left) kms_psr (fbc-pr-cursor-plane-move)
[86.645623] Starting subtest: fbc-pr-cursor-plane-move
[86.647459] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[86.714161] [012/131] (933s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[86.797400] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[86.798523] Starting dynamic subtest: pipe-A-eDP-1
[86.821133] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[86.827404] Starting dynamic subtest: pipe-B-eDP-1
[86.843963] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[86.849786] Starting dynamic subtest: pipe-C-eDP-1
[86.867875] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[86.873663] Starting dynamic subtest: pipe-D-eDP-1
[86.890111] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[86.890901] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s)
[89.024352] [013/131] (931s left) gem_lmem_swapping (random-engines)
[89.060899] Subtest random-engines: SKIP (0.000s)
[89.099082] [014/131] (931s left) api_intel_bb (delta-check)
[89.147103] Starting subtest: delta-check
[89.152703] Subtest delta-check: SUCCESS (0.006s)
[89.259222] [015/131] (931s left) perf_pmu (busy-idle)
[89.297671] Starting subtest: busy-idle
[89.298587] Starting dynamic subtest: rcs0
[89.992991] Dynamic subtest rcs0: SUCCESS (0.694s)
[90.000788] Starting dynamic subtest: bcs0
[90.654310] Dynamic subtest bcs0: SUCCESS (0.661s)
[90.663135] Starting dynamic subtest: vcs0
[91.936897] Dynamic subtest vcs0: SUCCESS (1.272s)
[91.944962] Starting dynamic subtest: vcs1
[93.921702] Dynamic subtest vcs1: SUCCESS (1.983s)
[93.929052] Starting dynamic subtest: vecs0
[95.903838] Dynamic subtest vecs0: SUCCESS (1.981s)
[95.912641] Starting dynamic subtest: ccs0
[96.559819] Dynamic subtest ccs0: SUCCESS (0.664s)
[96.561136] Subtest busy-idle: SUCCESS (7.261s)
[96.651825] [016/131] (923s left) sw_sync (sync_busy_fork)
[96.685033] Starting subtest: sync_busy_fork
[97.706615] Subtest sync_busy_fork: SUCCESS (1.013s)
[97.756353] [017/131] (922s left) i915_drm_fdinfo (busy-idle)
[97.792627] Starting subtest: busy-idle
[97.793734] Starting dynamic subtest: rcs0
[97.811368] Dynamic subtest rcs0: SKIP (0.018s)
[97.818331] Starting dynamic subtest: bcs0
[97.827942] Dynamic subtest bcs0: SKIP (0.017s)
[97.833928] Starting dynamic subtest: vcs0
[97.835473] Dynamic subtest vcs0: SKIP (0.000s)
[97.841822] Starting dynamic subtest: vcs1
[97.843356] Dynamic subtest vcs1: SKIP (0.001s)
[97.849368] Starting dynamic subtest: vecs0
[97.850956] Dynamic subtest vecs0: SKIP (0.001s)
[97.856743] Starting dynamic subtest: ccs0
[97.858368] Dynamic subtest ccs0: SKIP (0.000s)
[97.859948] Subtest busy-idle: SKIP (0.040s)
[97.896316] [018/131] (922s left) gem_exec_whisper (basic-sync-all)
[97.955459] Starting subtest: basic-sync-all
[105.272531] Subtest basic-sync-all: SUCCESS (7.315s)
[105.449715] [019/131] (915s left) kms_properties (get_properties-sanity-non-atomic)
[105.537869] Starting subtest: get_properties-sanity-non-atomic
[105.538756] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[105.618268] [020/131] (914s left) gem_exec_reloc (basic-write-cpu)
[105.670514] Subtest basic-write-cpu: SKIP (0.000s)
[105.735828] [021/131] (914s left) syncobj_eventfd (invalid-bad-flags)
[105.788025] Starting subtest: invalid-bad-flags
[105.789080] Subtest invalid-bad-flags: SUCCESS (0.000s)
[105.874193] [022/131] (914s left) gem_ctx_shared (q-independent)
[105.928279] Starting subtest: Q-independent
[105.929186] Starting dynamic subtest: rcs0
[105.995462] Dynamic subtest rcs0: SUCCESS (0.066s)
[106.004703] Starting dynamic subtest: vcs0
[106.034087] Dynamic subtest vcs0: SUCCESS (0.039s)
[106.041495] Starting dynamic subtest: vcs1
[106.073324] Dynamic subtest vcs1: SUCCESS (0.039s)
[106.081789] Starting dynamic subtest: vecs0
[106.113538] Dynamic subtest vecs0: SUCCESS (0.040s)
[106.122395] Starting dynamic subtest: ccs0
[106.155045] Dynamic subtest ccs0: SUCCESS (0.041s)
[106.156138] Subtest Q-independent: SUCCESS (0.227s)
[108.006917] [023/131] (912s left) gem_gtt_cpu_tlb
[108.115453] [024/131] (912s left) tools_test (sysfs_l3_parity)
[108.150473] Starting subtest: sysfs_l3_parity
[108.238071] Subtest sysfs_l3_parity: SKIP (0.091s)
[108.287743] [025/131] (912s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[108.382751] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[108.383609] Starting dynamic subtest: pipe-A-eDP-1
[108.556471] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.168s)
[108.564973] Starting dynamic subtest: pipe-B-eDP-1
[108.579900] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[108.586505] Starting dynamic subtest: pipe-C-eDP-1
[108.593571] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[108.599463] Starting dynamic subtest: pipe-D-eDP-1
[108.606431] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[108.607263] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.175s)
[110.780822] [026/131] (910s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[111.151040] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[111.993367] [027/131] (908s left) gen9_exec_parse (bb-secure)
[112.040067] Subtest bb-secure: SKIP (0.000s)
[112.104210] [028/131] (908s left) kms_big_fb (linear-64bpp-rotate-0)
[112.204199] Starting subtest: linear-64bpp-rotate-0
[113.748953] Subtest linear-64bpp-rotate-0: SUCCESS (1.545s)
[113.905576] [029/131] (906s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[114.000525] Starting subtest: plane-all-transition-nonblocking-fencing
[114.001618] Starting dynamic subtest: pipe-A-eDP-1
[116.496038] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[116.813090] Starting dynamic subtest: pipe-B-eDP-1
[120.063466] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.257s)
[120.361969] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.361s)
[121.205120] [030/131] (899s left) kms_draw_crc (fill-fb)
[121.313302] Starting subtest: fill-fb
[121.788546] Subtest fill-fb: SUCCESS (0.475s)
[121.885644] [031/131] (899s left) kms_atomic (plane-primary-legacy)
[121.989342] Starting subtest: plane-primary-legacy
[121.990387] Starting dynamic subtest: pipe-A-eDP-1
[122.438405] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[122.439272] Subtest plane-primary-legacy: SUCCESS (0.450s)
[123.236125] [032/131] (897s left) gem_exec_fence (syncobj-timeline-chain-engines)
[123.860808] Starting subtest: syncobj-timeline-chain-engines
[123.948895] Subtest syncobj-timeline-chain-engines: SUCCESS (0.098s)
[124.989541] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[124.991719] [033/131] (896s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[125.086849] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[125.087621] Starting dynamic subtest: pipe-A
[125.219149] Dynamic subtest pipe-A: SKIP (0.130s)
[125.225801] Starting dynamic subtest: pipe-B
[126.405518] Dynamic subtest pipe-B: SKIP (1.186s)
[126.412295] Starting dynamic subtest: pipe-C
[127.633932] Dynamic subtest pipe-C: SUCCESS (1.230s)
[127.642239] Starting dynamic subtest: pipe-D
[128.872186] Dynamic subtest pipe-D: SUCCESS (1.238s)
[128.873082] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.786s)
[130.060174] [034/131] (890s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[130.179424] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[141.366060] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.186s)
[142.182303] [035/131] (878s left) kms_psr (fbc-pr-sprite-render)
[142.282462] Starting subtest: fbc-pr-sprite-render
[142.284233] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[142.365369] [036/131] (878s left) kms_plane_multiple (tiling-4)
[142.456364] Starting subtest: tiling-4
[142.457277] Starting dynamic subtest: pipe-A-eDP-1
[146.230935] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.773s)
[146.237973] Starting dynamic subtest: pipe-B-eDP-1
[150.598229] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.366s)
[150.604968] Starting dynamic subtest: pipe-C-eDP-1
[154.909742] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.310s)
[154.925597] Starting dynamic subtest: pipe-D-eDP-1
[159.212379] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.301s)
[159.213263] Subtest tiling-4: SUCCESS (16.755s)
[160.025031] [037/131] (861s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[160.121759] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[160.123380] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[160.213420] [038/131] (860s left) kms_content_protection (content-type-change)
[160.343887] Starting subtest: content-type-change
[160.346078] Subtest content-type-change: SKIP (0.000s)
[160.456832] [039/131] (860s left) syncobj_timeline (multi-wait-available-submitted)
[160.504179] Starting subtest: multi-wait-available-submitted
[160.505049] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[160.595137] [040/131] (860s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[160.675476] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[160.676367] Starting dynamic subtest: pipe-A-eDP-1
[161.981802] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.296s)
[162.257915] Starting dynamic subtest: pipe-B-eDP-1
[163.303490] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.044s)
[163.574801] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.898s)
[164.429221] [041/131] (856s left) gem_mmap_gtt (isolation)
[164.478700] Subtest isolation: SKIP (0.000s)
[164.536732] [042/131] (856s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[164.627783] Starting subtest: fbc-rgb565-draw-render
[168.854708] Subtest fbc-rgb565-draw-render: SUCCESS (4.226s)
[170.021818] [043/131] (851s left) perf (gen8-unprivileged-single-ctx-counters)
[170.152284] Starting subtest: gen8-unprivileged-single-ctx-counters
[170.153870] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[170.186378] [044/131] (851s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[170.294883] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[171.383531] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.089s)
[171.500813] [045/131] (849s left) kms_plane_alpha_blend (alpha-opaque-fb)
[171.592336] Starting subtest: alpha-opaque-fb
[171.878458] Starting dynamic subtest: pipe-A-eDP-1
[172.567579] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[172.574158] Starting dynamic subtest: pipe-D-eDP-1
[173.878056] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.309s)
[173.878903] Subtest alpha-opaque-fb: SUCCESS (2.286s)
[174.704232] [046/131] (846s left) kms_dp_linktrain_fallback (dsc-fallback)
[174.796675] Starting subtest: dsc-fallback
[174.799344] Subtest dsc-fallback: SKIP (0.000s)
[174.867505] [047/131] (846s left) i915_power (sanity)
[174.922154] Starting subtest: sanity
[178.959765] Subtest sanity: SUCCESS (4.030s)
[180.968399] [048/131] (840s left) syncobj_timeline (invalid-signal-bad-pad)
[181.021747] Starting subtest: invalid-signal-bad-pad
[181.022808] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[181.112441] [049/131] (840s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[181.199327] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[181.200214] Starting dynamic subtest: pipe-A-default-mode
[183.926536] Dynamic subtest pipe-A-default-mode: SUCCESS (2.726s)
[183.927435] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.727s)
[184.777720] [050/131] (836s left) syncobj_wait (invalid-wait-bad-flags)
[184.839258] Starting subtest: invalid-wait-bad-flags
[184.840195] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[184.923388] [051/131] (836s left) kms_cdclk (mode-transition)
[185.018411] Starting subtest: mode-transition
[185.019266] Starting dynamic subtest: pipe-A-eDP-1
[185.307266] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[185.314581] Starting dynamic subtest: pipe-B-eDP-1
[185.316571] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[185.323217] Starting dynamic subtest: pipe-C-eDP-1
[185.325078] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[185.331542] Starting dynamic subtest: pipe-D-eDP-1
[185.333714] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[185.335867] Subtest mode-transition: SKIP (0.295s)
[186.109473] [052/131] (835s left) kms_psr (psr-primary-mmap-gtt)
[186.201302] Starting subtest: psr-primary-mmap-gtt
[186.202147] Starting dynamic subtest: eDP-1
[187.629346] Dynamic subtest eDP-1: SKIP (1.418s)
[187.631258] Subtest psr-primary-mmap-gtt: SKIP (1.421s)
[187.751005] [053/131] (833s left) gem_readwrite (new-obj)
[187.804503] Subtest new-obj: SKIP (0.000s)
[187.863581] [054/131] (833s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[187.941570] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[187.942462] Starting dynamic subtest: pipe-A
[187.960603] Dynamic subtest pipe-A: SKIP (0.018s)
[187.967555] Starting dynamic subtest: pipe-B
[187.994234] Dynamic subtest pipe-B: SKIP (0.032s)
[188.001079] Starting dynamic subtest: pipe-C
[188.025724] Dynamic subtest pipe-C: SKIP (0.032s)
[188.034558] Starting dynamic subtest: pipe-D
[188.057922] Dynamic subtest pipe-D: SKIP (0.032s)
[188.059628] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.116s)
[188.145802] [055/131] (833s left) intel_hwmon (hwmon-read)
[188.206403] Subtest hwmon-read: SKIP (0.000s)
[188.263515] [056/131] (833s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[188.351817] Starting subtest: crc-primary-suspend-y-tiled-ccs
[188.352877] Starting dynamic subtest: pipe-A-eDP-1
[188.356427] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[188.370133] Starting dynamic subtest: pipe-B-eDP-1
[188.373870] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[188.383836] Starting dynamic subtest: pipe-C-eDP-1
[188.387649] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[188.394285] Starting dynamic subtest: pipe-D-eDP-1
[188.397721] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[188.399395] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[190.507634] [057/131] (831s left) kms_feature_discovery (display-3x)
[190.592719] Starting subtest: display-3x
[190.594453] Subtest display-3x: SKIP (0.000s)
[190.659821] [058/131] (831s left) kms_flip (absolute-wf_vblank-interruptible)
[190.753118] Starting subtest: absolute-wf_vblank-interruptible
[190.754559] Starting dynamic subtest: A-eDP1
[199.496451] Dynamic subtest A-eDP1: SUCCESS (8.715s)
[199.505283] Starting dynamic subtest: B-eDP1
[208.230594] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[208.242491] Starting dynamic subtest: C-eDP1
[216.956805] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[216.965391] Starting dynamic subtest: D-eDP1
[225.644059] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[225.647649] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.892s)
[226.854164] [059/131] (795s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[226.965086] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[226.966786] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[227.065776] [060/131] (794s left) gem_mmap_gtt (fault-concurrent)
[227.117072] Subtest fault-concurrent: SKIP (0.000s)
[227.167887] [061/131] (794s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[227.254479] Starting subtest: fbcpsr-rgb101010-draw-blt
[234.020316] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.766s)
[234.130980] [062/131] (787s left) kms_vblank (query-busy)
[234.235274] Starting subtest: query-busy
[234.236140] Starting dynamic subtest: pipe-A-eDP-1
[236.123101] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[236.135469] Starting dynamic subtest: pipe-D-eDP-1
[238.660910] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.531s)
[238.661804] Subtest query-busy: SUCCESS (4.427s)
[239.467410] [063/131] (782s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[239.553826] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[239.555760] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[239.637976] [064/131] (782s left) syncobj_wait (invalid-reset-one-illegal-handle)
[239.701931] Starting subtest: invalid-reset-one-illegal-handle
[239.702897] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[239.817590] [065/131] (782s left) gem_render_copy (yf-tiled-to-vebox-linear)
[239.870533] Starting subtest: yf-tiled-to-vebox-linear
[239.872322] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[240.042682] [066/131] (782s left) kms_atomic_interruptible (legacy-setmode)
[240.135557] Starting subtest: legacy-setmode
[240.136344] Starting dynamic subtest: pipe-A-eDP-1
[247.055067] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.918s)
[247.056063] Subtest legacy-setmode: SUCCESS (6.919s)
[247.925231] [067/131] (774s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[248.021392] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[248.023237] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[248.114272] [068/131] (774s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[248.200733] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[248.202461] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[248.282898] [069/131] (773s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[248.371179] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[248.372800] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[248.453183] [070/131] (773s left) kms_flip (plain-flip-fb-recreate-interruptible)
[248.538110] Starting subtest: plain-flip-fb-recreate-interruptible
[248.539332] Starting dynamic subtest: A-eDP1
[257.433859] Dynamic subtest A-eDP1: SUCCESS (8.894s)
[257.443699] Starting dynamic subtest: B-eDP1
[266.263529] Dynamic subtest B-eDP1: SUCCESS (8.826s)
[266.274436] Starting dynamic subtest: C-eDP1
[275.088036] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[275.095925] Starting dynamic subtest: D-eDP1
[283.922554] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[283.926352] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.388s)
[285.101500] [071/131] (737s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[285.152734] Starting subtest: etime-single-wait-for-submit-unsubmitted
[285.258788] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[285.329061] [072/131] (737s left) kms_cursor_crc (cursor-random-512x170)
[285.633513] Starting subtest: cursor-random-512x170
[285.635204] Subtest cursor-random-512x170: SKIP (0.001s)
[285.764417] [073/131] (736s left) gem_exec_whisper (basic-fds-priority)
[285.838709] Starting subtest: basic-fds-priority
[310.191962] Subtest basic-fds-priority: SUCCESS (24.334s)
[310.356965] [074/131] (712s left) kms_psr (psr2-basic)
[310.457516] Starting subtest: psr2-basic
[310.458466] Starting dynamic subtest: eDP-1
[312.062547] Dynamic subtest eDP-1: SUCCESS (1.605s)
[312.063351] Subtest psr2-basic: SUCCESS (1.606s)
[312.869843] [075/131] (709s left) gem_ctx_persistence (processes)
[312.918993] Starting subtest: processes
[314.914363] Subtest processes: SUCCESS (1.995s)
[314.999130] [076/131] (707s left) perf (polling-parameterized)
[315.097555] Starting subtest: polling-parameterized
[335.130050] Subtest polling-parameterized: SUCCESS (20.025s)
[335.164494] [077/131] (687s left) perf_pmu (busy-accuracy-98)
[335.199093] Starting subtest: busy-accuracy-98
[335.200193] Starting dynamic subtest: rcs0
[338.249051] Dynamic subtest rcs0: SUCCESS (3.045s)
[338.256681] Starting dynamic subtest: bcs0
[341.314599] Dynamic subtest bcs0: SUCCESS (3.056s)
[341.321527] Starting dynamic subtest: vcs0
[344.353200] Dynamic subtest vcs0: SUCCESS (3.042s)
[344.362971] Starting dynamic subtest: vcs1
[347.399975] Dynamic subtest vcs1: SUCCESS (3.044s)
[347.409915] Starting dynamic subtest: vecs0
[350.443183] Dynamic subtest vecs0: SUCCESS (3.040s)
[350.452809] Starting dynamic subtest: ccs0
[353.498965] Dynamic subtest ccs0: SUCCESS (3.053s)
[353.499952] Subtest busy-accuracy-98: SUCCESS (18.296s)
[353.608948] [078/131] (668s left) syncobj_timeline (signal-array)
[353.673082] Starting subtest: signal-array
[353.673986] Subtest signal-array: SUCCESS (0.001s)
[353.769647] [079/131] (668s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[353.885426] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[353.887251] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[353.984646] [080/131] (668s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[354.071365] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[361.174039] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.104s)
[361.280996] [081/131] (661s left) core_setmaster_vs_auth
[361.441620] [082/131] (661s left) gem_busy (busy)
[361.510866] Starting subtest: busy
[361.511781] Starting dynamic subtest: all-engines
[361.574513] Dynamic subtest all-engines: SUCCESS (0.065s)
[361.585610] Starting dynamic subtest: rcs0
[362.915162] Dynamic subtest rcs0: SUCCESS (1.333s)
[362.923465] Starting dynamic subtest: bcs0
[362.949357] Dynamic subtest bcs0: SUCCESS (0.039s)
[362.957266] Starting dynamic subtest: vcs0
[362.990590] Dynamic subtest vcs0: SUCCESS (0.040s)
[362.998675] Starting dynamic subtest: vcs1
[364.899877] Dynamic subtest vcs1: SUCCESS (1.897s)
[364.909222] Starting dynamic subtest: vecs0
[366.947594] Dynamic subtest vecs0: SUCCESS (2.046s)
[366.957171] Starting dynamic subtest: ccs0
[368.931367] Dynamic subtest ccs0: SUCCESS (1.984s)
[368.932425] Subtest busy: SUCCESS (7.413s)
[369.285049] [083/131] (653s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[369.372920] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[373.771188] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.398s)
[374.886856] [084/131] (647s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[374.997603] Starting subtest: cursor-vs-flip-legacy
[404.369552] Subtest cursor-vs-flip-legacy: SUCCESS (29.370s)
[405.213192] [085/131] (617s left) gem_render_copy (linear-to-vebox-y-tiled)
[405.264849] Starting subtest: linear-to-vebox-y-tiled
[405.266547] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[405.444761] [086/131] (617s left) gem_pread (snoop)
[405.499447] Subtest snoop: SKIP (0.000s)
[405.555885] [087/131] (617s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[405.651871] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[405.653530] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[405.743404] [088/131] (617s left) kms_color (invalid-ctm-matrix-sizes)
[405.839446] Starting subtest: invalid-ctm-matrix-sizes
[405.840293] Starting dynamic subtest: pipe-A
[405.841106] Dynamic subtest pipe-A: SUCCESS (0.002s)
[405.848615] Starting dynamic subtest: pipe-B
[405.849502] Dynamic subtest pipe-B: SUCCESS (0.003s)
[405.856834] Starting dynamic subtest: pipe-C
[405.857698] Dynamic subtest pipe-C: SUCCESS (0.003s)
[405.864592] Starting dynamic subtest: pipe-D
[405.865455] Dynamic subtest pipe-D: SUCCESS (0.004s)
[405.866304] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[405.935841] [089/131] (616s left) kms_pm_rpm (system-suspend-modeset)
[408.065496] Starting subtest: system-suspend-modeset
[428.358541] Subtest system-suspend-modeset: SUCCESS (5.170s)
[432.796956] [090/131] (594s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[432.905778] Starting subtest: psr-2p-primscrn-cur-indfb-move
[432.907539] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[432.997339] [091/131] (594s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[433.083483] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[433.085184] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[433.200504] [092/131] (593s left) gem_exec_capture (capture-recoverable)
[433.245389] Starting subtest: capture-recoverable
[433.247301] Subtest capture-recoverable: SUCCESS (0.003s)
[433.366896] [093/131] (593s left) kms_lease (invalid-create-leases)
[433.449254] Starting subtest: invalid-create-leases
[433.455599] Subtest invalid-create-leases: SUCCESS (0.005s)
[433.569883] [094/131] (593s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[433.664487] Starting subtest: extended-pageflip-modeset-hang-oldfb
[433.665321] Starting dynamic subtest: pipe-A
[441.660209] Dynamic subtest pipe-A: SUCCESS (7.899s)
[441.669825] Starting dynamic subtest: pipe-D
[450.283068] Dynamic subtest pipe-D: SUCCESS (8.582s)
[450.284006] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.486s)
[451.143379] [095/131] (576s left) device_reset (unbind-cold-reset-rebind)
[451.195611] Starting subtest: unbind-cold-reset-rebind
[451.197378] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[451.262724] [096/131] (575s left) gem_exec_schedule (u-submit-early-slice)
[451.323598] Starting subtest: u-submit-early-slice
[451.324466] Starting dynamic subtest: rcs0
[451.371139] Dynamic subtest rcs0: SUCCESS (0.048s)
[451.382241] Starting dynamic subtest: bcs0
[451.410647] Dynamic subtest bcs0: SUCCESS (0.039s)
[451.419747] Starting dynamic subtest: vcs0
[451.458008] Dynamic subtest vcs0: SUCCESS (0.047s)
[451.468947] Starting dynamic subtest: vcs1
[451.496358] Dynamic subtest vcs1: SUCCESS (0.038s)
[451.507435] Starting dynamic subtest: vecs0
[451.535596] Dynamic subtest vecs0: SUCCESS (0.038s)
[451.547122] Starting dynamic subtest: ccs0
[451.571642] Dynamic subtest ccs0: SUCCESS (0.035s)
[451.572709] Subtest u-submit-early-slice: SUCCESS (0.249s)
[453.102720] [097/131] (574s left) kms_psr (psr-cursor-render)
[453.190425] Starting subtest: psr-cursor-render
[453.191310] Starting dynamic subtest: eDP-1
[454.952778] Dynamic subtest eDP-1: SUCCESS (1.759s)
[454.953667] Subtest psr-cursor-render: SUCCESS (1.760s)
[455.821547] [098/131] (571s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[455.924974] Starting subtest: cursor-tearing-framebuffer-change
[455.927124] Starting dynamic subtest: pipe-A-eDP-1
[456.513203] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[456.521388] Starting dynamic subtest: pipe-D-eDP-1
[457.754063] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[457.754950] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.826s)
[458.572651] [099/131] (568s left) gem_exec_suspend (basic-s3-devices)
[458.635438] Starting subtest: basic-S3-devices
[458.636361] Starting dynamic subtest: smem
[470.004128] Dynamic subtest smem: SUCCESS (11.349s)
[470.005799] Subtest basic-S3-devices: SUCCESS (11.351s)
[475.249779] [100/131] (557s left) gem_exec_balancer (bonded-semaphore)
[475.332920] Starting subtest: bonded-semaphore
[475.334825] Subtest bonded-semaphore: SKIP (0.000s)
[475.650182] [101/131] (556s left) kms_vblank (query-idle-hang)
[475.747529] Starting subtest: query-idle-hang
[475.749591] Starting dynamic subtest: pipe-A-eDP-1
[501.802504] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.053s)
[501.813046] Starting dynamic subtest: pipe-D-eDP-1
[516.844504] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.036s)
[516.845395] Subtest query-idle-hang: SUCCESS (41.093s)
[517.638413] [102/131] (514s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[517.726896] Starting subtest: 4-tiled-8bpp-rotate-0
[518.930426] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.203s)
[519.060120] [103/131] (513s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[519.156370] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[519.158031] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[519.241914] [104/131] (513s left) gem_ctx_param (invalid-ctx-get)
[519.293783] Starting subtest: invalid-ctx-get
[519.294712] Subtest invalid-ctx-get: SUCCESS (0.000s)
[519.355162] [105/131] (513s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[519.454155] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[519.456276] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[519.573500] [106/131] (513s left) gem_mmap_gtt (medium-copy)
[519.636922] Subtest medium-copy: SKIP (0.000s)
[519.695115] [107/131] (512s left) gem_exec_schedule (pi-common)
[519.866158] Starting subtest: pi-common
[519.867183] Starting dynamic subtest: rcs0
[519.903629] Dynamic subtest rcs0: SUCCESS (0.040s)
[519.912826] Starting dynamic subtest: bcs0
[519.952658] Dynamic subtest bcs0: SUCCESS (0.048s)
[519.962262] Starting dynamic subtest: vcs0
[519.994411] Dynamic subtest vcs0: SUCCESS (0.041s)
[520.004152] Starting dynamic subtest: vcs1
[520.027071] Dynamic subtest vcs1: SUCCESS (0.032s)
[520.037542] Starting dynamic subtest: vecs0
[520.064604] Dynamic subtest vecs0: SUCCESS (0.037s)
[520.082612] Starting dynamic subtest: ccs0
[520.093603] Dynamic subtest ccs0: SUCCESS (0.028s)
[520.094588] Subtest pi-common: SUCCESS (0.231s)
[520.344203] [108/131] (512s left) i915_pm_rpm (debugfs-read)
[522.161900] Starting subtest: debugfs-read
[523.308262] Subtest debugfs-read: SUCCESS (1.145s)
[523.673810] [109/131] (509s left) gem_mmap (short-mmap)
[523.722153] Subtest short-mmap: SKIP (0.000s)
[523.771945] [110/131] (509s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[523.865234] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[523.866251] Starting dynamic subtest: pipe-A-eDP-1
[523.969704] Dynamic subtest pipe-A-eDP-1: SKIP (0.104s)
[523.978704] Starting dynamic subtest: pipe-B-eDP-1
[525.148382] Dynamic subtest pipe-B-eDP-1: SKIP (1.177s)
[525.150055] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.284s)
[526.342547] [111/131] (506s left) kms_chamelium_frames (hdmi-crc-fast)
[526.736663] Subtest hdmi-crc-fast: SKIP (0.000s)
[527.543718] [112/131] (505s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[527.639228] Starting subtest: yf-tiled-32bpp-rotate-180
[527.641233] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[527.737973] [113/131] (505s left) kms_addfb_basic (addfb25-bad-modifier)
[527.832614] Starting subtest: addfb25-bad-modifier
[527.833730] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[527.918726] [114/131] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[528.010074] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[528.011815] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[528.097887] [115/131] (504s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[528.173503] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[528.174352] Starting dynamic subtest: pipe-A-eDP-1
[528.182554] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[528.195568] Starting dynamic subtest: pipe-B-eDP-1
[528.203670] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[528.215056] Starting dynamic subtest: pipe-C-eDP-1
[528.224500] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[528.232022] Starting dynamic subtest: pipe-D-eDP-1
[528.240928] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[528.242676] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[530.435064] [116/131] (502s left) kms_cursor_crc (cursor-onscreen-512x512)
[530.726975] Starting subtest: cursor-onscreen-512x512
[530.728449] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[530.872506] [117/131] (502s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[530.955273] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[530.957480] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[531.022978] [118/131] (502s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[531.117571] Starting subtest: y-tiled-8bpp-rotate-90
[531.119360] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[531.214333] [119/131] (501s left) gem_madvise (dontneed-before-mmap)
[531.254742] Starting subtest: dontneed-before-mmap
[531.274869] Subtest dontneed-before-mmap: SUCCESS (0.021s)
[531.369517] [120/131] (501s left) gem_ppgtt (shrink-vs-evict-pinned)
[531.416618] Starting subtest: shrink-vs-evict-pinned
[539.084066] Subtest shrink-vs-evict-pinned: SUCCESS (7.619s)
[539.130530] [121/131] (494s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[539.239666] Starting subtest: pixel-format-y-tiled-ccs-modifier
[539.241465] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[539.319947] [122/131] (493s left) kms_tv_load_detect (load-detect)
[539.367994] Subtest load-detect: SKIP (0.000s)
[539.437542] [123/131] (493s left) syncobj_wait (wait-all-interrupted)
[539.506980] Starting subtest: wait-all-interrupted
[539.609989] Subtest wait-all-interrupted: SUCCESS (0.102s)
[539.681449] [124/131] (493s left) vgem_basic (create)
[539.716229] Starting subtest: create
[539.717120] Subtest create: SUCCESS (0.000s)
[539.771192] [125/131] (493s left) gem_ctx_isolation (nonpriv-switch)
[539.818381] Starting subtest: nonpriv-switch
[539.819219] Starting dynamic subtest: rcs0
[540.097010] Dynamic subtest rcs0: SUCCESS (0.279s)
[540.106101] Starting dynamic subtest: bcs0
[540.394094] Dynamic subtest bcs0: SUCCESS (0.296s)
[540.404797] Starting dynamic subtest: vcs0
[540.687064] Dynamic subtest vcs0: SUCCESS (0.292s)
[540.695272] Starting dynamic subtest: vcs1
[542.343080] Dynamic subtest vcs1: SUCCESS (1.654s)
[542.353607] Starting dynamic subtest: vecs0
[544.332847] Dynamic subtest vecs0: SUCCESS (1.988s)
[544.343600] Starting dynamic subtest: ccs0
[546.336455] Dynamic subtest ccs0: SUCCESS (2.002s)
[546.337728] Subtest nonpriv-switch: SUCCESS (6.517s)
[546.589479] [126/131] (486s left) gem_softpin (reverse)
[546.645992] Starting subtest: reverse
[546.656365] Subtest reverse: SUCCESS (0.010s)
[546.762018] [127/131] (486s left) gem_exec_parallel (engines)
[546.813212] Starting subtest: engines
[546.814208] Starting dynamic subtest: basic
[549.043579] Dynamic subtest basic: SUCCESS (2.219s)
[549.054612] Starting dynamic subtest: contexts
[553.406635] Dynamic subtest contexts: SUCCESS (4.359s)
[553.416989] Starting dynamic subtest: fds
[557.112960] Dynamic subtest fds: SUCCESS (3.702s)
[557.123114] Starting dynamic subtest: userptr
[559.027514] Dynamic subtest userptr: SUCCESS (1.913s)
[559.028795] Subtest engines: SUCCESS (12.202s)
[559.211942] [128/131] (474s left) i915_drm_fdinfo (virtual-busy-idle)
[559.246525] Starting subtest: virtual-busy-idle
[559.248204] Subtest virtual-busy-idle: SKIP (0.000s)
[559.328586] [129/131] (474s left) kms_pm_rpm (cursor)
[561.177216] Starting subtest: cursor
[561.179283] Subtest cursor: SKIP (0.000s)
[561.583962] [130/131] (471s left) api_intel_allocator (standalone)
[561.636821] Starting subtest: standalone
[561.650882] Subtest standalone: SUCCESS (0.016s)
[561.752686] [131/131] (471s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[561.838737] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[568.831548] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.989s)
[568.975900] Closing watchdogs
results: parsing output: 0/ for test: gem_wait
results: parsing output: 1/ for test: gem_create
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_bad_reloc
results: parsing output: 5/ for test: kms_invalid_mode
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_exec_parallel
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: gem_lmem_swapping
results: parsing output: 13/ for test: api_intel_bb
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: sw_sync
results: parsing output: 16/ for test: i915_drm_fdinfo
results: parsing output: 17/ for test: gem_exec_whisper
results: parsing output: 18/ for test: kms_properties
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: syncobj_eventfd
results: parsing output: 21/ for test: gem_ctx_shared
results: parsing output: 22/ for test: gem_gtt_cpu_tlb
results: parsing output: 23/ for test: tools_test
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_chamelium_hpd
results: parsing output: 26/ for test: gen9_exec_parse
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_atomic_transition
results: parsing output: 29/ for test: kms_draw_crc
results: parsing output: 30/ for test: kms_atomic
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_plane_multiple
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_atomic_transition
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_plane_alpha_blend
results: parsing output: 45/ for test: kms_dp_linktrain_fallback
results: parsing output: 46/ for test: i915_power
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_cdclk
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_readwrite
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: intel_hwmon
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_feature_discovery
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_vblank
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: kms_atomic_interruptible
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: gem_exec_whisper
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: core_setmaster_vs_auth
results: parsing output: 81/ for test: gem_busy
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: gem_pread
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_color
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_capture
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: kms_busy
results: parsing output: 94/ for test: device_reset
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: gem_exec_suspend
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: kms_vblank
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_ctx_param
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: i915_pm_rpm
results: parsing output: 108/ for test: gem_mmap
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: kms_chamelium_frames
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_addfb_basic
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_madvise
results: parsing output: 119/ for test: gem_ppgtt
results: parsing output: 120/ for test: kms_plane
results: parsing output: 121/ for test: kms_tv_load_detect
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: vgem_basic
results: parsing output: 124/ for test: gem_ctx_isolation
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: gem_exec_parallel
results: parsing output: 127/ for test: i915_drm_fdinfo
results: parsing output: 128/ for test: kms_pm_rpm
results: parsing output: 129/ for test: api_intel_allocator
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.