[60.492390] Initializing watchdogs [60.492439] /dev/watchdog0 [60.506791] [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] [60.512041] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.514109] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.516159] [001/131] (960s left) kms_prop_blob (invalid-set-prop-any) [60.573786] Starting subtest: invalid-set-prop-any [60.574846] Subtest invalid-set-prop-any: SUCCESS (0.000s) [60.672335] [002/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [60.771292] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [60.773067] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [60.900201] [003/131] (960s left) perf_pmu (render-node-busy-idle) [60.979540] Starting subtest: render-node-busy-idle [60.980642] Starting dynamic subtest: rcs0 [61.706222] Dynamic subtest rcs0: SUCCESS (0.726s) [61.714317] Starting dynamic subtest: bcs0 [62.375900] Dynamic subtest bcs0: SUCCESS (0.668s) [62.383820] Starting dynamic subtest: vcs0 [63.895604] Dynamic subtest vcs0: SUCCESS (1.516s) [63.903786] Starting dynamic subtest: vcs1 [65.879526] Dynamic subtest vcs1: SUCCESS (1.983s) [65.888316] Starting dynamic subtest: vecs0 [67.926901] Dynamic subtest vecs0: SUCCESS (2.047s) [67.934222] Starting dynamic subtest: ccs0 [68.596547] Dynamic subtest ccs0: SUCCESS (0.670s) [68.598104] Subtest render-node-busy-idle: SUCCESS (7.617s) [68.673204] [004/131] (952s left) perf (create-destroy-userspace-config) [68.800614] Starting subtest: create-destroy-userspace-config [68.818398] Subtest create-destroy-userspace-config: SUCCESS (0.017s) [68.850051] [005/131] (952s left) kms_hdr (static-toggle-suspend) [68.943817] Starting subtest: static-toggle-suspend [68.946390] Subtest static-toggle-suspend: SKIP (0.000s) [69.019725] [006/131] (952s left) kms_big_fb (4-tiled-8bpp-rotate-90) [69.119984] Starting subtest: 4-tiled-8bpp-rotate-90 [69.157108] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.037s) [69.312968] [007/131] (951s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [69.431404] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [69.433232] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [69.657207] [008/131] (951s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [69.746907] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [69.747897] Starting dynamic subtest: pipe-A-eDP-1 [69.809070] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s) [69.815922] Starting dynamic subtest: pipe-B-eDP-1 [69.875375] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.065s) [69.882977] Starting dynamic subtest: pipe-C-eDP-1 [69.940441] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.064s) [69.948030] Starting dynamic subtest: pipe-D-eDP-1 [70.004116] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.063s) [70.005428] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.258s) [72.315712] [009/131] (948s left) gem_ctx_param (invalid-size-set) [72.368437] Starting subtest: invalid-size-set [72.369639] Subtest invalid-size-set: SUCCESS (0.001s) [72.504725] [010/131] (948s left) gem_exec_schedule (submit-golden-slice) [72.572253] Starting subtest: submit-golden-slice [72.573256] Starting dynamic subtest: rcs0 [72.607044] Dynamic subtest rcs0: SUCCESS (0.036s) [72.615975] Starting dynamic subtest: bcs0 [72.639191] Dynamic subtest bcs0: SUCCESS (0.032s) [72.646744] Starting dynamic subtest: vcs0 [72.668641] Dynamic subtest vcs0: SUCCESS (0.029s) [72.675354] Starting dynamic subtest: vcs1 [72.695546] Dynamic subtest vcs1: SUCCESS (0.027s) [72.701987] Starting dynamic subtest: vecs0 [72.725267] Dynamic subtest vecs0: SUCCESS (0.030s) [72.732507] Starting dynamic subtest: ccs0 [72.756080] Dynamic subtest ccs0: SUCCESS (0.030s) [72.757737] Subtest submit-golden-slice: SUCCESS (0.185s) [74.040187] [011/131] (947s left) gem_ctx_param (set-priority-not-supported) [74.096538] Starting subtest: set-priority-not-supported [74.098731] Subtest set-priority-not-supported: SKIP (0.000s) [74.172749] [012/131] (947s left) gem_mmap (bad-object) [74.223285] Subtest bad-object: SKIP (0.000s) [74.280716] [013/131] (947s left) gem_busy (extended) [74.466997] Starting subtest: extended [74.468297] Starting dynamic subtest: rcs0 [74.579414] Dynamic subtest rcs0: SUCCESS (0.114s) [74.588644] Starting dynamic subtest: bcs0 [74.622156] Dynamic subtest bcs0: SUCCESS (0.042s) [74.629931] Starting dynamic subtest: vcs0 [75.928072] Dynamic subtest vcs0: SUCCESS (1.302s) [75.937231] Starting dynamic subtest: vcs1 [77.911517] Dynamic subtest vcs1: SUCCESS (1.983s) [77.920557] Starting dynamic subtest: vecs0 [79.895898] Dynamic subtest vecs0: SUCCESS (1.983s) [79.905281] Starting dynamic subtest: ccs0 [79.938849] Dynamic subtest ccs0: SUCCESS (0.045s) [79.940038] Subtest extended: SUCCESS (5.474s) [80.212111] [014/131] (941s left) perf (disabled-read-error) [80.310191] Starting subtest: disabled-read-error [80.323438] Subtest disabled-read-error: SUCCESS (0.013s) [80.365067] [015/131] (941s left) gem_exec_gttfill (engines) [80.423466] Starting subtest: engines [80.424573] Starting dynamic subtest: rcs0 [103.859254] Dynamic subtest rcs0: SUCCESS (23.434s) [103.868339] Starting dynamic subtest: bcs0 [127.071153] Dynamic subtest bcs0: SUCCESS (23.211s) [127.077796] Starting dynamic subtest: vcs0 [150.312896] Dynamic subtest vcs0: SUCCESS (23.240s) [150.322120] Starting dynamic subtest: vcs1 [173.586300] Dynamic subtest vcs1: SUCCESS (23.270s) [173.595864] Starting dynamic subtest: vecs0 [196.840869] Dynamic subtest vecs0: SUCCESS (23.254s) [196.849972] Starting dynamic subtest: ccs0 [220.151221] Dynamic subtest ccs0: SUCCESS (23.309s) [220.152091] Subtest engines: SUCCESS (139.723s) [220.342844] [016/131] (801s left) gem_ctx_isolation (nonpriv-switch) [220.428764] Starting subtest: nonpriv-switch [220.429766] Starting dynamic subtest: rcs0 [220.793189] Dynamic subtest rcs0: SUCCESS (0.364s) [220.800670] Starting dynamic subtest: bcs0 [221.167733] Dynamic subtest bcs0: SUCCESS (0.374s) [221.175865] Starting dynamic subtest: vcs0 [221.513340] Dynamic subtest vcs0: SUCCESS (0.346s) [221.522339] Starting dynamic subtest: vcs1 [223.205798] Dynamic subtest vcs1: SUCCESS (1.692s) [223.214059] Starting dynamic subtest: vecs0 [225.199439] Dynamic subtest vecs0: SUCCESS (1.993s) [225.208222] Starting dynamic subtest: ccs0 [227.218583] Dynamic subtest ccs0: SUCCESS (2.019s) [227.219508] Subtest nonpriv-switch: SUCCESS (6.790s) [227.460155] [017/131] (794s left) kms_big_fb (linear-8bpp-rotate-90) [227.567421] Starting subtest: linear-8bpp-rotate-90 [227.590448] Subtest linear-8bpp-rotate-90: SKIP (0.022s) [227.736290] [018/131] (793s left) kms_chamelium_edid (hdmi-edid-read) [228.118528] Subtest hdmi-edid-read: SKIP (0.000s) [228.890032] [019/131] (792s left) gem_ccs (suspend-resume) [228.947424] Starting subtest: suspend-resume [228.949398] Subtest suspend-resume: SKIP (0.000s) [229.020819] [020/131] (792s left) kms_force_connector_basic (force-connector-state) [229.098846] Starting subtest: force-connector-state [229.717423] Subtest force-connector-state: SUCCESS (0.618s) [230.679786] [021/131] (790s left) prime_mmap (test_userptr) [230.730552] Starting subtest: test_userptr [230.731461] Starting dynamic subtest: test_userptr-smem [230.732256] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [230.733076] Subtest test_userptr: SUCCESS (0.001s) [230.838675] [022/131] (790s left) syncobj_timeline (reset-multiple-signaled) [230.896926] Starting subtest: reset-multiple-signaled [230.897862] Subtest reset-multiple-signaled: SUCCESS (0.000s) [231.024410] [023/131] (790s left) gem_softpin (noreloc-s3) [231.074214] Starting subtest: noreloc-S3 [251.215877] Subtest noreloc-S3: SUCCESS (5.417s) [255.431794] [024/131] (770s left) kms_pm_rpm (system-suspend-idle) [256.971960] Starting subtest: system-suspend-idle [276.783706] Subtest system-suspend-idle: SUCCESS (4.683s) [281.201082] [025/131] (748s left) kms_cursor_crc (cursor-rapid-movement-512x512) [281.484158] Starting subtest: cursor-rapid-movement-512x512 [281.486131] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [281.676033] [026/131] (748s left) kms_psr (pr-cursor-mmap-cpu) [281.764363] Starting subtest: pr-cursor-mmap-cpu [281.766984] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [281.840328] [027/131] (748s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [281.930167] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [281.932475] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [282.050393] [028/131] (747s left) gem_watchdog (default-physical) [282.110353] Starting subtest: default-physical [283.876271] Subtest default-physical: SUCCESS (1.767s) [283.982465] [029/131] (745s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [284.578302] Starting subtest: syncobj-backward-timeline-chain-engines [284.737575] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.161s) [285.848549] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true [285.850616] [030/131] (744s left) syncobj_eventfd (binary-wait-before-signal) [285.902547] Starting subtest: binary-wait-before-signal [285.932116] Subtest binary-wait-before-signal: SUCCESS (0.031s) [286.024342] [031/131] (743s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [291.016861] Starting subtest: psr2-plane-move-sf-dmg-area [291.018318] Starting dynamic subtest: pipe-A-eDP-1 [296.208869] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.193s) [296.218568] Starting dynamic subtest: pipe-B-eDP-1 [301.407521] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.196s) [301.408649] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.393s) [302.243164] [032/131] (727s left) kms_flip (flip-vs-wf_vblank-interruptible) [302.340561] Starting subtest: flip-vs-wf_vblank-interruptible [302.343253] Starting dynamic subtest: A-eDP1 [304.248439] Dynamic subtest A-eDP1: SUCCESS (1.905s) [304.258611] Starting dynamic subtest: B-eDP1 [306.151518] Dynamic subtest B-eDP1: SUCCESS (1.902s) [306.161857] Starting dynamic subtest: C-eDP1 [308.042546] Dynamic subtest C-eDP1: SUCCESS (1.889s) [308.051024] Starting dynamic subtest: D-eDP1 [309.945922] Dynamic subtest D-eDP1: SUCCESS (1.903s) [309.949074] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.607s) [311.143725] [033/131] (718s left) gem_tiling_max_stride [311.252476] [034/131] (718s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [311.351091] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [311.353038] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [311.456304] [035/131] (718s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [311.552981] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [312.644222] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.091s) [312.793056] [036/131] (717s left) syncobj_timeline (etime-multi-wait-submitted) [312.843146] Starting subtest: etime-multi-wait-submitted [312.949330] Subtest etime-multi-wait-submitted: SUCCESS (0.104s) [313.045278] [037/131] (717s left) gen9_exec_parse (bb-start-cmd) [313.101110] Subtest bb-start-cmd: SKIP (0.000s) [313.171486] [038/131] (717s left) drm_read (short-buffer-block) [313.313617] Starting subtest: short-buffer-block [313.315353] Subtest short-buffer-block: SUCCESS (0.000s) [313.460301] [039/131] (716s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [313.545569] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [313.548192] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [313.668923] [040/131] (716s left) kms_chamelium_hpd (hdmi-hpd-fast) [314.039187] Subtest hdmi-hpd-fast: SKIP (0.000s) [314.805551] [041/131] (715s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [314.895444] Starting subtest: psr-1p-primscrn-cur-indfb-move [322.513136] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.617s) [322.677233] [042/131] (707s left) gem_userptr_blits (unsync-unmap-after-close) [322.740216] Subtest unsync-unmap-after-close: SKIP (0.000s) [322.885231] [043/131] (707s left) api_intel_allocator (default-alignment) [322.927369] Starting subtest: default-alignment [322.929313] Subtest default-alignment: SUCCESS (0.003s) [323.082107] [044/131] (707s left) kms_plane_alpha_blend (alpha-opaque-fb) [323.168852] Starting subtest: alpha-opaque-fb [323.464529] Starting dynamic subtest: pipe-A-eDP-1 [324.152570] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s) [324.160642] Starting dynamic subtest: pipe-D-eDP-1 [325.511536] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.358s) [325.512637] Subtest alpha-opaque-fb: SUCCESS (2.344s) [326.332488] [045/131] (704s left) gem_pxp (protected-raw-src-copy-not-readible) [326.443565] Starting subtest: protected-raw-src-copy-not-readible [326.502629] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s) [326.649150] [046/131] (703s left) drm_mm (drm_mm) [326.679422] Starting subtest: drm_mm [326.698281] Starting dynamic subtest: drm_test_mm_init [326.841102] Dynamic subtest drm_test_mm_init: SUCCESS (0.141s) [326.850238] Starting dynamic subtest: drm_test_mm_debug [326.976871] Dynamic subtest drm_test_mm_debug: SUCCESS (0.136s) [326.987162] Starting dynamic subtest: drm_test_mm_align32 [327.098870] Dynamic subtest drm_test_mm_align32: SUCCESS (0.119s) [327.107545] Starting dynamic subtest: drm_test_mm_align64 [327.238092] Dynamic subtest drm_test_mm_align64: SUCCESS (0.140s) [327.248574] Starting dynamic subtest: drm_test_mm_lowest [327.373168] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.133s) [327.381233] Starting dynamic subtest: drm_test_mm_highest [327.497678] Dynamic subtest drm_test_mm_highest: SUCCESS (0.125s) [327.498864] Subtest drm_mm: SUCCESS (0.819s) [327.697858] [047/131] (702s left) kms_async_flips (async-flip-with-page-flip-events-linear) [327.787791] Starting subtest: async-flip-with-page-flip-events-linear [328.160194] Starting dynamic subtest: pipe-A-eDP-1 [329.089874] Dynamic subtest pipe-A-eDP-1: FAIL (0.748s) [329.276878] Starting dynamic subtest: pipe-B-eDP-1 [330.195246] Dynamic subtest pipe-B-eDP-1: FAIL (0.814s) [330.449608] Starting dynamic subtest: pipe-C-eDP-1 [333.181857] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.736s) [333.545043] Starting dynamic subtest: pipe-D-eDP-1 [336.282199] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.742s) [336.283424] Subtest async-flip-with-page-flip-events-linear: FAIL (8.493s) [337.448491] [048/131] (693s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [337.540661] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [337.542495] Starting dynamic subtest: pipe-A-eDP-1 [337.554340] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [337.563300] Starting dynamic subtest: pipe-B-eDP-1 [337.575259] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [337.583285] Starting dynamic subtest: pipe-C-eDP-1 [337.618734] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [337.628290] Starting dynamic subtest: pipe-D-eDP-1 [337.636737] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [337.638397] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s) [339.745623] [049/131] (690s left) api_intel_bb (simple-bb) [339.798706] Starting subtest: simple-bb [339.806771] Subtest simple-bb: SUCCESS (0.008s) [339.957602] [050/131] (690s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [340.040215] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [340.041885] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [340.157014] [051/131] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [340.250747] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [340.252806] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [340.367818] [052/131] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [340.463020] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [340.464862] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [340.573143] [053/131] (690s left) kms_dp_link_training (uhbr-sst) [340.665692] Starting subtest: uhbr-sst [340.670103] Subtest uhbr-sst: SKIP (0.000s) [340.756066] [054/131] (690s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [340.847087] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [340.848728] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [340.953632] [055/131] (689s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [341.045564] Starting subtest: crc-primary-rotation-180-y-tiled-ccs [341.046743] Starting dynamic subtest: pipe-A-eDP-1 [341.061420] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [341.070575] Starting dynamic subtest: pipe-B-eDP-1 [341.081102] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [341.089462] Starting dynamic subtest: pipe-C-eDP-1 [341.099206] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [341.106963] Starting dynamic subtest: pipe-D-eDP-1 [341.116856] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [341.118869] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s) [343.236616] [056/131] (687s left) perf_pmu (busy-idle) [343.276338] Starting subtest: busy-idle [343.277492] Starting dynamic subtest: rcs0 [343.997232] Dynamic subtest rcs0: SUCCESS (0.720s) [344.008544] Starting dynamic subtest: bcs0 [344.677891] Dynamic subtest bcs0: SUCCESS (0.679s) [344.689893] Starting dynamic subtest: vcs0 [346.737567] Dynamic subtest vcs0: SUCCESS (2.055s) [346.747584] Starting dynamic subtest: vcs1 [348.785585] Dynamic subtest vcs1: SUCCESS (2.045s) [348.796891] Starting dynamic subtest: vecs0 [350.769845] Dynamic subtest vecs0: SUCCESS (1.981s) [350.781733] Starting dynamic subtest: ccs0 [351.443784] Dynamic subtest ccs0: SUCCESS (0.674s) [351.445741] Subtest busy-idle: SUCCESS (8.168s) [351.550547] [057/131] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [351.650033] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [358.284199] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.635s) [358.461053] [058/131] (672s left) kms_lease (possible-crtcs-filtering) [358.557689] Starting subtest: possible-crtcs-filtering [358.561318] Subtest possible-crtcs-filtering: SUCCESS (0.005s) [358.687571] [059/131] (672s left) kms_psr (pr-primary-mmap-cpu) [358.778469] Starting subtest: pr-primary-mmap-cpu [358.780406] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [358.861679] [060/131] (672s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [358.950379] Starting subtest: crc-primary-basic-yf-tiled-ccs [358.951245] Starting dynamic subtest: pipe-A-eDP-1 [358.959121] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [358.967165] Starting dynamic subtest: pipe-B-eDP-1 [358.975486] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [358.983436] Starting dynamic subtest: pipe-C-eDP-1 [358.991786] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [358.999571] Starting dynamic subtest: pipe-D-eDP-1 [359.010460] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [359.012276] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s) [361.242191] [061/131] (669s left) kms_hdr (bpc-switch-dpms) [361.335849] Starting subtest: bpc-switch-dpms [362.382433] Starting dynamic subtest: pipe-A-eDP-1 [366.883443] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.502s) [366.884393] Subtest bpc-switch-dpms: SUCCESS (5.549s) [367.005746] [062/131] (664s left) vgem_slow (nohang) [367.036054] Starting subtest: nohang [377.102995] Subtest nohang: SUCCESS (10.064s) [377.172666] [063/131] (653s left) gem_render_copy_redux (flink-interruptible) [377.218360] Starting subtest: flink-interruptible [378.353403] Subtest flink-interruptible: SUCCESS (1.135s) [378.512165] [064/131] (652s left) kms_async_flips (invalid-async-flip-atomic) [378.601742] Starting subtest: invalid-async-flip-atomic [378.979210] Starting dynamic subtest: pipe-A-eDP-1 [380.014535] Dynamic subtest pipe-A-eDP-1: FAIL (0.812s) [380.177317] Starting dynamic subtest: pipe-B-eDP-1 [381.168459] Dynamic subtest pipe-B-eDP-1: FAIL (0.825s) [381.389673] Starting dynamic subtest: pipe-C-eDP-1 [382.232550] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.852s) [382.611430] Starting dynamic subtest: pipe-D-eDP-1 [383.417132] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.839s) [383.418152] Subtest invalid-async-flip-atomic: FAIL (4.817s) [384.647672] [065/131] (646s left) kms_cursor_crc (cursor-sliding-256x85) [384.889668] Starting subtest: cursor-sliding-256x85 [384.935121] Subtest cursor-sliding-256x85: SKIP (0.043s) [385.119138] [066/131] (646s left) gem_spin_batch (legacy-resubmit) [385.176376] Starting subtest: legacy-resubmit [385.177500] Starting dynamic subtest: default [385.184372] Dynamic subtest default: SUCCESS (0.007s) [385.194612] Starting dynamic subtest: render [385.195756] Dynamic subtest render: SUCCESS (0.001s) [385.203664] Starting dynamic subtest: bsd [385.204851] Dynamic subtest bsd: SUCCESS (0.004s) [385.212907] Starting dynamic subtest: bsd1 [385.214258] Dynamic subtest bsd1: SUCCESS (0.001s) [385.222883] Starting dynamic subtest: bsd2 [385.224250] Dynamic subtest bsd2: SUCCESS (0.003s) [385.232247] Starting dynamic subtest: blt [385.233680] Dynamic subtest blt: SUCCESS (0.002s) [385.241728] Starting dynamic subtest: vebox [385.243195] Dynamic subtest vebox: SUCCESS (0.003s) [385.244400] Subtest legacy-resubmit: SUCCESS (0.028s) [385.456229] [067/131] (645s left) i915_pciid [385.631962] [068/131] (645s left) kms_flip (2x-absolute-wf_vblank-interruptible) [385.729891] Starting subtest: 2x-absolute-wf_vblank-interruptible [385.741478] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s) [385.864582] [069/131] (645s left) gem_ctx_persistence (legacy-engines-queued) [385.925384] Starting subtest: legacy-engines-queued [385.926643] Starting dynamic subtest: render [386.030274] Dynamic subtest render: SUCCESS (0.104s) [386.043273] Starting dynamic subtest: bsd1 [387.729885] Dynamic subtest bsd1: SUCCESS (1.695s) [387.741081] Starting dynamic subtest: bsd2 [389.711579] Dynamic subtest bsd2: SUCCESS (1.978s) [389.721476] Starting dynamic subtest: blt [389.795046] Dynamic subtest blt: SUCCESS (0.082s) [389.807131] Starting dynamic subtest: vebox [391.696575] Dynamic subtest vebox: SUCCESS (1.896s) [391.698198] Subtest legacy-engines-queued: SUCCESS (5.771s) [391.781335] [070/131] (639s left) kms_content_protection (dp-mst-lic-type-0) [391.921987] Starting subtest: dp-mst-lic-type-0 [391.925052] Subtest dp-mst-lic-type-0: SKIP (0.000s) [392.077523] [071/131] (639s left) kms_psr (psr-sprite-mmap-cpu) [392.161151] Starting subtest: psr-sprite-mmap-cpu [392.162566] Starting dynamic subtest: eDP-1 [393.944632] Dynamic subtest eDP-1: SUCCESS (1.783s) [393.946010] Subtest psr-sprite-mmap-cpu: SUCCESS (1.784s) [394.731426] [072/131] (636s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [394.818580] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [394.821249] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [394.959168] [073/131] (636s left) syncobj_eventfd (timeline-wait-signaled) [395.016387] Starting subtest: timeline-wait-signaled [395.017899] Subtest timeline-wait-signaled: SUCCESS (0.000s) [395.138618] [074/131] (636s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [395.232128] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [399.700215] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.468s) [400.846889] [075/131] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [400.929195] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [407.920312] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (6.992s) [408.094527] [076/131] (623s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [408.218065] Starting subtest: 2x-long-flip-vs-cursor-legacy [408.220064] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s) [408.383593] [077/131] (623s left) i915_query (test-query-geometry-subslices) [408.441075] Starting subtest: test-query-geometry-subslices [408.442286] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [408.563288] [078/131] (623s left) gem_exec_balancer (full-pulse) [408.623585] Starting subtest: full-pulse [413.669672] Subtest full-pulse: SUCCESS (5.046s) [414.008733] [079/131] (617s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [414.061346] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [414.062228] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [414.182928] [080/131] (617s left) kms_frontbuffer_tracking (psr-suspend) [414.266064] Starting subtest: psr-suspend [452.783856] Subtest psr-suspend: SUCCESS (8.373s) [458.953248] [081/131] (578s left) gem_mmap_offset (blt-coherency) [459.007201] Starting subtest: blt-coherency [459.018570] Subtest blt-coherency: SUCCESS (0.013s) [459.168226] [082/131] (578s left) kms_plane (pixel-format) [459.270547] Starting subtest: pixel-format [459.298520] Starting dynamic subtest: pipe-A-plane-0 [464.125070] Dynamic subtest pipe-A-plane-0: SUCCESS (4.822s) [464.133413] Starting dynamic subtest: pipe-A-plane-3 [466.415755] Dynamic subtest pipe-A-plane-3: SUCCESS (2.288s) [466.424103] Starting dynamic subtest: pipe-A-plane-5 [466.627064] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [467.696593] Starting dynamic subtest: pipe-B-plane-0 [472.457378] Dynamic subtest pipe-B-plane-0: SUCCESS (4.767s) [472.466411] Starting dynamic subtest: pipe-B-plane-3 [474.715138] Dynamic subtest pipe-B-plane-3: SUCCESS (2.255s) [474.723894] Starting dynamic subtest: pipe-B-plane-5 [474.924861] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s) [475.233255] Subtest pixel-format: SUCCESS (15.952s) [476.043179] [083/131] (561s left) gem_exec_alignment (many) [476.099263] Starting subtest: many [498.310811] Subtest many: SUCCESS (22.208s) [500.720809] [084/131] (537s left) kms_psr (psr2-sprite-mmap-cpu) [500.848522] Starting subtest: psr2-sprite-mmap-cpu [500.849402] Starting dynamic subtest: eDP-1 [502.593732] Dynamic subtest eDP-1: SUCCESS (1.744s) [502.594819] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.745s) [503.432102] [085/131] (534s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [503.558011] Starting subtest: flip-vs-cursor-busy-crc-legacy [504.403432] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.844s) [505.232507] [086/131] (532s left) gem_pxp (create-protected-buffer) [505.344723] Starting subtest: create-protected-buffer [505.345663] Subtest create-protected-buffer: SUCCESS (0.000s) [505.456109] [087/131] (532s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [505.550918] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [506.574302] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.024s) [506.715987] [088/131] (531s left) gen9_exec_parse (valid-registers) [506.770337] Subtest valid-registers: SKIP (0.000s) [506.837352] [089/131] (531s left) kms_getfb (getfb-handle-closed) [506.930388] Starting subtest: getfb-handle-closed [506.931361] Subtest getfb-handle-closed: SUCCESS (0.000s) [507.050024] [090/131] (530s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [507.139555] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [507.140469] Starting dynamic subtest: pipe-A-default-mode [509.802116] Dynamic subtest pipe-A-default-mode: SUCCESS (2.661s) [509.803232] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.662s) [510.626083] [091/131] (527s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [510.738640] Starting subtest: basic-busy-flip-before-cursor-legacy [510.740576] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [510.912653] [092/131] (527s left) gem_userptr_blits (forbidden-operations) [510.978201] Starting subtest: forbidden-operations [510.980000] Subtest forbidden-operations: SKIP (0.000s) [511.139331] [093/131] (526s left) gem_exec_reloc (basic-wc-read) [511.186578] Subtest basic-wc-read: SKIP (0.000s) [511.265836] [094/131] (526s left) gem_exec_schedule (noreorder) [511.444952] Starting subtest: noreorder [511.446078] Starting dynamic subtest: rcs0 [511.500389] Dynamic subtest rcs0: SUCCESS (0.056s) [511.512696] Starting dynamic subtest: vcs0 [512.896117] Dynamic subtest vcs0: SUCCESS (1.391s) [512.907846] Starting dynamic subtest: vcs1 [514.912604] Dynamic subtest vcs1: SUCCESS (2.014s) [514.923709] Starting dynamic subtest: vecs0 [516.940179] Dynamic subtest vecs0: SUCCESS (2.025s) [516.950944] Starting dynamic subtest: ccs0 [517.021728] Dynamic subtest ccs0: SUCCESS (0.081s) [517.022967] Subtest noreorder: SUCCESS (5.578s) [517.215346] [095/131] (520s left) gem_exec_schedule (u-submit-early-slice) [517.269761] Starting subtest: u-submit-early-slice [517.270662] Starting dynamic subtest: rcs0 [517.334906] Dynamic subtest rcs0: SUCCESS (0.064s) [517.345287] Starting dynamic subtest: bcs0 [517.382325] Dynamic subtest bcs0: SUCCESS (0.047s) [517.391932] Starting dynamic subtest: vcs0 [517.452260] Dynamic subtest vcs0: SUCCESS (0.069s) [517.462768] Starting dynamic subtest: vcs1 [517.509384] Dynamic subtest vcs1: SUCCESS (0.056s) [517.519716] Starting dynamic subtest: vecs0 [517.561545] Dynamic subtest vecs0: SUCCESS (0.052s) [517.570051] Starting dynamic subtest: ccs0 [517.620868] Dynamic subtest ccs0: SUCCESS (0.058s) [517.621782] Subtest u-submit-early-slice: SUCCESS (0.351s) [519.009129] [096/131] (519s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [519.130389] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [519.132046] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [519.280740] [097/131] (518s left) syncobj_basic (bad-pad-fd-to-handle) [519.335225] Starting subtest: bad-pad-fd-to-handle [519.336198] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [519.456819] [098/131] (518s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [519.548498] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [519.550253] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [519.669907] [099/131] (518s left) kms_psr (fbc-psr2-cursor-plane-onoff) [519.766219] Starting subtest: fbc-psr2-cursor-plane-onoff [519.767052] Starting dynamic subtest: eDP-1 [519.768677] Dynamic subtest eDP-1: SKIP (0.000s) [519.770383] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [519.847799] [100/131] (518s left) kms_cursor_crc (cursor-offscreen-max-size) [520.117326] Starting subtest: cursor-offscreen-max-size [520.120077] Subtest cursor-offscreen-max-size: SKIP (0.000s) [520.258298] [101/131] (518s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [520.340567] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [520.341593] Starting dynamic subtest: pipe-A-default-mode [520.628452] Dynamic subtest pipe-A-default-mode: SKIP (0.287s) [520.630103] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.288s) [521.431944] [102/131] (516s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [521.519594] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [521.520522] Starting dynamic subtest: pipe-A [522.628427] Dynamic subtest pipe-A: SUCCESS (1.109s) [522.637831] Starting dynamic subtest: pipe-B [524.808336] Dynamic subtest pipe-B: SUCCESS (2.178s) [524.816695] Starting dynamic subtest: pipe-C [525.961447] Dynamic subtest pipe-C: SUCCESS (1.152s) [525.969682] Starting dynamic subtest: pipe-D [527.169201] Dynamic subtest pipe-D: SUCCESS (1.207s) [527.170185] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.650s) [528.327077] [103/131] (510s left) syncobj_wait (invalid-signal-bad-pad) [528.391656] Starting subtest: invalid-signal-bad-pad [528.392667] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [528.500323] [104/131] (509s left) gem_exec_params (invalid-bsd1-flag-on-blt) [528.555036] Starting subtest: invalid-bsd1-flag-on-blt [528.556043] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [528.662529] [105/131] (509s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [533.711421] Starting subtest: pr-cursor-plane-move-continuous-sf [533.715268] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s) [534.533986] [106/131] (504s left) gem_mmap_gtt (medium-copy) [534.583452] Subtest medium-copy: SKIP (0.000s) [534.647181] [107/131] (503s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [534.730258] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [534.731108] Starting dynamic subtest: pipe-A-eDP-1 [534.752228] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [534.763350] Starting dynamic subtest: pipe-B-eDP-1 [534.785740] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [534.793549] Starting dynamic subtest: pipe-C-eDP-1 [534.814692] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [534.822538] Starting dynamic subtest: pipe-D-eDP-1 [534.843273] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [534.845460] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s) [537.025537] [108/131] (501s left) kms_frontbuffer_tracking (fbc-tiling-4) [537.110368] Starting subtest: fbc-tiling-4 [541.342447] Subtest fbc-tiling-4: SUCCESS (4.232s) [542.570730] [109/131] (496s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [542.664937] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [550.016798] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.351s) [550.159652] [110/131] (488s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [550.241194] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [550.242835] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [550.364748] [111/131] (488s left) gem_exec_create (legacy) [550.414155] Starting subtest: legacy [550.415229] Starting dynamic subtest: smem [553.906342] Dynamic subtest smem: SUCCESS (3.489s) [553.908003] Subtest legacy: SUCCESS (3.491s) [554.095012] [112/131] (484s left) gem_exec_reloc (basic-cpu-active) [554.145521] Subtest basic-cpu-active: SKIP (0.000s) [554.228172] [113/131] (484s left) i915_pm_rps (min-max-config-loaded) [554.283331] Starting subtest: min-max-config-loaded [554.285388] Subtest min-max-config-loaded: SKIP (0.001s) [554.420524] [114/131] (484s left) kms_universal_plane (universal-plane-pageflip-windowed) [554.507218] Starting subtest: universal-plane-pageflip-windowed [554.508152] Starting dynamic subtest: pipe-A-eDP-1 [555.112790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s) [555.122194] Starting dynamic subtest: pipe-B-eDP-1 [556.313218] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.198s) [556.322710] Starting dynamic subtest: pipe-C-eDP-1 [557.508702] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.192s) [557.516871] Starting dynamic subtest: pipe-D-eDP-1 [558.713216] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.203s) [558.714117] Subtest universal-plane-pageflip-windowed: SUCCESS (4.206s) [559.536366] [115/131] (479s left) kms_properties (plane-properties-atomic) [559.629283] Starting subtest: plane-properties-atomic [559.630318] Starting dynamic subtest: pipe-A-eDP-1 [560.184566] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s) [560.192867] Starting dynamic subtest: pipe-B-eDP-1 [561.462854] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.278s) [561.472687] Starting dynamic subtest: pipe-C-eDP-1 [562.748448] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.283s) [562.757043] Starting dynamic subtest: pipe-D-eDP-1 [564.055920] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s) [564.056947] Subtest plane-properties-atomic: SUCCESS (4.426s) [564.925032] [116/131] (473s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [565.026659] Starting subtest: yf-tiled-8bpp-rotate-0 [565.028519] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [565.142482] [117/131] (473s left) kms_pm_dc (dc5-psr) [566.233915] Starting subtest: dc5-psr [569.118631] Subtest dc5-psr: SUCCESS (2.885s) [569.920578] [118/131] (469s left) syncobj_timeline (single-wait-available-submitted) [569.963402] Starting subtest: single-wait-available-submitted [569.964397] Subtest single-wait-available-submitted: SUCCESS (0.000s) [570.066045] [119/131] (468s left) kms_pm_backlight (bad-brightness) [570.160504] Starting subtest: bad-brightness [570.213001] Starting dynamic subtest: eDP-1 [570.519662] Dynamic subtest eDP-1: SUCCESS (0.306s) [570.520589] Subtest bad-brightness: SUCCESS (0.360s) [571.315669] [120/131] (467s left) kms_setmode (basic-clone-single-crtc) [571.365347] Starting subtest: basic-clone-single-crtc [571.367790] Subtest basic-clone-single-crtc: SKIP (0.000s) [571.499601] [121/131] (467s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [571.596494] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [571.598222] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [571.733610] [122/131] (467s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs) [571.830499] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs [571.831472] Starting dynamic subtest: pipe-A-eDP-1 [571.840411] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [571.848573] Starting dynamic subtest: pipe-B-eDP-1 [571.857523] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [571.865667] Starting dynamic subtest: pipe-C-eDP-1 [571.874514] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [571.882706] Starting dynamic subtest: pipe-D-eDP-1 [571.891734] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [571.893327] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s) [574.035368] [123/131] (465s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [574.085109] Starting subtest: yf-tiled-to-vebox-yf-tiled [574.086934] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [574.271543] [124/131] (464s left) gem_lmem_swapping (massive) [574.304387] Subtest massive: SKIP (0.000s) [574.345890] [125/131] (464s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [574.440432] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [574.452204] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s) [574.547281] [126/131] (464s left) kms_vblank (wait-forked-busy-hang) [574.630350] Starting subtest: wait-forked-busy-hang [574.631213] Starting dynamic subtest: pipe-A-eDP-1 [600.701681] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.069s) [600.712000] Starting dynamic subtest: pipe-D-eDP-1 [625.663099] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.956s) [625.665113] Subtest wait-forked-busy-hang: SUCCESS (51.030s) [626.534480] [127/131] (412s left) sysfs_heartbeat_interval (idempotent) [626.604693] Starting subtest: idempotent [626.605745] Starting dynamic subtest: vecs0 [626.606667] Dynamic subtest vecs0: SUCCESS (0.001s) [626.617355] Starting dynamic subtest: ccs0 [626.618230] Dynamic subtest ccs0: SUCCESS (0.001s) [626.626739] Starting dynamic subtest: vcs0 [626.627696] Dynamic subtest vcs0: SUCCESS (0.000s) [626.635418] Starting dynamic subtest: bcs0 [626.636287] Dynamic subtest bcs0: SUCCESS (0.001s) [626.644019] Starting dynamic subtest: rcs0 [626.644984] Dynamic subtest rcs0: SUCCESS (0.001s) [626.652844] Starting dynamic subtest: vcs1 [626.653767] Dynamic subtest vcs1: SUCCESS (0.000s) [626.654677] Subtest idempotent: SUCCESS (0.009s) [626.742882] [128/131] (412s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [626.856134] Starting subtest: 2x-long-cursor-vs-flip-legacy [626.859186] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [627.022636] [129/131] (412s left) gem_lmem_swapping (verify-ccs) [627.056333] Subtest verify-ccs: SKIP (0.000s) [627.091261] [130/131] (412s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [627.187972] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [627.189627] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [627.324147] [131/131] (412s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [627.415598] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [627.417342] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [627.524155] Closing watchdogs results: parsing output: 0/ for test: kms_prop_blob results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: perf_pmu results: parsing output: 3/ for test: perf results: parsing output: 4/ for test: kms_hdr results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_cursor_legacy results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: gem_ctx_param results: parsing output: 9/ for test: gem_exec_schedule results: parsing output: 10/ for test: gem_ctx_param results: parsing output: 11/ for test: gem_mmap results: parsing output: 12/ for test: gem_busy results: parsing output: 13/ for test: perf results: parsing output: 14/ for test: gem_exec_gttfill results: parsing output: 15/ for test: gem_ctx_isolation results: parsing output: 16/ for test: kms_big_fb results: parsing output: 17/ for test: kms_chamelium_edid results: parsing output: 18/ for test: gem_ccs results: parsing output: 19/ for test: kms_force_connector_basic results: parsing output: 20/ for test: prime_mmap results: parsing output: 21/ for test: syncobj_timeline results: parsing output: 22/ for test: gem_softpin results: parsing output: 23/ for test: kms_pm_rpm results: parsing output: 24/ for test: kms_cursor_crc results: parsing output: 25/ for test: kms_psr results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_watchdog results: parsing output: 28/ for test: gem_exec_fence results: parsing output: 29/ for test: syncobj_eventfd results: parsing output: 30/ for test: kms_psr2_sf results: parsing output: 31/ for test: kms_flip results: parsing output: 32/ for test: gem_tiling_max_stride results: parsing output: 33/ for test: kms_big_fb results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: syncobj_timeline results: parsing output: 36/ for test: gen9_exec_parse results: parsing output: 37/ for test: drm_read results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_chamelium_hpd results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: gem_userptr_blits results: parsing output: 42/ for test: api_intel_allocator results: parsing output: 43/ for test: kms_plane_alpha_blend results: parsing output: 44/ for test: gem_pxp results: parsing output: 45/ for test: drm_mm results: parsing output: 46/ for test: kms_async_flips results: parsing output: 47/ for test: kms_ccs results: parsing output: 48/ for test: api_intel_bb results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_dp_link_training results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_ccs results: parsing output: 55/ for test: perf_pmu results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_lease results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: kms_ccs results: parsing output: 60/ for test: kms_hdr results: parsing output: 61/ for test: vgem_slow results: parsing output: 62/ for test: gem_render_copy_redux results: parsing output: 63/ for test: kms_async_flips results: parsing output: 64/ for test: kms_cursor_crc results: parsing output: 65/ for test: gem_spin_batch results: parsing output: 66/ for test: i915_pciid results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: gem_ctx_persistence results: parsing output: 69/ for test: kms_content_protection results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: syncobj_eventfd results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_cursor_legacy results: parsing output: 76/ for test: i915_query results: parsing output: 77/ for test: gem_exec_balancer results: parsing output: 78/ for test: syncobj_timeline results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_mmap_offset results: parsing output: 81/ for test: kms_plane results: parsing output: 82/ for test: gem_exec_alignment results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: kms_cursor_legacy results: parsing output: 85/ for test: gem_pxp results: parsing output: 86/ for test: kms_big_fb results: parsing output: 87/ for test: gen9_exec_parse results: parsing output: 88/ for test: kms_getfb results: parsing output: 89/ for test: kms_flip_scaled_crc results: parsing output: 90/ for test: kms_cursor_legacy results: parsing output: 91/ for test: gem_userptr_blits results: parsing output: 92/ for test: gem_exec_reloc results: parsing output: 93/ for test: gem_exec_schedule results: parsing output: 94/ for test: gem_exec_schedule results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: syncobj_basic results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_psr results: parsing output: 99/ for test: kms_cursor_crc results: parsing output: 100/ for test: kms_flip_scaled_crc results: parsing output: 101/ for test: kms_plane_scaling results: parsing output: 102/ for test: syncobj_wait results: parsing output: 103/ for test: gem_exec_params results: parsing output: 104/ for test: kms_psr2_sf results: parsing output: 105/ for test: gem_mmap_gtt results: parsing output: 106/ for test: kms_ccs results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: gem_exec_create results: parsing output: 111/ for test: gem_exec_reloc results: parsing output: 112/ for test: i915_pm_rps results: parsing output: 113/ for test: kms_universal_plane results: parsing output: 114/ for test: kms_properties results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: kms_pm_dc results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: kms_pm_backlight results: parsing output: 119/ for test: kms_setmode results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_ccs results: parsing output: 122/ for test: gem_render_copy results: parsing output: 123/ for test: gem_lmem_swapping results: parsing output: 124/ for test: kms_flip results: parsing output: 125/ for test: kms_vblank results: parsing output: 126/ for test: sysfs_heartbeat_interval results: parsing output: 127/ for test: kms_cursor_legacy results: parsing output: 128/ for test: gem_lmem_swapping results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.