[53.068162] Initializing watchdogs [53.068305] /dev/watchdog0 [53.083883] [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] [53.088427] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [53.090490] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [53.092601] [001/131] (960s left) kms_setmode (basic) [53.145490] Starting subtest: basic [53.500987] Starting dynamic subtest: pipe-A-eDP-1 [55.516608] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.012s) [55.870663] Starting dynamic subtest: pipe-B-eDP-1 [58.008296] Dynamic subtest pipe-B-eDP-1: FAIL (2.093s) [58.273033] Subtest basic: FAIL (5.115s) [59.086287] [002/131] (954s left) gem_ppgtt (blt-vs-render-ctx0) [59.154956] Starting subtest: blt-vs-render-ctx0 [92.106559] Subtest blt-vs-render-ctx0: SUCCESS (32.914s) [92.229926] [003/131] (921s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [92.341470] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [92.342350] Starting dynamic subtest: pipe-A-eDP-1 [92.350641] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [92.358933] Starting dynamic subtest: pipe-B-eDP-1 [92.368142] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [92.375260] Starting dynamic subtest: pipe-C-eDP-1 [92.383518] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [92.388820] Starting dynamic subtest: pipe-D-eDP-1 [92.397159] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [92.398977] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.004s) [94.467634] [004/131] (919s left) gem_cs_tlb (engines) [94.520789] Starting subtest: engines [94.521880] Starting dynamic subtest: rcs0 [96.676302] Dynamic subtest rcs0: SUCCESS (2.153s) [96.682655] Starting dynamic subtest: bcs0 [98.830428] Dynamic subtest bcs0: SUCCESS (2.152s) [98.837962] Starting dynamic subtest: vcs0 [100.983658] Dynamic subtest vcs0: SUCCESS (2.153s) [100.992019] Starting dynamic subtest: vcs1 [103.136265] Dynamic subtest vcs1: SUCCESS (2.152s) [103.144517] Starting dynamic subtest: vecs0 [105.290207] Dynamic subtest vecs0: SUCCESS (2.153s) [105.297969] Starting dynamic subtest: ccs0 [107.443528] Dynamic subtest ccs0: SUCCESS (2.155s) [107.444802] Subtest engines: SUCCESS (12.920s) [107.583754] [005/131] (906s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [107.683761] Starting subtest: fbcpsr-shrfb-scaledprimary [115.441064] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (7.757s) [115.591886] [006/131] (898s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [115.685728] Starting subtest: invalidate-primary-flip-overlay [126.433871] Subtest invalidate-primary-flip-overlay: SUCCESS (10.749s) [126.537453] [007/131] (887s left) kms_big_fb (4-tiled-8bpp-rotate-180) [126.639929] Starting subtest: 4-tiled-8bpp-rotate-180 [127.774416] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.136s) [127.954889] [008/131] (885s left) i915_drm_fdinfo (busy-idle-check-all) [127.996689] Starting subtest: busy-idle-check-all [127.997573] Starting dynamic subtest: rcs0 [128.003380] Dynamic subtest rcs0: SKIP (0.006s) [128.010132] Starting dynamic subtest: bcs0 [128.011762] Dynamic subtest bcs0: SKIP (0.000s) [128.017353] Starting dynamic subtest: vcs0 [128.019094] Dynamic subtest vcs0: SKIP (0.000s) [128.024588] Starting dynamic subtest: vcs1 [128.026272] Dynamic subtest vcs1: SKIP (0.000s) [128.031815] Starting dynamic subtest: vecs0 [128.033559] Dynamic subtest vecs0: SKIP (0.000s) [128.039230] Starting dynamic subtest: ccs0 [128.040944] Dynamic subtest ccs0: SKIP (0.000s) [128.042694] Subtest busy-idle-check-all: SKIP (0.008s) [128.066821] [009/131] (885s left) gem_exec_balancer (semaphore) [128.163789] Starting subtest: semaphore [129.908219] Subtest semaphore: SUCCESS (1.742s) [130.238435] [010/131] (883s left) gem_exec_fence (nb-await) [130.420531] Starting subtest: nb-await [130.421650] Starting dynamic subtest: rcs0 [130.505373] Dynamic subtest rcs0: SUCCESS (0.085s) [130.514336] Starting dynamic subtest: bcs0 [130.567794] Dynamic subtest bcs0: SUCCESS (0.062s) [130.576579] Starting dynamic subtest: vcs0 [130.630390] Dynamic subtest vcs0: SUCCESS (0.062s) [130.638888] Starting dynamic subtest: vcs1 [130.690076] Dynamic subtest vcs1: SUCCESS (0.059s) [130.698684] Starting dynamic subtest: vecs0 [130.750936] Dynamic subtest vecs0: SUCCESS (0.061s) [130.760065] Starting dynamic subtest: ccs0 [130.812737] Dynamic subtest ccs0: SUCCESS (0.061s) [130.814113] Subtest nb-await: SUCCESS (0.393s) [132.940877] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true [132.942616] [011/131] (880s left) kms_color (ctm-0-25) [133.027528] Starting subtest: ctm-0-25 [133.028437] Starting dynamic subtest: pipe-A-eDP-1 [136.477768] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.449s) [136.485672] Starting dynamic subtest: pipe-B-eDP-1 [140.545373] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.067s) [140.551876] Starting dynamic subtest: pipe-C-eDP-1 [144.496258] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.951s) [144.502897] Starting dynamic subtest: pipe-D-eDP-1 [148.439882] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.943s) [148.440805] Subtest ctm-0-25: SUCCESS (15.411s) [149.272247] [012/131] (864s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [149.330097] Starting subtest: wait-all-for-submit-delayed-submit [149.436417] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [149.500065] [013/131] (864s left) kms_cursor_crc (cursor-alpha-transparent) [149.601753] Starting subtest: cursor-alpha-transparent [149.603042] Starting dynamic subtest: pipe-A-eDP-1 [150.232115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.628s) [150.240156] Starting dynamic subtest: pipe-D-eDP-1 [151.554699] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s) [151.555624] Subtest cursor-alpha-transparent: SUCCESS (1.953s) [152.413671] [014/131] (861s left) gem_pxp (verify-pxp-stale-ctx-execution) [152.544797] Starting subtest: verify-pxp-stale-ctx-execution [153.603029] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.060s) [153.725493] [015/131] (860s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [153.817796] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [153.818888] Starting dynamic subtest: pipe-A [153.825601] Dynamic subtest pipe-A: SKIP (0.005s) [153.832064] Starting dynamic subtest: pipe-B [153.842777] Dynamic subtest pipe-B: SKIP (0.016s) [153.850252] Starting dynamic subtest: pipe-C [153.858736] Dynamic subtest pipe-C: SKIP (0.017s) [153.864913] Starting dynamic subtest: pipe-D [153.878042] Dynamic subtest pipe-D: SKIP (0.018s) [153.879897] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.057s) [153.983765] [016/131] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [154.081279] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [154.082919] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [154.192862] [017/131] (859s left) gem_workarounds (suspend-resume) [154.249658] Starting subtest: suspend-resume [171.187661] Subtest suspend-resume: SUCCESS (1.751s) [178.342706] [018/131] (842s left) kms_psr (fbc-pr-basic) [178.440701] Starting subtest: fbc-pr-basic [178.442749] Subtest fbc-pr-basic: SKIP (0.000s) [178.508497] [019/131] (842s left) kms_cursor_crc (cursor-onscreen-128x42) [178.726492] Starting subtest: cursor-onscreen-128x42 [178.768435] Subtest cursor-onscreen-128x42: SKIP (0.036s) [178.972361] [020/131] (842s left) gem_render_copy (linear) [179.026331] Starting subtest: linear [179.027166] Starting dynamic subtest: smem [179.070857] Dynamic subtest smem: SUCCESS (0.044s) [179.072001] Subtest linear: SUCCESS (0.044s) [179.314612] [021/131] (841s left) kms_chamelium_color (ctm-0-25) [179.395299] Subtest ctm-0-25: SKIP (0.000s) [179.433940] [022/131] (841s left) kms_addfb_basic (clobberred-modifier) [179.489345] Starting subtest: clobberred-modifier [179.490984] Subtest clobberred-modifier: SKIP (0.000s) [179.613672] [023/131] (841s left) kms_prop_blob (invalid-get-prop) [179.661354] Starting subtest: invalid-get-prop [179.662448] Subtest invalid-get-prop: SUCCESS (0.000s) [179.759560] [024/131] (841s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [179.849463] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [186.504652] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.628s) [186.678548] [025/131] (834s left) gem_userptr_blits (sync-overlap) [186.741056] Starting subtest: sync-overlap [186.742086] Subtest sync-overlap: SUCCESS (0.000s) [186.871659] [026/131] (834s left) gem_exec_flush (basic-wb-ro-default) [186.923993] Starting subtest: basic-wb-ro-default [192.388835] Subtest basic-wb-ro-default: SUCCESS (5.453s) [192.568960] [027/131] (828s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [192.674422] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [193.545100] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.870s) [193.730855] [028/131] (827s left) kms_addfb_basic (too-high) [193.820590] Starting subtest: too-high [193.821560] Subtest too-high: SUCCESS (0.000s) [193.933032] [029/131] (827s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [194.018526] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [200.897823] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.874s) [201.005921] [030/131] (820s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [201.061791] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [201.063905] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [201.243129] [031/131] (820s left) kms_invalid_mode (zero-hdisplay) [201.324335] Starting subtest: zero-hdisplay [201.325330] Starting dynamic subtest: pipe-A-eDP-1 [201.610927] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [201.617809] Starting dynamic subtest: pipe-B-eDP-1 [201.618733] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [201.625047] Starting dynamic subtest: pipe-C-eDP-1 [201.625873] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [201.632519] Starting dynamic subtest: pipe-D-eDP-1 [201.633378] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [201.634255] Subtest zero-hdisplay: SUCCESS (0.290s) [202.384372] [032/131] (819s left) gem_exec_whisper (basic-queues-forked-all) [202.444904] Starting subtest: basic-queues-forked-all [222.403284] Subtest basic-queues-forked-all: SUCCESS (19.952s) [222.580657] [033/131] (799s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [222.678004] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [222.679787] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [222.784200] [034/131] (798s left) gem_mmap_gtt (hang-user) [222.829091] Subtest hang-user: SKIP (0.000s) [222.889956] [035/131] (798s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [222.979936] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [222.981827] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [223.091698] [036/131] (798s left) kms_sequence (get-busy) [223.173611] Starting subtest: get-busy [223.174579] Starting dynamic subtest: pipe-A-eDP-1 [225.124371] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.948s) [225.132700] Starting dynamic subtest: pipe-B-eDP-1 [227.681801] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.556s) [227.689026] Starting dynamic subtest: pipe-C-eDP-1 [230.298944] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.616s) [230.307335] Starting dynamic subtest: pipe-D-eDP-1 [232.824350] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s) [232.825417] Subtest get-busy: SUCCESS (9.648s) [233.607278] [037/131] (788s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [233.664590] Starting subtest: multi-wait-all-for-submit-unsubmitted [233.772234] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s) [233.839969] [038/131] (787s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [238.867226] Starting subtest: pr-overlay-plane-update-continuous-sf [238.869647] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.003s) [239.698185] [039/131] (782s left) syncobj_timeline (multi-wait-available-signaled) [239.752309] Starting subtest: multi-wait-available-signaled [239.753267] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [239.854304] [040/131] (781s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [239.911017] Starting subtest: invalid-multi-wait-unsubmitted-submitted [239.911900] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [239.995707] [041/131] (781s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [240.094615] Starting subtest: coverage-vs-premult-vs-constant [240.535130] Starting dynamic subtest: pipe-A-eDP-1 [241.088385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s) [241.096045] Starting dynamic subtest: pipe-D-eDP-1 [242.388580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s) [242.389548] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.292s) [243.252806] [042/131] (778s left) kms_psr (fbc-psr-no-drrs) [243.342833] Starting subtest: fbc-psr-no-drrs [243.343814] Starting dynamic subtest: eDP-1 [243.345727] Dynamic subtest eDP-1: SKIP (0.000s) [243.347591] Subtest fbc-psr-no-drrs: SKIP (0.001s) [243.413914] [043/131] (778s left) gem_tiled_blits (basic) [243.472370] Subtest basic: SKIP (0.000s) [243.541597] [044/131] (778s left) syncobj_timeline (etime-single-wait-submitted) [243.583996] Starting subtest: etime-single-wait-submitted [243.692279] Subtest etime-single-wait-submitted: SUCCESS (0.105s) [243.758258] [045/131] (778s left) kms_pm_rpm (modeset-lpsp-stress) [245.289148] Starting subtest: modeset-lpsp-stress [261.165754] Subtest modeset-lpsp-stress: SUCCESS (15.871s) [261.249650] [046/131] (760s left) api_intel_bb (full-batch) [261.309105] Starting subtest: full-batch [261.313184] Subtest full-batch: SUCCESS (0.006s) [261.452713] [047/131] (760s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [261.538640] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [261.539576] Starting dynamic subtest: pipe-A-eDP-1 [261.561410] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [261.569757] Starting dynamic subtest: pipe-B-eDP-1 [261.591272] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [261.598616] Starting dynamic subtest: pipe-C-eDP-1 [261.620193] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [261.627635] Starting dynamic subtest: pipe-D-eDP-1 [261.652763] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [261.654706] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s) [263.658263] [048/131] (758s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [263.757428] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [263.759016] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [263.866427] [049/131] (758s left) syncobj_basic (bad-handle-to-fd) [263.918384] Starting subtest: bad-handle-to-fd [263.919396] Subtest bad-handle-to-fd: SUCCESS (0.000s) [264.021887] [050/131] (758s left) perf (gen12-group-concurrent-oa-buffer-read) [264.134817] Starting subtest: gen12-group-concurrent-oa-buffer-read [274.187740] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.052s) [274.229795] [051/131] (747s left) kms_chamelium_edid (dp-edid-resolution-list) [274.610484] Subtest dp-edid-resolution-list: SKIP (0.000s) [275.362781] [052/131] (746s left) gem_exec_reloc (basic-softpin) [275.413616] Subtest basic-softpin: SKIP (0.000s) [275.497249] [053/131] (746s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [275.606913] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [280.097575] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.492s) [281.256722] [054/131] (741s left) i915_module_load (reload-with-fault-injection) [281.287312] Starting subtest: reload-with-fault-injection [321.499525] Subtest reload-with-fault-injection: SUCCESS (40.209s) [321.521548] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [321.522265] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true [321.524082] [055/131] (700s left) kms_addfb_basic (bo-too-small) [322.895186] Starting subtest: bo-too-small [322.896249] Subtest bo-too-small: SUCCESS (0.000s) [322.979827] [FACT kms_addfb_basic (bo-too-small)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [322.981654] [FACT kms_addfb_basic (bo-too-small)] new: kernel.kmod_is_loaded.i915: true [322.983977] [056/131] (699s left) gem_mmap_offset (open-flood) [323.039966] Starting subtest: open-flood [344.532315] Subtest open-flood: SUCCESS (21.489s) [344.647708] [057/131] (677s left) kms_lease (lease-invalid-connector) [344.747563] Starting subtest: lease-invalid-connector [344.748509] Starting dynamic subtest: pipe-A-eDP-1 [344.749399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [344.756535] Starting dynamic subtest: pipe-B-eDP-1 [344.757391] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [344.764025] Starting dynamic subtest: pipe-C-eDP-1 [344.764927] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [344.771503] Starting dynamic subtest: pipe-D-eDP-1 [344.772384] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [344.773277] Subtest lease-invalid-connector: SUCCESS (0.003s) [344.816382] [058/131] (677s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [344.924401] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [344.926192] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [345.019261] [059/131] (677s left) prime_mmap (test_forked_cpu_write) [345.070806] Starting subtest: test_forked_cpu_write [345.071952] Starting dynamic subtest: test_forked_cpu_write-smem [345.077768] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s) [345.078754] Subtest test_forked_cpu_write: SUCCESS (0.009s) [345.191673] [060/131] (677s left) kms_addfb_basic (basic) [345.250424] Starting subtest: basic [345.251491] Subtest basic: SUCCESS (0.000s) [345.384213] [061/131] (677s left) gem_exec_schedule (preempt-queue-contexts) [345.445269] Subtest preempt-queue-contexts: SKIP (0.000s) [345.728737] [062/131] (676s left) gem_madvise (dontneed-after-mmap) [345.758032] Starting subtest: dontneed-after-mmap [345.781431] Subtest dontneed-after-mmap: SUCCESS (0.025s) [345.873348] [063/131] (676s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [345.967418] Starting subtest: y-tiled-addfb-size-offset-overflow [345.969338] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [346.054770] [064/131] (676s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [346.147693] Starting subtest: fbcpsr-rgb101010-draw-blt [352.872933] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.724s) [353.002653] [065/131] (669s left) kms_atomic_interruptible (universal-setplane-primary) [353.102537] Starting subtest: universal-setplane-primary [353.103554] Starting dynamic subtest: pipe-A-eDP-1 [360.540369] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.436s) [360.541300] Subtest universal-setplane-primary: SUCCESS (7.437s) [361.371795] [066/131] (661s left) vgem_basic (create) [361.409959] Starting subtest: create [361.410811] Subtest create: SUCCESS (0.000s) [361.460332] [067/131] (661s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25) [361.550609] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25 [361.551763] Starting dynamic subtest: pipe-A [361.558165] Dynamic subtest pipe-A: SKIP (0.012s) [361.566990] Starting dynamic subtest: pipe-B [361.583582] Dynamic subtest pipe-B: SKIP (0.026s) [361.590767] Starting dynamic subtest: pipe-C [361.609592] Dynamic subtest pipe-C: SKIP (0.025s) [361.616597] Starting dynamic subtest: pipe-D [361.634788] Dynamic subtest pipe-D: SKIP (0.025s) [361.636545] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.089s) [361.749209] [068/131] (660s left) i915_suspend (basic-s2idle-without-i915) [361.780311] Starting subtest: basic-s2idle-without-i915 [381.477768] Subtest basic-s2idle-without-i915: SUCCESS (4.427s) [386.597597] [069/131] (641s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [386.711219] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [393.126886] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.384s) [393.256602] [070/131] (634s left) gem_softpin (safe-alignment) [393.322545] Starting subtest: safe-alignment [393.355508] Subtest safe-alignment: SUCCESS (0.033s) [395.377164] [071/131] (632s left) kms_big_fb (x-tiled-32bpp-rotate-270) [395.471076] Starting subtest: x-tiled-32bpp-rotate-270 [395.490592] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s) [395.618588] [072/131] (632s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [395.667913] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [395.727244] [073/131] (632s left) api_intel_allocator (fork-simple-once) [395.778096] Starting subtest: fork-simple-once [395.793595] Subtest fork-simple-once: SUCCESS (0.017s) [395.921200] [074/131] (632s left) kms_plane_multiple (2x-tiling-x) [396.015024] Starting subtest: 2x-tiling-x [396.016925] Subtest 2x-tiling-x: SKIP (0.000s) [396.079812] [075/131] (631s left) kms_cursor_legacy (flip-vs-cursor-atomic) [396.184127] Starting subtest: flip-vs-cursor-atomic [403.303860] Subtest flip-vs-cursor-atomic: SUCCESS (7.105s) [404.151634] [076/131] (623s left) gem_reg_read (timestamp-monotonic) [404.200693] Starting subtest: timestamp-monotonic [408.233082] Subtest timestamp-monotonic: SUCCESS (4.026s) [408.298759] [077/131] (619s left) sw_sync (sync_busy_fork) [408.328182] Starting subtest: sync_busy_fork [409.340426] Subtest sync_busy_fork: SUCCESS (1.012s) [409.397914] [078/131] (618s left) kms_vblank (ts-continuation-idle-hang) [409.484233] Starting subtest: ts-continuation-idle-hang [409.486464] Starting dynamic subtest: pipe-A-eDP-1 [436.186499] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.695s) [436.196161] Starting dynamic subtest: pipe-D-eDP-1 [451.156923] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.965s) [451.157861] Subtest ts-continuation-idle-hang: SUCCESS (41.665s) [452.021045] [079/131] (576s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [452.139471] Starting subtest: flip-vs-cursor-atomic-transitions [459.701885] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.558s) [460.543190] [080/131] (567s left) kms_chamelium_hpd (dp-hpd-fast) [460.921347] Subtest dp-hpd-fast: SKIP (0.000s) [461.747070] [081/131] (566s left) gem_exec_schedule (u-lateslice) [461.805838] Starting subtest: u-lateslice [461.806751] Starting dynamic subtest: rcs0 [461.828493] Dynamic subtest rcs0: SUCCESS (0.023s) [461.837877] Starting dynamic subtest: bcs0 [461.844848] Dynamic subtest bcs0: SUCCESS (0.016s) [461.852694] Starting dynamic subtest: vcs0 [461.863199] Dynamic subtest vcs0: SUCCESS (0.018s) [461.870843] Starting dynamic subtest: vcs1 [461.880826] Dynamic subtest vcs1: SUCCESS (0.017s) [461.891259] Starting dynamic subtest: vecs0 [461.897830] Dynamic subtest vecs0: SUCCESS (0.016s) [461.905346] Starting dynamic subtest: ccs0 [461.915329] Dynamic subtest ccs0: SUCCESS (0.017s) [461.916257] Subtest u-lateslice: SUCCESS (0.110s) [463.472106] [082/131] (564s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [463.558231] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [463.559212] Starting dynamic subtest: pipe-A-eDP-1 [464.437981] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.871s) [464.445523] Starting dynamic subtest: pipe-B-eDP-1 [465.976066] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.541s) [465.983337] Starting dynamic subtest: pipe-C-eDP-1 [467.471457] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.493s) [467.478977] Starting dynamic subtest: pipe-D-eDP-1 [468.890080] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.417s) [468.890953] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.327s) [470.069206] [083/131] (558s left) gem_userptr_blits (process-exit-busy) [470.137481] Starting subtest: process-exit-busy [470.152564] Subtest process-exit-busy: SUCCESS (0.015s) [470.290783] [084/131] (557s left) gem_ctx_persistence (idempotent) [470.355331] Starting subtest: idempotent [470.356486] Subtest idempotent: SUCCESS (0.000s) [470.454369] [085/131] (557s left) gem_ctx_persistence (legacy-engines-persistence) [470.510465] Starting subtest: legacy-engines-persistence [470.511510] Starting dynamic subtest: render [471.342069] Dynamic subtest render: SUCCESS (0.830s) [471.353512] Starting dynamic subtest: bsd1 [472.164874] Dynamic subtest bsd1: SUCCESS (0.819s) [472.174766] Starting dynamic subtest: bsd2 [473.000366] Dynamic subtest bsd2: SUCCESS (0.832s) [473.012463] Starting dynamic subtest: blt [473.788843] Dynamic subtest blt: SUCCESS (0.786s) [473.799103] Starting dynamic subtest: vebox [474.548278] Dynamic subtest vebox: SUCCESS (0.757s) [474.549488] Subtest legacy-engines-persistence: SUCCESS (4.037s) [474.680549] [086/131] (553s left) api_intel_bb (render-ccs) [474.735979] Starting subtest: render-ccs [475.109403] Subtest render-ccs: SUCCESS (0.370s) [475.217763] [087/131] (553s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [475.310320] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [475.312681] Starting dynamic subtest: pipe-A-default-mode [476.414624] Dynamic subtest pipe-A-default-mode: SKIP (1.099s) [476.416919] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.101s) [476.565741] [088/131] (551s left) sysfs_heartbeat_interval (invalid) [476.616349] Starting subtest: invalid [476.617478] Starting dynamic subtest: vecs0 [476.618633] Dynamic subtest vecs0: SUCCESS (0.000s) [476.628510] Starting dynamic subtest: ccs0 [476.629413] Dynamic subtest ccs0: SUCCESS (0.000s) [476.636539] Starting dynamic subtest: vcs0 [476.637439] Dynamic subtest vcs0: SUCCESS (0.000s) [476.644550] Starting dynamic subtest: bcs0 [476.645429] Dynamic subtest bcs0: SUCCESS (0.000s) [476.652321] Starting dynamic subtest: rcs0 [476.653302] Dynamic subtest rcs0: SUCCESS (0.000s) [476.660222] Starting dynamic subtest: vcs1 [476.661168] Dynamic subtest vcs1: SUCCESS (0.000s) [476.662088] Subtest invalid: SUCCESS (0.005s) [476.720856] [089/131] (551s left) perf_pmu (semaphore-busy) [476.756777] Starting subtest: semaphore-busy [476.757780] Starting dynamic subtest: rcs0 [478.416182] Dynamic subtest rcs0: SUCCESS (1.655s) [478.424461] Starting dynamic subtest: bcs0 [480.047419] Dynamic subtest bcs0: SUCCESS (1.628s) [480.057532] Starting dynamic subtest: vcs0 [483.848975] Dynamic subtest vcs0: SUCCESS (3.798s) [483.863304] Starting dynamic subtest: vcs1 [489.866297] Dynamic subtest vcs1: SUCCESS (6.017s) [489.875290] Starting dynamic subtest: vecs0 [495.880147] Dynamic subtest vecs0: SUCCESS (6.013s) [495.890478] Starting dynamic subtest: ccs0 [498.952781] Dynamic subtest ccs0: SUCCESS (3.072s) [498.954130] Subtest semaphore-busy: SUCCESS (22.196s) [499.060563] [090/131] (529s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [499.164203] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [504.532715] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.370s) [505.663626] [091/131] (522s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [505.758298] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [505.760118] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [505.864982] [092/131] (522s left) perf_pmu (busy-idle-no-semaphores) [505.901369] Starting subtest: busy-idle-no-semaphores [505.902307] Starting dynamic subtest: rcs0 [506.578793] Dynamic subtest rcs0: SUCCESS (0.674s) [506.589316] Starting dynamic subtest: bcs0 [507.229929] Dynamic subtest bcs0: SUCCESS (0.649s) [507.240242] Starting dynamic subtest: vcs0 [507.880943] Dynamic subtest vcs0: SUCCESS (0.649s) [507.891247] Starting dynamic subtest: vcs1 [508.979993] Dynamic subtest vcs1: SUCCESS (1.097s) [508.990315] Starting dynamic subtest: vecs0 [510.966481] Dynamic subtest vecs0: SUCCESS (1.985s) [510.975544] Starting dynamic subtest: ccs0 [513.015425] Dynamic subtest ccs0: SUCCESS (2.047s) [513.016813] Subtest busy-idle-no-semaphores: SUCCESS (7.112s) [513.123045] [093/131] (515s left) drm_read (short-buffer-wakeup) [513.279542] Starting subtest: short-buffer-wakeup [545.492500] Subtest short-buffer-wakeup: SUCCESS (32.215s) [545.631522] [094/131] (482s left) gem_exec_reloc (basic-wc-gtt-noreloc) [545.688616] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [545.770055] [095/131] (482s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [545.851707] Starting subtest: fbc-psr2-sprite-mmap-cpu [545.852640] Starting dynamic subtest: eDP-1 [545.854457] Dynamic subtest eDP-1: SKIP (0.000s) [545.856182] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [545.917803] [096/131] (482s left) gem_lmem_swapping (heavy-random) [545.952521] Subtest heavy-random: SKIP (0.000s) [545.993041] [097/131] (482s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [546.092785] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [546.094432] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [546.194413] [098/131] (482s left) kms_feature_discovery (psr1) [546.299850] Starting subtest: psr1 [546.300852] Subtest psr1: SUCCESS (0.000s) [546.366321] [099/131] (482s left) i915_pm_rps (min-max-config-loaded) [546.422498] Starting subtest: min-max-config-loaded [546.424931] Subtest min-max-config-loaded: SKIP (0.001s) [546.480893] [100/131] (482s left) gem_exec_reloc (basic-range) [546.534274] Subtest basic-range: SKIP (0.000s) [546.606900] [101/131] (482s left) gem_mmap (basic-small-bo) [546.653436] Subtest basic-small-bo: SKIP (0.000s) [546.710342] [102/131] (482s left) gem_render_copy_redux (normal) [546.764438] Starting subtest: normal [547.143011] Subtest normal: SUCCESS (0.379s) [547.260178] [103/131] (481s left) gem_exec_reloc (basic-wc-active) [547.308210] Subtest basic-wc-active: SKIP (0.000s) [547.373462] [104/131] (481s left) gem_exec_fence (syncobj-invalid-flags) [547.791526] Starting subtest: syncobj-invalid-flags [547.792662] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [549.478531] [105/131] (479s left) gem_exec_schedule (in-order) [549.540361] Starting subtest: in-order [549.541387] Starting dynamic subtest: rcs0 [549.725664] Dynamic subtest rcs0: SUCCESS (0.182s) [549.734665] Starting dynamic subtest: vcs0 [549.832136] Dynamic subtest vcs0: SUCCESS (0.108s) [549.842737] Starting dynamic subtest: vcs1 [549.938416] Dynamic subtest vcs1: SUCCESS (0.105s) [549.948926] Starting dynamic subtest: vecs0 [550.040338] Dynamic subtest vecs0: SUCCESS (0.101s) [550.048444] Starting dynamic subtest: ccs0 [550.169981] Dynamic subtest ccs0: SUCCESS (0.128s) [550.171452] Subtest in-order: SUCCESS (0.629s) [551.480554] [106/131] (477s left) kms_psr (pr-cursor-render) [551.583269] Starting subtest: pr-cursor-render [551.585002] Subtest pr-cursor-render: SKIP (0.000s) [551.650580] [107/131] (477s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [551.755936] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [552.615038] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.859s) [552.826840] [108/131] (476s left) kms_cursor_crc (cursor-sliding-64x64) [553.001546] Starting subtest: cursor-sliding-64x64 [553.005081] Starting dynamic subtest: pipe-A-eDP-1 [556.656868] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.651s) [556.686961] Starting dynamic subtest: pipe-D-eDP-1 [560.834893] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.154s) [560.836176] Subtest cursor-sliding-64x64: SUCCESS (7.833s) [561.689924] [109/131] (467s left) kms_dsc (dsc-with-bpc-formats) [561.781597] Starting subtest: dsc-with-bpc-formats [561.821840] Subtest dsc-with-bpc-formats: SKIP (0.003s) [561.850339] [110/131] (467s left) gem_exec_balancer (full-late-pulse) [561.908450] Starting subtest: full-late-pulse [566.262929] Subtest full-late-pulse: SUCCESS (4.353s) [566.556297] [111/131] (462s left) kms_cursor_legacy (cursor-vs-flip-atomic) [566.673431] Starting subtest: cursor-vs-flip-atomic [596.018814] Subtest cursor-vs-flip-atomic: SUCCESS (29.340s) [596.803680] [112/131] (432s left) kms_cursor_edge_walk (128x128-top-edge) [596.888239] Starting subtest: 128x128-top-edge [596.889261] Starting dynamic subtest: pipe-A-eDP-1 [600.369025] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s) [600.376853] Starting dynamic subtest: pipe-D-eDP-1 [603.493500] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s) [603.494446] Subtest 128x128-top-edge: SUCCESS (6.604s) [604.289962] [113/131] (424s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [604.388183] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [604.399399] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s) [604.468434] [114/131] (424s left) kms_psr (psr-cursor-plane-move) [604.568308] Starting subtest: psr-cursor-plane-move [604.569200] Starting dynamic subtest: eDP-1 [606.273582] Dynamic subtest eDP-1: SUCCESS (1.703s) [606.274592] Subtest psr-cursor-plane-move: SUCCESS (1.704s) [607.134381] [115/131] (422s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [607.228055] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [607.229795] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [607.365035] [116/131] (421s left) kms_flip (2x-plain-flip-fb-recreate) [607.457964] Starting subtest: 2x-plain-flip-fb-recreate [607.469237] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s) [607.542467] [117/131] (421s left) kms_big_fb (yf-tiled-32bpp-rotate-270) [607.643086] Starting subtest: yf-tiled-32bpp-rotate-270 [607.645144] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s) [607.743692] [118/131] (421s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [607.829542] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [607.830599] Starting dynamic subtest: pipe-A-default-mode [610.540989] Dynamic subtest pipe-A-default-mode: SUCCESS (2.709s) [610.541995] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.711s) [611.396175] [119/131] (417s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [611.493534] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [611.495278] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [611.580590] [120/131] (417s left) gem_create (create-massive) [611.637835] Starting subtest: create-massive [611.638759] Subtest create-massive: SUCCESS (0.000s) [611.813941] [121/131] (417s left) i915_drm_fdinfo (most-busy-idle-check-all) [611.846529] Starting subtest: most-busy-idle-check-all [611.848296] Starting dynamic subtest: rcs0 [611.852596] Dynamic subtest rcs0: SKIP (0.004s) [611.861130] Starting dynamic subtest: bcs0 [611.862746] Dynamic subtest bcs0: SKIP (0.000s) [611.870581] Starting dynamic subtest: vcs0 [611.872424] Dynamic subtest vcs0: SKIP (0.000s) [611.882317] Starting dynamic subtest: vcs1 [611.884046] Dynamic subtest vcs1: SKIP (0.000s) [611.891429] Starting dynamic subtest: vecs0 [611.893062] Dynamic subtest vecs0: SKIP (0.000s) [611.900424] Starting dynamic subtest: ccs0 [611.902086] Dynamic subtest ccs0: SKIP (0.000s) [611.903665] Subtest most-busy-idle-check-all: SKIP (0.009s) [611.931385] [122/131] (417s left) gem_softpin (evict-snoop) [612.026799] Starting subtest: evict-snoop [612.029000] Subtest evict-snoop: SKIP (0.000s) [612.136449] [123/131] (417s left) gem_userptr_blits (vma-merge) [612.205567] Starting subtest: vma-merge [612.246572] Subtest vma-merge: SUCCESS (0.041s) [612.367665] [124/131] (417s left) kms_flip (dpms-vs-vblank-race) [612.462971] Starting subtest: dpms-vs-vblank-race [612.466117] Starting dynamic subtest: A-eDP1 [617.471356] Dynamic subtest A-eDP1: SUCCESS (5.004s) [617.479009] Starting dynamic subtest: B-eDP1 [622.050842] Dynamic subtest B-eDP1: SUCCESS (4.578s) [622.058830] Starting dynamic subtest: C-eDP1 [626.653467] Dynamic subtest C-eDP1: SUCCESS (4.600s) [626.662282] Starting dynamic subtest: D-eDP1 [631.261111] Dynamic subtest D-eDP1: SUCCESS (4.605s) [631.262096] Subtest dpms-vs-vblank-race: SUCCESS (18.795s) [632.042992] [125/131] (397s left) kms_addfb_basic (master-rmfb) [632.096338] Starting subtest: master-rmfb [632.097452] Subtest master-rmfb: SUCCESS (0.001s) [632.245471] [126/131] (397s left) kms_hdr (bpc-switch-dpms) [632.331170] Starting subtest: bpc-switch-dpms [633.410206] Starting dynamic subtest: pipe-A-eDP-1 [637.800953] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.390s) [637.801908] Subtest bpc-switch-dpms: SUCCESS (5.469s) [637.929273] [127/131] (391s left) gen9_exec_parse (basic-rejected-ctx-param) [637.978401] Subtest basic-rejected-ctx-param: SKIP (0.000s) [638.059018] [128/131] (391s left) kms_pm_rpm (dpms-lpsp) [639.605333] Starting subtest: dpms-lpsp [640.230456] Subtest dpms-lpsp: SUCCESS (0.626s) [640.313223] [129/131] (389s left) kms_flip (plain-flip-fb-recreate-interruptible) [640.409483] Starting subtest: plain-flip-fb-recreate-interruptible [640.411748] Starting dynamic subtest: A-eDP1 [649.276679] Dynamic subtest A-eDP1: SUCCESS (8.863s) [649.286436] Starting dynamic subtest: B-eDP1 [658.108303] Dynamic subtest B-eDP1: SUCCESS (8.828s) [658.116612] Starting dynamic subtest: C-eDP1 [667.021721] Dynamic subtest C-eDP1: SUCCESS (8.911s) [667.031529] Starting dynamic subtest: D-eDP1 [675.845680] Dynamic subtest D-eDP1: SUCCESS (8.819s) [675.847802] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.430s) [677.009175] [130/131] (352s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [677.101182] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [677.102180] Starting dynamic subtest: pipe-A-eDP-1 [677.109882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [677.118323] Starting dynamic subtest: pipe-B-eDP-1 [677.127162] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [677.135030] Starting dynamic subtest: pipe-C-eDP-1 [677.142984] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [677.150501] Starting dynamic subtest: pipe-D-eDP-1 [677.157925] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [677.158784] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s) [679.269950] [131/131] (350s left) syncobj_eventfd (timeline-wait) [679.315975] Starting subtest: timeline-wait [679.326464] Subtest timeline-wait: SUCCESS (0.011s) [679.391521] Closing watchdogs results: parsing output: 0/ for test: kms_setmode results: parsing output: 1/ for test: gem_ppgtt results: parsing output: 2/ for test: kms_ccs results: parsing output: 3/ for test: gem_cs_tlb results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_psr_stress_test results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: i915_drm_fdinfo results: parsing output: 8/ for test: gem_exec_balancer results: parsing output: 9/ for test: gem_exec_fence results: parsing output: 10/ for test: kms_color results: parsing output: 11/ for test: syncobj_timeline results: parsing output: 12/ for test: kms_cursor_crc results: parsing output: 13/ for test: gem_pxp results: parsing output: 14/ for test: kms_plane_scaling results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_workarounds results: parsing output: 17/ for test: kms_psr results: parsing output: 18/ for test: kms_cursor_crc results: parsing output: 19/ for test: gem_render_copy results: parsing output: 20/ for test: kms_chamelium_color results: parsing output: 21/ for test: kms_addfb_basic results: parsing output: 22/ for test: kms_prop_blob results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: gem_userptr_blits results: parsing output: 25/ for test: gem_exec_flush results: parsing output: 26/ for test: kms_big_fb results: parsing output: 27/ for test: kms_addfb_basic results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: gem_render_copy results: parsing output: 30/ for test: kms_invalid_mode results: parsing output: 31/ for test: gem_exec_whisper results: parsing output: 32/ for test: kms_big_fb results: parsing output: 33/ for test: gem_mmap_gtt results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_sequence results: parsing output: 36/ for test: syncobj_wait results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: syncobj_timeline results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: kms_plane_alpha_blend results: parsing output: 41/ for test: kms_psr results: parsing output: 42/ for test: gem_tiled_blits results: parsing output: 43/ for test: syncobj_timeline results: parsing output: 44/ for test: kms_pm_rpm results: parsing output: 45/ for test: api_intel_bb results: parsing output: 46/ for test: kms_ccs results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: syncobj_basic results: parsing output: 49/ for test: perf results: parsing output: 50/ for test: kms_chamelium_edid results: parsing output: 51/ for test: gem_exec_reloc results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: i915_module_load results: parsing output: 54/ for test: kms_addfb_basic results: parsing output: 55/ for test: gem_mmap_offset results: parsing output: 56/ for test: kms_lease results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: prime_mmap results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: gem_exec_schedule results: parsing output: 61/ for test: gem_madvise results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_atomic_interruptible results: parsing output: 65/ for test: vgem_basic results: parsing output: 66/ for test: kms_plane_scaling results: parsing output: 67/ for test: i915_suspend results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: gem_softpin results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: kms_pipe_b_c_ivb results: parsing output: 72/ for test: api_intel_allocator results: parsing output: 73/ for test: kms_plane_multiple results: parsing output: 74/ for test: kms_cursor_legacy results: parsing output: 75/ for test: gem_reg_read results: parsing output: 76/ for test: sw_sync results: parsing output: 77/ for test: kms_vblank results: parsing output: 78/ for test: kms_cursor_legacy results: parsing output: 79/ for test: kms_chamelium_hpd results: parsing output: 80/ for test: gem_exec_schedule results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: gem_userptr_blits results: parsing output: 83/ for test: gem_ctx_persistence results: parsing output: 84/ for test: gem_ctx_persistence results: parsing output: 85/ for test: api_intel_bb results: parsing output: 86/ for test: kms_flip_scaled_crc results: parsing output: 87/ for test: sysfs_heartbeat_interval results: parsing output: 88/ for test: perf_pmu results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: perf_pmu results: parsing output: 92/ for test: drm_read results: parsing output: 93/ for test: gem_exec_reloc results: parsing output: 94/ for test: kms_psr results: parsing output: 95/ for test: gem_lmem_swapping results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_feature_discovery results: parsing output: 98/ for test: i915_pm_rps results: parsing output: 99/ for test: gem_exec_reloc results: parsing output: 100/ for test: gem_mmap results: parsing output: 101/ for test: gem_render_copy_redux results: parsing output: 102/ for test: gem_exec_reloc results: parsing output: 103/ for test: gem_exec_fence results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_psr results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: kms_cursor_crc results: parsing output: 108/ for test: kms_dsc results: parsing output: 109/ for test: gem_exec_balancer results: parsing output: 110/ for test: kms_cursor_legacy results: parsing output: 111/ for test: kms_cursor_edge_walk results: parsing output: 112/ for test: kms_flip results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_flip results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: kms_flip_scaled_crc results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gem_create results: parsing output: 120/ for test: i915_drm_fdinfo results: parsing output: 121/ for test: gem_softpin results: parsing output: 122/ for test: gem_userptr_blits results: parsing output: 123/ for test: kms_flip results: parsing output: 124/ for test: kms_addfb_basic results: parsing output: 125/ for test: kms_hdr results: parsing output: 126/ for test: gen9_exec_parse results: parsing output: 127/ for test: kms_pm_rpm results: parsing output: 128/ for test: kms_flip results: parsing output: 129/ for test: kms_ccs results: parsing output: 130/ for test: syncobj_eventfd Done.