[57.961868] Initializing watchdogs [57.961917] /dev/watchdog0 [57.975687] [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] [57.980047] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.982264] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.985678] [001/133] (960s left) gem_exec_whisper (basic-contexts) [58.072850] Starting subtest: basic-contexts [64.788904] Subtest basic-contexts: SUCCESS (6.738s) [64.994259] [002/133] (953s left) gem_mmap_gtt (fault-concurrent) [65.052658] Subtest fault-concurrent: SKIP (0.000s) [65.117835] [003/133] (953s left) perf (blocking) [65.255945] Starting subtest: blocking [65.257912] Starting dynamic subtest: 0-rcs0 [75.270435] Dynamic subtest 0-rcs0: SUCCESS (10.026s) [75.278374] Starting dynamic subtest: 1-vecs0 [85.290396] Dynamic subtest 1-vecs0: SUCCESS (10.023s) [85.292949] Subtest blocking: SUCCESS (20.050s) [85.334991] [004/133] (933s left) syncobj_timeline (invalid-query-zero-handles) [85.395632] Starting subtest: invalid-query-zero-handles [85.397928] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [85.525945] [005/133] (933s left) gem_flink_basic (flink-lifetime) [85.581044] Starting subtest: flink-lifetime [85.583469] Subtest flink-lifetime: SUCCESS (0.002s) [85.704068] [006/133] (932s left) i915_pm_rps (thresholds) [85.767688] Starting subtest: thresholds [85.772432] Subtest thresholds: SKIP (0.001s) [85.902819] [007/133] (932s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [86.023179] Starting subtest: yf-tiled-32bpp-rotate-0 [86.027822] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [86.160771] [008/133] (932s left) kms_pm_rpm (pm-caching) [88.019076] Starting subtest: pm-caching [88.024910] Subtest pm-caching: SKIP (0.000s) [88.525081] [009/133] (930s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [88.634444] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [88.636880] Starting dynamic subtest: pipe-A-default-mode [88.942744] Dynamic subtest pipe-A-default-mode: SKIP (0.304s) [88.947452] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.305s) [89.750018] [010/133] (929s left) kms_vrr (max-min) [89.854704] Starting subtest: max-min [89.860871] Subtest max-min: SKIP (0.000s) [89.942791] [011/133] (928s left) kms_flip_event_leak (basic) [90.037672] Starting subtest: basic [90.039811] Starting dynamic subtest: pipe-A-eDP-1 [90.456597] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s) [90.468222] Starting dynamic subtest: pipe-B-eDP-1 [91.546298] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.089s) [91.555903] Starting dynamic subtest: pipe-C-eDP-1 [92.657438] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s) [92.665829] Starting dynamic subtest: pipe-D-eDP-1 [93.794828] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s) [93.797255] Subtest basic: SUCCESS (3.759s) [94.677491] [012/133] (924s left) kms_vblank (ts-continuation-dpms-rpm) [94.796984] Starting subtest: ts-continuation-dpms-rpm [94.799370] Starting dynamic subtest: pipe-A-eDP-1 [97.372253] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.576s) [97.386951] Starting dynamic subtest: pipe-D-eDP-1 [99.623940] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.250s) [99.626334] Subtest ts-continuation-dpms-rpm: SUCCESS (4.830s) [100.525103] [013/133] (918s left) gem_mmap_gtt (basic-read) [100.592483] Subtest basic-read: SKIP (0.000s) [100.648912] [014/133] (918s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [100.748527] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [100.752685] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [100.875969] [015/133] (918s left) gem_exec_schedule (implicit-boths) [100.954376] Starting subtest: implicit-boths [100.956667] Starting dynamic subtest: rcs0 [101.047042] Dynamic subtest rcs0: SUCCESS (0.103s) [101.056783] Starting dynamic subtest: vcs0 [101.135734] Dynamic subtest vcs0: SUCCESS (0.088s) [101.147933] Starting dynamic subtest: vcs1 [101.212419] Dynamic subtest vcs1: SUCCESS (0.077s) [101.224670] Starting dynamic subtest: vecs0 [101.283271] Dynamic subtest vecs0: SUCCESS (0.071s) [101.293559] Starting dynamic subtest: ccs0 [101.361774] Dynamic subtest ccs0: SUCCESS (0.077s) [101.364495] Subtest implicit-boths: SUCCESS (0.418s) [103.056303] [016/133] (916s left) gem_render_copy (yf-tiled-ccs-to-x-tiled) [103.114822] Starting subtest: yf-tiled-ccs-to-x-tiled [103.119406] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s) [103.324207] [017/133] (915s left) kms_feature_discovery (dp-mst) [103.415944] Starting subtest: dp-mst [103.420324] Subtest dp-mst: SKIP (0.000s) [103.510148] [018/133] (915s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [103.637107] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [103.641656] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [103.802505] [019/133] (915s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-pwrite) [103.906464] Starting subtest: fbc-abgr161616f-draw-pwrite [103.910887] Subtest fbc-abgr161616f-draw-pwrite: SKIP (0.000s) [104.015202] [020/133] (915s left) kms_addfb_basic (basic-y-tiled-legacy) [104.080574] Starting subtest: basic-y-tiled-legacy [104.084934] Subtest basic-y-tiled-legacy: SKIP (0.000s) [104.239157] [021/133] (915s left) kms_addfb_basic (framebuffer-vs-set-tiling) [104.299285] Starting subtest: framebuffer-vs-set-tiling [104.303180] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [104.473714] [022/133] (914s left) gem_render_copy (x-tiled) [104.530769] Starting subtest: x-tiled [104.532771] Starting dynamic subtest: smem [104.571542] Dynamic subtest smem: SUCCESS (0.041s) [104.573621] Subtest x-tiled: SUCCESS (0.041s) [104.818718] [023/133] (914s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [104.905979] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [104.908342] Starting dynamic subtest: pipe-A-eDP-1 [104.930810] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [104.940686] Starting dynamic subtest: pipe-B-eDP-1 [104.961070] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [104.968089] Starting dynamic subtest: pipe-C-eDP-1 [104.988811] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [104.996243] Starting dynamic subtest: pipe-D-eDP-1 [105.017499] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [105.021843] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s) [107.186417] [024/133] (912s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [112.140040] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [112.144978] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [113.022985] [025/133] (906s left) gem_exec_balancer (hog) [113.092406] Starting subtest: hog [113.096762] Subtest hog: SKIP (0.000s) [113.424247] [026/133] (906s left) kms_flip (2x-plain-flip-fb-recreate) [113.520885] Starting subtest: 2x-plain-flip-fb-recreate [113.532081] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s) [113.654089] [027/133] (905s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [113.766697] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [122.232180] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.469s) [122.367713] [028/133] (897s left) gem_mmap_offset (open-flood) [122.422839] Starting subtest: open-flood [143.908587] Subtest open-flood: SUCCESS (21.489s) [144.053541] [029/133] (875s left) gem_eio (in-flight-internal-1us) [144.283780] Starting subtest: in-flight-internal-1us [145.965306] Subtest in-flight-internal-1us: SUCCESS (1.679s) [146.159105] [030/133] (873s left) perf_pmu (render-node-busy-idle) [146.235215] Starting subtest: render-node-busy-idle [146.237148] Starting dynamic subtest: rcs0 [146.910497] Dynamic subtest rcs0: SUCCESS (0.677s) [146.924675] Starting dynamic subtest: bcs0 [147.573433] Dynamic subtest bcs0: SUCCESS (0.661s) [147.584695] Starting dynamic subtest: vcs0 [148.886200] Dynamic subtest vcs0: SUCCESS (1.309s) [148.897570] Starting dynamic subtest: vcs1 [150.933647] Dynamic subtest vcs1: SUCCESS (2.045s) [150.945118] Starting dynamic subtest: vecs0 [152.918556] Dynamic subtest vecs0: SUCCESS (1.982s) [152.929623] Starting dynamic subtest: ccs0 [153.581713] Dynamic subtest ccs0: SUCCESS (0.662s) [153.584684] Subtest render-node-busy-idle: SUCCESS (7.349s) [153.680311] [031/133] (865s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [153.746210] Starting subtest: multi-wait-all-for-submit-signaled [153.748493] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s) [153.880129] [032/133] (865s left) kms_lease (lease-revoke) [153.992363] Starting subtest: lease-revoke [153.994760] Starting dynamic subtest: pipe-A-eDP-1 [154.020432] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s) [154.031869] Starting dynamic subtest: pipe-B-eDP-1 [154.046706] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s) [154.055529] Starting dynamic subtest: pipe-C-eDP-1 [154.074786] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s) [154.083581] Starting dynamic subtest: pipe-D-eDP-1 [154.102671] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s) [154.104887] Subtest lease-revoke: SUCCESS (0.114s) [154.243462] [033/133] (865s left) kms_pipe_crc_basic (suspend-read-crc) [154.335247] Starting subtest: suspend-read-crc [154.337524] Starting dynamic subtest: pipe-A-eDP-1 [171.799036] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.689s) [171.810548] Starting dynamic subtest: pipe-B-eDP-1 [189.800426] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.147s) [189.811135] Starting dynamic subtest: pipe-C-eDP-1 [207.762049] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.063s) [207.773392] Starting dynamic subtest: pipe-D-eDP-1 [225.776808] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.069s) [225.779261] Subtest suspend-read-crc: SUCCESS (11.973s) [226.592549] [034/133] (793s left) gem_mmap_gtt (cpuset-medium-copy) [226.662098] Subtest cpuset-medium-copy: SKIP (0.000s) [226.728288] [035/133] (793s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [231.802616] Starting subtest: fbc-psr2-cursor-plane-update-sf [231.804971] Starting dynamic subtest: pipe-A-eDP-1 [232.573109] Dynamic subtest pipe-A-eDP-1: SKIP (0.773s) [232.585601] Starting dynamic subtest: pipe-B-eDP-1 [233.697231] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s) [233.703284] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.910s) [234.911223] [036/133] (784s left) kms_big_fb (y-tiled-8bpp-rotate-0) [235.017924] Starting subtest: y-tiled-8bpp-rotate-0 [235.023143] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [235.146776] [037/133] (784s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [235.256510] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [235.261757] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [235.392642] [038/133] (784s left) gem_exec_fence (syncobj-repeat) [235.863399] Starting subtest: syncobj-repeat [236.035736] Subtest syncobj-repeat: SUCCESS (0.172s) [237.662473] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true [237.666067] [039/133] (782s left) i915_drm_fdinfo (most-busy-idle-check-all) [237.720096] Starting subtest: most-busy-idle-check-all [237.722716] Starting dynamic subtest: rcs0 [237.727931] Dynamic subtest rcs0: SKIP (0.005s) [237.743263] Starting dynamic subtest: bcs0 [237.749070] Dynamic subtest bcs0: SKIP (0.001s) [237.761377] Starting dynamic subtest: vcs0 [237.766247] Dynamic subtest vcs0: SKIP (0.000s) [237.775294] Starting dynamic subtest: vcs1 [237.780221] Dynamic subtest vcs1: SKIP (0.000s) [237.789124] Starting dynamic subtest: vecs0 [237.794092] Dynamic subtest vecs0: SKIP (0.000s) [237.803216] Starting dynamic subtest: ccs0 [237.808842] Dynamic subtest ccs0: SKIP (0.000s) [237.813924] Subtest most-busy-idle-check-all: SKIP (0.012s) [237.852754] [040/133] (782s left) kms_psr (fbc-psr2-primary-blt) [237.956139] Starting subtest: fbc-psr2-primary-blt [237.958705] Starting dynamic subtest: eDP-1 [237.963595] Dynamic subtest eDP-1: SKIP (0.000s) [237.969204] Subtest fbc-psr2-primary-blt: SKIP (0.001s) [238.050785] [041/133] (782s left) gen3_mixed_blits [238.197866] [042/133] (781s left) gem_exec_capture (capture) [238.269249] Starting subtest: capture [238.272184] Starting dynamic subtest: rcs0-smem [239.094669] Dynamic subtest rcs0-smem: SUCCESS (0.828s) [239.106624] Starting dynamic subtest: bcs0-smem [240.407683] Dynamic subtest bcs0-smem: SUCCESS (1.320s) [240.417144] Starting dynamic subtest: vcs0-smem [241.238338] Dynamic subtest vcs0-smem: SUCCESS (0.830s) [241.249561] Starting dynamic subtest: vcs1-smem [242.556203] Dynamic subtest vcs1-smem: SUCCESS (1.321s) [242.566959] Starting dynamic subtest: vecs0-smem [243.451671] Dynamic subtest vecs0-smem: FAIL (0.841s) [243.461745] Starting dynamic subtest: ccs0-smem [244.717586] Dynamic subtest ccs0-smem: SUCCESS (1.326s) [244.720269] Subtest capture: FAIL (6.471s) [244.884090] [043/133] (775s left) kms_plane_scaling (planes-scaler-unity-scaling) [244.988341] Starting subtest: planes-scaler-unity-scaling [244.990715] Starting dynamic subtest: pipe-A [245.050665] Dynamic subtest pipe-A: SUCCESS (0.064s) [245.066130] Starting dynamic subtest: pipe-B [246.170214] Dynamic subtest pipe-B: SUCCESS (1.119s) [246.182813] Starting dynamic subtest: pipe-C [247.276097] Dynamic subtest pipe-C: SUCCESS (1.106s) [247.292283] Starting dynamic subtest: pipe-D [248.406264] Dynamic subtest pipe-D: SUCCESS (1.130s) [248.409370] Subtest planes-scaler-unity-scaling: SUCCESS (3.426s) [249.588046] [044/133] (770s left) kms_plane_multiple (2x-tiling-yf) [249.688329] Starting subtest: 2x-tiling-yf [249.693499] Subtest 2x-tiling-yf: SKIP (0.000s) [249.785645] [045/133] (770s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [249.896398] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [249.901083] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [250.017191] [046/133] (770s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [250.120163] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [250.125154] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [250.246590] [047/133] (770s left) kms_cursor_crc (cursor-rapid-movement-64x64) [250.416364] Starting subtest: cursor-rapid-movement-64x64 [250.419152] Starting dynamic subtest: pipe-A-eDP-1 [250.964336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s) [250.988943] Starting dynamic subtest: pipe-D-eDP-1 [252.165624] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.185s) [252.168090] Subtest cursor-rapid-movement-64x64: SUCCESS (1.753s) [253.052719] [048/133] (767s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [258.103388] Starting subtest: psr2-cursor-plane-move-continuous-sf [258.106412] Starting dynamic subtest: pipe-A-eDP-1 [269.203719] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.091s) [269.215191] Starting dynamic subtest: pipe-B-eDP-1 [280.240620] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.034s) [280.243764] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.129s) [281.058856] [049/133] (739s left) kms_cursor_crc (cursor-sliding-512x170) [281.335031] Starting subtest: cursor-sliding-512x170 [281.339578] Subtest cursor-sliding-512x170: SKIP (0.001s) [281.524886] [050/133] (738s left) kms_getfb (getfb-repeated-different-handles) [281.614065] Starting subtest: getfb-repeated-different-handles [281.616600] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [281.748302] [051/133] (738s left) gem_ctx_isolation (preservation-reset) [281.918196] Starting subtest: preservation-reset [281.921305] Starting dynamic subtest: rcs0 [282.188100] Dynamic subtest rcs0: SUCCESS (0.269s) [282.201144] Starting dynamic subtest: bcs0 [282.513603] Dynamic subtest bcs0: SUCCESS (0.325s) [282.525349] Starting dynamic subtest: vcs0 [282.839365] Dynamic subtest vcs0: SUCCESS (0.325s) [282.851369] Starting dynamic subtest: vcs1 [284.894594] Dynamic subtest vcs1: SUCCESS (2.054s) [284.906779] Starting dynamic subtest: vecs0 [286.898641] Dynamic subtest vecs0: SUCCESS (2.003s) [286.910945] Starting dynamic subtest: ccs0 [288.869287] Dynamic subtest ccs0: SUCCESS (1.971s) [288.872232] Subtest preservation-reset: SUCCESS (6.954s) [289.042082] [052/133] (731s left) gem_ctx_persistence (legacy-engines-hang) [289.105456] Starting subtest: legacy-engines-hang [289.108348] Starting dynamic subtest: render [289.200760] Dynamic subtest render: SUCCESS (0.095s) [289.213301] Starting dynamic subtest: bsd1 [289.312693] Dynamic subtest bsd1: SUCCESS (0.109s) [289.325384] Starting dynamic subtest: bsd2 [289.421203] Dynamic subtest bsd2: SUCCESS (0.105s) [289.434110] Starting dynamic subtest: blt [289.536199] Dynamic subtest blt: SUCCESS (0.112s) [289.547661] Starting dynamic subtest: vebox [289.634685] Dynamic subtest vebox: SUCCESS (0.095s) [289.637251] Subtest legacy-engines-hang: SUCCESS (0.531s) [289.741750] [053/133] (730s left) gem_exec_schedule (u-independent) [289.816334] Starting subtest: u-independent [289.818846] Starting dynamic subtest: rcs0 [291.556644] Dynamic subtest rcs0: SUCCESS (1.748s) [291.569966] Starting dynamic subtest: vcs0 [293.561790] Dynamic subtest vcs0: SUCCESS (2.002s) [293.578771] Starting dynamic subtest: vcs1 [295.627365] Dynamic subtest vcs1: SUCCESS (2.064s) [295.639652] Starting dynamic subtest: vecs0 [297.603643] Dynamic subtest vecs0: SUCCESS (1.974s) [297.615349] Starting dynamic subtest: ccs0 [299.555774] Dynamic subtest ccs0: SUCCESS (1.950s) [299.558752] Subtest u-independent: SUCCESS (9.751s) [299.882833] [054/133] (720s left) kms_selftest (drm_dp_mst_helper) [299.922000] Starting subtest: drm_dp_mst_helper [299.943480] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [300.068390] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.123s) [300.077864] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [300.217349] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.150s) [300.227672] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [300.355377] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.138s) [300.358124] Subtest drm_dp_mst_helper: SUCCESS (0.435s) [300.572476] [055/133] (720s left) kms_pipe_crc_basic (bad-source) [300.672388] Starting subtest: bad-source [300.675209] Subtest bad-source: SUCCESS (0.000s) [300.768999] [056/133] (719s left) kms_flip_scaled_crc (flip-32bpp-yuv-linear-to-32bpp-yuv-linear-reflect-x) [300.866181] Starting subtest: flip-32bpp-yuv-linear-to-32bpp-yuv-linear-reflect-x [300.868931] Starting dynamic subtest: pipe-A-default-mode [301.998096] Dynamic subtest pipe-A-default-mode: SKIP (1.130s) [302.002349] Subtest flip-32bpp-yuv-linear-to-32bpp-yuv-linear-reflect-x: SKIP (1.132s) [302.173297] [057/133] (718s left) api_intel_bb (blit-reloc-purge-cache) [302.239777] Starting subtest: blit-reloc-purge-cache [302.244862] Subtest blit-reloc-purge-cache: SKIP (0.001s) [302.398078] [058/133] (718s left) gem_fence_thrash (bo-write-verify-x) [302.429901] Starting subtest: bo-write-verify-x [302.451714] Subtest bo-write-verify-x: SKIP (0.019s) [302.518664] [059/133] (718s left) sw_sync (sync_multi_consumer_producer) [302.554402] Starting subtest: sync_multi_consumer_producer [302.860095] Subtest sync_multi_consumer_producer: SUCCESS (0.304s) [302.951145] [060/133] (717s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [303.018644] Starting subtest: invalid-single-wait-all-unsubmitted [303.021342] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [303.164618] [061/133] (717s left) kms_chamelium_color (ctm-0-75) [303.264026] Subtest ctm-0-75: SKIP (0.000s) [303.307763] [062/133] (717s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [303.411210] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [303.416085] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [303.563802] [063/133] (717s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [303.681780] Starting subtest: 2x-long-flip-vs-cursor-atomic [303.687080] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s) [303.873771] [064/133] (717s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [303.995236] Starting subtest: basic-flip-before-cursor-legacy [304.914887] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.916s) [305.729230] [065/133] (715s left) gem_reg_read (timestamp-moving) [305.795134] Starting subtest: timestamp-moving [306.794638] Subtest timestamp-moving: SUCCESS (1.001s) [306.898923] [066/133] (714s left) core_setmaster (master-drop-set-root) [306.986086] Starting subtest: master-drop-set-root [306.998374] Subtest master-drop-set-root: SUCCESS (0.013s) [307.046188] [067/133] (714s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [307.140296] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [307.143180] Starting dynamic subtest: pipe-A-eDP-1 [307.168839] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [307.179867] Starting dynamic subtest: pipe-B-eDP-1 [307.202173] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [307.210951] Starting dynamic subtest: pipe-C-eDP-1 [307.233497] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [307.242108] Starting dynamic subtest: pipe-D-eDP-1 [307.265291] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [307.269891] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s) [309.321181] [068/133] (711s left) gem_exec_reloc (basic-concurrent16) [309.396240] Subtest basic-concurrent16: SKIP (0.000s) [309.466035] [069/133] (711s left) kms_chamelium_edid (dp-mode-timings) [309.848848] Subtest dp-mode-timings: SKIP (0.000s) [310.706026] [070/133] (710s left) syncobj_wait (invalid-single-wait-unsubmitted) [310.768274] Starting subtest: invalid-single-wait-unsubmitted [310.770802] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [310.923614] [071/133] (710s left) kms_cursor_crc (cursor-onscreen-32x32) [311.076747] Starting subtest: cursor-onscreen-32x32 [311.126016] Subtest cursor-onscreen-32x32: SKIP (0.042s) [311.430379] [072/133] (710s left) gem_exec_flush (basic-wb-prw-default) [311.499340] Starting subtest: basic-wb-prw-default [316.953103] Subtest basic-wb-prw-default: SUCCESS (5.457s) [317.172467] [073/133] (704s left) gem_ctx_bad_destroy (invalid-default-ctx) [317.216139] Starting subtest: invalid-default-ctx [317.218955] Subtest invalid-default-ctx: SUCCESS (0.000s) [317.318613] [074/133] (704s left) gem_create (create-valid-nonaligned) [317.379635] Starting subtest: create-valid-nonaligned [317.382365] Subtest create-valid-nonaligned: SUCCESS (0.000s) [317.595046] [075/133] (703s left) gem_ctx_shared (exec-single-timeline) [317.657028] Starting subtest: exec-single-timeline [317.660389] Starting dynamic subtest: rcs0 [318.719750] Dynamic subtest rcs0: SUCCESS (1.061s) [318.732973] Starting dynamic subtest: bcs0 [319.807403] Dynamic subtest bcs0: SUCCESS (1.086s) [319.821662] Starting dynamic subtest: vcs0 [320.896536] Dynamic subtest vcs0: SUCCESS (1.087s) [320.910212] Starting dynamic subtest: vcs1 [321.984492] Dynamic subtest vcs1: SUCCESS (1.085s) [321.998126] Starting dynamic subtest: vecs0 [323.072396] Dynamic subtest vecs0: SUCCESS (1.084s) [323.085901] Starting dynamic subtest: ccs0 [324.161033] Dynamic subtest ccs0: SUCCESS (1.085s) [324.164178] Subtest exec-single-timeline: SUCCESS (6.504s) [324.373482] [076/133] (697s left) kms_async_flips (test-cursor-atomic) [324.477136] Starting subtest: test-cursor-atomic [324.481552] Subtest test-cursor-atomic: SKIP (0.000s) [325.677011] [077/133] (696s left) kms_color (legacy-gamma) [325.782235] Starting subtest: legacy-gamma [325.785211] Starting dynamic subtest: pipe-A-eDP-1 [326.477951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s) [326.488962] Starting dynamic subtest: pipe-B-eDP-1 [327.868073] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.390s) [327.877684] Starting dynamic subtest: pipe-C-eDP-1 [329.232631] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s) [329.243258] Starting dynamic subtest: pipe-D-eDP-1 [330.572514] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s) [330.575354] Subtest legacy-gamma: SUCCESS (4.793s) [331.393629] [078/133] (690s left) kms_flip (blocking-wf_vblank) [331.502388] Starting subtest: blocking-wf_vblank [331.505188] Starting dynamic subtest: A-eDP1 [340.414975] Dynamic subtest A-eDP1: SUCCESS (8.914s) [340.432874] Starting dynamic subtest: B-eDP1 [349.357216] Dynamic subtest B-eDP1: SUCCESS (8.940s) [349.367920] Starting dynamic subtest: C-eDP1 [358.288394] Dynamic subtest C-eDP1: SUCCESS (8.930s) [358.301845] Starting dynamic subtest: D-eDP1 [367.221563] Dynamic subtest D-eDP1: SUCCESS (8.929s) [367.224140] Subtest blocking-wf_vblank: SUCCESS (35.725s) [368.479981] [079/133] (653s left) perf_pmu (busy-hang) [368.525105] Starting subtest: busy-hang [368.528300] Starting dynamic subtest: rcs0 [369.804586] Dynamic subtest rcs0: SUCCESS (1.283s) [369.826132] Starting dynamic subtest: bcs0 [371.048345] Dynamic subtest bcs0: SUCCESS (1.238s) [371.060392] Starting dynamic subtest: vcs0 [373.102367] Dynamic subtest vcs0: SUCCESS (2.052s) [373.113231] Starting dynamic subtest: vcs1 [375.086379] Dynamic subtest vcs1: SUCCESS (1.982s) [375.097403] Starting dynamic subtest: vecs0 [377.069349] Dynamic subtest vecs0: SUCCESS (1.982s) [377.080374] Starting dynamic subtest: ccs0 [378.318178] Dynamic subtest ccs0: SUCCESS (1.247s) [378.321304] Subtest busy-hang: SUCCESS (9.796s) [378.442422] [080/133] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [378.558188] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [378.563265] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [378.675333] [081/133] (643s left) gem_exec_params (rel-constants-invalid-rel-gen5) [378.736217] Starting subtest: rel-constants-invalid-rel-gen5 [378.739119] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [378.878528] [082/133] (643s left) gem_mmap_wc (write-wc-read-gtt) [378.942364] Subtest write-wc-read-gtt: SKIP (0.000s) [379.004707] [083/133] (642s left) api_intel_bb (intel-bb-blit-none) [379.061052] Starting subtest: intel-bb-blit-none [382.821887] Subtest intel-bb-blit-none: SUCCESS (3.734s) [382.943682] [084/133] (639s left) kms_frontbuffer_tracking (fbc-tiling-y) [383.052162] Starting subtest: fbc-tiling-y [383.057376] Subtest fbc-tiling-y: SKIP (0.000s) [383.192781] [085/133] (638s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [383.285382] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [383.290352] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [383.419901] [086/133] (638s left) gem_create (create-clear) [383.485823] Starting subtest: create-clear [383.488217] Starting dynamic subtest: smem0 [416.438246] Dynamic subtest smem0: SUCCESS (32.957s) [416.440894] Subtest create-clear: SUCCESS (32.959s) [416.655713] [087/133] (605s left) kms_color_pipeline (plane-lut3d-green-only) [416.766183] Starting subtest: plane-lut3d-green-only [416.778585] Starting dynamic subtest: pipe-A-eDP-1 [416.784177] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [417.831348] Starting dynamic subtest: pipe-B-eDP-1 [417.836685] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [418.865201] Starting dynamic subtest: pipe-C-eDP-1 [418.870279] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [419.891206] Starting dynamic subtest: pipe-D-eDP-1 [419.896374] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [420.166853] Subtest plane-lut3d-green-only: SKIP (3.401s) [420.998713] [088/133] (601s left) sysfs_heartbeat_interval (mixed) [421.068164] Starting subtest: mixed [421.071167] Starting dynamic subtest: vecs0 [426.310789] Dynamic subtest vecs0: SUCCESS (5.247s) [426.322952] Starting dynamic subtest: ccs0 [431.574595] Dynamic subtest ccs0: SUCCESS (5.263s) [431.586655] Starting dynamic subtest: vcs0 [436.804011] Dynamic subtest vcs0: SUCCESS (5.227s) [436.824571] Starting dynamic subtest: bcs0 [442.023381] Dynamic subtest bcs0: SUCCESS (5.218s) [442.035696] Starting dynamic subtest: rcs0 [447.254877] Dynamic subtest rcs0: SUCCESS (5.231s) [447.266977] Starting dynamic subtest: vcs1 [452.474342] Dynamic subtest vcs1: SUCCESS (5.216s) [452.477258] Subtest mixed: SUCCESS (31.415s) [452.579728] [089/133] (569s left) gem_basic (multigpu-create-close) [452.649676] Starting subtest: multigpu-create-close [452.655221] Subtest multigpu-create-close: SKIP (0.000s) [452.801204] [090/133] (569s left) prime_self_import (export-vs-gem_close-race) [452.840175] Starting subtest: export-vs-gem_close-race [457.942057] Subtest export-vs-gem_close-race: SUCCESS (5.105s) [458.070214] [091/133] (564s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [458.193739] Starting subtest: bad-pixel-format-y-tiled-ccs [458.196714] Starting dynamic subtest: pipe-A-eDP-1 [458.224837] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [458.236488] Starting dynamic subtest: pipe-B-eDP-1 [458.260970] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [458.270783] Starting dynamic subtest: pipe-C-eDP-1 [458.295288] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [458.305290] Starting dynamic subtest: pipe-D-eDP-1 [458.332148] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [458.337726] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s) [460.442901] [092/133] (561s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [460.538639] Starting subtest: plane-upscale-factor-0-25-with-rotation [460.541208] Starting dynamic subtest: pipe-A [460.763906] Dynamic subtest pipe-A: SUCCESS (0.227s) [460.774004] Starting dynamic subtest: pipe-B [462.100676] Dynamic subtest pipe-B: SUCCESS (1.336s) [462.110329] Starting dynamic subtest: pipe-C [463.437200] Dynamic subtest pipe-C: SUCCESS (1.335s) [463.447306] Starting dynamic subtest: pipe-D [464.769433] Dynamic subtest pipe-D: SUCCESS (1.331s) [464.773066] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.232s) [465.972124] [093/133] (556s left) gem_spin_batch (resubmit-new-all) [466.046354] Starting subtest: resubmit-new-all [466.049393] Starting dynamic subtest: rcs0 [466.063114] Dynamic subtest rcs0: SUCCESS (0.016s) [466.074957] Starting dynamic subtest: bcs0 [466.077909] Dynamic subtest bcs0: SUCCESS (0.012s) [466.090513] Starting dynamic subtest: vcs0 [466.094052] Dynamic subtest vcs0: SUCCESS (0.013s) [466.115508] Starting dynamic subtest: vcs1 [466.118282] Dynamic subtest vcs1: SUCCESS (0.009s) [466.129640] Starting dynamic subtest: vecs0 [466.132088] Dynamic subtest vecs0: SUCCESS (0.009s) [466.142015] Starting dynamic subtest: ccs0 [466.144159] Dynamic subtest ccs0: SUCCESS (0.011s) [466.146350] Subtest resubmit-new-all: SUCCESS (0.076s) [467.619927] [094/133] (554s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [467.681363] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [467.782180] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.101s) [467.886767] [095/133] (554s left) kms_addfb_basic (addfb25-modifier-no-flag) [467.985143] Starting subtest: addfb25-modifier-no-flag [467.987270] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [468.102877] [096/133] (554s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [468.201939] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [468.206385] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [468.335022] [097/133] (554s left) kms_psr (fbc-pr-primary-mmap-gtt) [468.419816] Starting subtest: fbc-pr-primary-mmap-gtt [468.424068] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [468.516744] [098/133] (554s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [468.629620] Starting subtest: cursorA-vs-flipB-atomic-transitions [468.633996] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [468.797096] [099/133] (553s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [468.887661] Starting subtest: psr-rgb565-draw-pwrite [475.806169] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.917s) [475.954743] [100/133] (546s left) i915_pm_rpm (debugfs-read) [477.786209] Starting subtest: debugfs-read [478.940292] Subtest debugfs-read: SUCCESS (1.154s) [479.306759] [101/133] (543s left) gem_basic (create-fd-close) [479.370041] Starting subtest: create-fd-close [479.375392] Subtest create-fd-close: SUCCESS (0.000s) [479.502148] [102/133] (543s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [479.606115] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [486.571761] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.967s) [486.724166] [103/133] (536s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip) [486.819485] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip [486.824808] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [486.944728] [104/133] (535s left) kms_big_fb (4-tiled-8bpp-rotate-180) [487.048323] Starting subtest: 4-tiled-8bpp-rotate-180 [488.284948] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.236s) [488.431463] [105/133] (534s left) gem_userptr_blits (probe) [488.504669] Starting subtest: probe [488.577934] Subtest probe: SUCCESS (0.073s) [488.735575] [106/133] (534s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [488.826625] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [488.829032] Starting dynamic subtest: pipe-A-eDP-1 [488.851625] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [488.862306] Starting dynamic subtest: pipe-B-eDP-1 [488.884084] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [488.893091] Starting dynamic subtest: pipe-C-eDP-1 [488.915346] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [488.926627] Starting dynamic subtest: pipe-D-eDP-1 [488.948133] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [488.952660] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s) [491.023250] [107/133] (531s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [491.119919] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [497.679373] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.561s) [497.816604] [108/133] (525s left) gen9_exec_parse (bb-large) [497.874131] Subtest bb-large: SKIP (0.000s) [497.964704] [109/133] (525s left) gem_ctx_exec (basic) [498.023385] Starting subtest: basic [498.028411] Subtest basic: SUCCESS (0.007s) [498.174630] [110/133] (524s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff) [498.284230] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff [498.290351] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [498.413132] [111/133] (524s left) kms_lease (lease-again) [498.495812] Starting subtest: lease-again [498.498218] Starting dynamic subtest: pipe-A-eDP-1 [498.500599] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [498.511338] Starting dynamic subtest: pipe-B-eDP-1 [498.513911] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [498.524154] Starting dynamic subtest: pipe-C-eDP-1 [498.526655] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [498.536361] Starting dynamic subtest: pipe-D-eDP-1 [498.538923] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [498.541164] Subtest lease-again: SUCCESS (0.012s) [498.638380] [112/133] (524s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [498.741328] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [498.745791] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [498.876425] [113/133] (524s left) syncobj_timeline (wait-all-delayed-signal) [498.942795] Starting subtest: wait-all-delayed-signal [499.043250] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [499.149613] [114/133] (524s left) gem_lmem_swapping (massive) [499.192035] Subtest massive: SKIP (0.000s) [499.248298] [115/133] (524s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [499.346209] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [500.204607] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.859s) [500.410579] [116/133] (522s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [500.511003] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [500.516143] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [500.649082] [117/133] (522s left) sw_sync (timeline_closed_signaled) [500.685098] Starting subtest: timeline_closed_signaled [500.687745] Subtest timeline_closed_signaled: SUCCESS (0.000s) [500.778618] [118/133] (522s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [500.869850] Starting subtest: multiplane-rotation-cropping-bottom [518.518944] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.649s) [518.652062] [119/133] (504s left) kms_psr (psr2-primary-blt) [518.757695] Starting subtest: psr2-primary-blt [518.759748] Starting dynamic subtest: eDP-1 [520.536965] Dynamic subtest eDP-1: SUCCESS (1.780s) [520.539601] Subtest psr2-primary-blt: SUCCESS (1.781s) [521.440167] [120/133] (502s left) kms_getfb (getfb2-handle-zero) [521.543111] Starting subtest: getfb2-handle-zero [521.545886] Subtest getfb2-handle-zero: SUCCESS (0.000s) [521.694433] [121/133] (501s left) gem_exec_reloc (basic-write-read-active) [521.769161] Subtest basic-write-read-active: SKIP (0.000s) [521.859639] [122/133] (501s left) kms_psr (fbc-psr-sprite-render) [521.961091] Starting subtest: fbc-psr-sprite-render [521.963193] Starting dynamic subtest: eDP-1 [521.968100] Dynamic subtest eDP-1: SKIP (0.000s) [521.972360] Subtest fbc-psr-sprite-render: SKIP (0.001s) [522.058374] [123/133] (501s left) gem_tiled_swapping (non-threaded) [522.119986] Subtest non-threaded: SKIP (0.000s) [522.189351] [124/133] (501s left) kms_chamelium_hpd (vga-hpd-after-suspend) [522.573890] Subtest vga-hpd-after-suspend: SKIP (0.000s) [523.423982] [125/133] (500s left) i915_hangman (gt-engine-hang) [523.500288] Starting subtest: gt-engine-hang [523.503151] Starting dynamic subtest: rcs0 [524.545380] Dynamic subtest rcs0: SUCCESS (1.044s) [524.560463] Starting dynamic subtest: bcs0 [526.465214] Dynamic subtest bcs0: SUCCESS (1.917s) [526.480962] Starting dynamic subtest: vcs0 [528.514751] Dynamic subtest vcs0: SUCCESS (2.047s) [528.527635] Starting dynamic subtest: vcs1 [530.561520] Dynamic subtest vcs1: SUCCESS (2.044s) [530.574288] Starting dynamic subtest: vecs0 [532.545100] Dynamic subtest vecs0: SUCCESS (1.981s) [532.560238] Starting dynamic subtest: ccs0 [534.465870] Dynamic subtest ccs0: SUCCESS (1.918s) [534.468933] Subtest gt-engine-hang: SUCCESS (10.967s) [534.624395] [126/133] (489s left) kms_flip (flip-vs-modeset-vs-hang) [534.718402] Starting subtest: flip-vs-modeset-vs-hang [534.721383] Starting dynamic subtest: A-eDP1 [586.041283] Dynamic subtest A-eDP1: SUCCESS (51.324s) [586.052374] Starting dynamic subtest: D-eDP1 [637.053035] Dynamic subtest D-eDP1: SUCCESS (51.014s) [637.055800] Subtest flip-vs-modeset-vs-hang: SUCCESS (102.346s) [637.468418] [127/133] (386s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [637.533654] Starting subtest: etime-single-wait-all-available-unsubmitted [637.639008] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.107s) [637.753989] [128/133] (386s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [637.849229] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [637.854275] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [637.967406] [129/133] (386s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [638.077795] Starting subtest: flip-vs-cursor-varying-size [646.548668] Subtest flip-vs-cursor-varying-size: SUCCESS (8.470s) [647.397554] [130/133] (376s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [647.523147] Starting subtest: cursorA-vs-flipB-atomic [647.527807] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [647.693491] [131/133] (376s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [647.763939] Starting subtest: yf-tiled-ccs-to-y-tiled [647.768819] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [647.971871] [132/133] (376s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [648.067277] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [648.072804] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [648.207066] [133/133] (375s left) gem_exec_nop (basic-series) [648.291358] Starting subtest: basic-series [664.551273] Subtest basic-series: SUCCESS (16.271s) [664.821200] Closing watchdogs results: parsing output: 0/ for test: gem_exec_whisper results: parsing output: 1/ for test: gem_mmap_gtt results: parsing output: 2/ for test: perf results: parsing output: 3/ for test: syncobj_timeline results: parsing output: 4/ for test: gem_flink_basic results: parsing output: 5/ for test: i915_pm_rps results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: kms_pm_rpm results: parsing output: 8/ for test: kms_flip_scaled_crc results: parsing output: 9/ for test: kms_vrr results: parsing output: 10/ for test: kms_flip_event_leak results: parsing output: 11/ for test: kms_vblank results: parsing output: 12/ for test: gem_mmap_gtt results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: gem_exec_schedule results: parsing output: 15/ for test: gem_render_copy results: parsing output: 16/ for test: kms_feature_discovery results: parsing output: 17/ for test: kms_cursor_legacy results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_addfb_basic results: parsing output: 20/ for test: kms_addfb_basic results: parsing output: 21/ for test: gem_render_copy results: parsing output: 22/ for test: kms_ccs results: parsing output: 23/ for test: kms_psr2_sf results: parsing output: 24/ for test: gem_exec_balancer results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_mmap_offset results: parsing output: 28/ for test: gem_eio results: parsing output: 29/ for test: perf_pmu results: parsing output: 30/ for test: syncobj_timeline results: parsing output: 31/ for test: kms_lease results: parsing output: 32/ for test: kms_pipe_crc_basic results: parsing output: 33/ for test: gem_mmap_gtt results: parsing output: 34/ for test: kms_psr2_sf results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: gem_exec_fence results: parsing output: 38/ for test: i915_drm_fdinfo results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: gen3_mixed_blits results: parsing output: 41/ for test: gem_exec_capture results: parsing output: 42/ for test: kms_plane_scaling results: parsing output: 43/ for test: kms_plane_multiple results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_cursor_crc results: parsing output: 47/ for test: kms_psr2_sf results: parsing output: 48/ for test: kms_cursor_crc results: parsing output: 49/ for test: kms_getfb results: parsing output: 50/ for test: gem_ctx_isolation results: parsing output: 51/ for test: gem_ctx_persistence results: parsing output: 52/ for test: gem_exec_schedule results: parsing output: 53/ for test: kms_selftest results: parsing output: 54/ for test: kms_pipe_crc_basic results: parsing output: 55/ for test: kms_flip_scaled_crc results: parsing output: 56/ for test: api_intel_bb results: parsing output: 57/ for test: gem_fence_thrash results: parsing output: 58/ for test: sw_sync results: parsing output: 59/ for test: syncobj_wait results: parsing output: 60/ for test: kms_chamelium_color results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_cursor_legacy results: parsing output: 63/ for test: kms_cursor_legacy results: parsing output: 64/ for test: gem_reg_read results: parsing output: 65/ for test: core_setmaster results: parsing output: 66/ for test: kms_ccs results: parsing output: 67/ for test: gem_exec_reloc results: parsing output: 68/ for test: kms_chamelium_edid results: parsing output: 69/ for test: syncobj_wait results: parsing output: 70/ for test: kms_cursor_crc results: parsing output: 71/ for test: gem_exec_flush results: parsing output: 72/ for test: gem_ctx_bad_destroy results: parsing output: 73/ for test: gem_create results: parsing output: 74/ for test: gem_ctx_shared results: parsing output: 75/ for test: kms_async_flips results: parsing output: 76/ for test: kms_color results: parsing output: 77/ for test: kms_flip results: parsing output: 78/ for test: perf_pmu results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_exec_params results: parsing output: 81/ for test: gem_mmap_wc results: parsing output: 82/ for test: api_intel_bb results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: gem_create results: parsing output: 86/ for test: kms_color_pipeline results: parsing output: 87/ for test: sysfs_heartbeat_interval results: parsing output: 88/ for test: gem_basic results: parsing output: 89/ for test: prime_self_import results: parsing output: 90/ for test: kms_ccs results: parsing output: 91/ for test: kms_plane_scaling results: parsing output: 92/ for test: gem_spin_batch results: parsing output: 93/ for test: syncobj_timeline results: parsing output: 94/ for test: kms_addfb_basic results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_psr results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: i915_pm_rpm results: parsing output: 100/ for test: gem_basic results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: gem_userptr_blits results: parsing output: 105/ for test: kms_ccs results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gen9_exec_parse results: parsing output: 108/ for test: gem_ctx_exec results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_lease results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: syncobj_timeline results: parsing output: 113/ for test: gem_lmem_swapping results: parsing output: 114/ for test: kms_big_fb results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: sw_sync results: parsing output: 117/ for test: kms_rotation_crc results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_getfb results: parsing output: 120/ for test: gem_exec_reloc results: parsing output: 121/ for test: kms_psr results: parsing output: 122/ for test: gem_tiled_swapping results: parsing output: 123/ for test: kms_chamelium_hpd results: parsing output: 124/ for test: i915_hangman results: parsing output: 125/ for test: kms_flip results: parsing output: 126/ for test: syncobj_timeline results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_cursor_legacy results: parsing output: 129/ for test: kms_cursor_legacy results: parsing output: 130/ for test: gem_render_copy results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: gem_exec_nop Done.