[109.388643] Initializing watchdogs [109.388707] /dev/watchdog0 [109.408801] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [109.420338] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [109.424438] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [109.426588] [001/132] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [109.614709] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [112.300660] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.687s) [112.525585] [002/132] (957s left) kms_pm_rpm (modeset-lpsp-stress) [114.064645] Starting subtest: modeset-lpsp-stress [114.387452] Subtest modeset-lpsp-stress: SKIP (0.321s) [114.864925] [003/132] (955s left) kms_plane_scaling (2x-scaler-multi-pipe) [115.051414] Starting subtest: 2x-scaler-multi-pipe [115.054177] Subtest 2x-scaler-multi-pipe: SKIP (0.002s) [115.238986] [004/132] (954s left) kms_cursor_crc (cursor-sliding-256x256) [115.647493] Starting subtest: cursor-sliding-256x256 [115.651215] Starting dynamic subtest: pipe-A-DP-3 [120.078708] Dynamic subtest pipe-A-DP-3: SUCCESS (4.427s) [120.130413] Starting dynamic subtest: pipe-D-DP-3 [124.402981] Dynamic subtest pipe-D-DP-3: SUCCESS (4.279s) [124.403995] Subtest cursor-sliding-256x256: SUCCESS (8.755s) [124.860065] [005/132] (945s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [125.057490] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [125.059239] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [125.255042] [006/132] (945s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [125.436964] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [125.437914] Starting dynamic subtest: pipe-A-DP-3 [125.446273] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [125.454844] Starting dynamic subtest: pipe-B-DP-3 [125.463553] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [125.471857] Starting dynamic subtest: pipe-C-DP-3 [125.479972] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [125.487685] Starting dynamic subtest: pipe-D-DP-3 [125.497036] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [125.499022] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.004s) [125.945617] [007/132] (944s left) kms_plane_multiple (tiling-4) [126.126013] Starting subtest: tiling-4 [126.126934] Starting dynamic subtest: pipe-A-DP-3 [127.281314] Dynamic subtest pipe-A-DP-3: SUCCESS (1.154s) [127.298299] Starting dynamic subtest: pipe-B-DP-3 [128.384742] Dynamic subtest pipe-B-DP-3: SUCCESS (1.101s) [128.403079] Starting dynamic subtest: pipe-C-DP-3 [129.455548] Dynamic subtest pipe-C-DP-3: SUCCESS (1.069s) [129.464166] Starting dynamic subtest: pipe-D-DP-3 [130.544335] Dynamic subtest pipe-D-DP-3: SUCCESS (1.088s) [130.545228] Subtest tiling-4: SUCCESS (4.418s) [130.849093] [008/132] (939s left) gem_wait (write-busy) [130.938906] Starting subtest: write-busy [130.939843] Starting dynamic subtest: all-engines [131.586230] Dynamic subtest all-engines: SUCCESS (0.647s) [131.595247] Starting dynamic subtest: rcs0 [132.127989] Dynamic subtest rcs0: SUCCESS (0.541s) [132.136989] Starting dynamic subtest: bcs0 [132.670595] Dynamic subtest bcs0: SUCCESS (0.542s) [132.679376] Starting dynamic subtest: vcs0 [133.212226] Dynamic subtest vcs0: SUCCESS (0.541s) [133.221207] Starting dynamic subtest: vcs1 [133.755303] Dynamic subtest vcs1: SUCCESS (0.543s) [133.764122] Starting dynamic subtest: vecs0 [134.297971] Dynamic subtest vecs0: SUCCESS (0.542s) [134.306738] Starting dynamic subtest: vecs1 [134.839370] Dynamic subtest vecs1: SUCCESS (0.541s) [134.848208] Starting dynamic subtest: ccs0 [135.381014] Dynamic subtest ccs0: SUCCESS (0.541s) [135.381992] Subtest write-busy: SUCCESS (4.442s) [135.769939] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true [135.771577] [009/132] (934s left) perf_pmu (init-busy) [135.844042] Starting subtest: init-busy [135.844995] Starting dynamic subtest: rcs0 [135.846991] Dynamic subtest rcs0: SUCCESS (0.002s) [135.855573] Starting dynamic subtest: bcs0 [135.856422] Dynamic subtest bcs0: SUCCESS (0.001s) [135.864431] Starting dynamic subtest: vcs0 [135.865303] Dynamic subtest vcs0: SUCCESS (0.001s) [135.873636] Starting dynamic subtest: vcs1 [135.874654] Dynamic subtest vcs1: SUCCESS (0.001s) [135.882908] Starting dynamic subtest: vecs0 [135.884188] Dynamic subtest vecs0: SUCCESS (0.000s) [135.892232] Starting dynamic subtest: vecs1 [135.893398] Dynamic subtest vecs1: SUCCESS (0.000s) [135.901609] Starting dynamic subtest: ccs0 [135.902804] Dynamic subtest ccs0: SUCCESS (0.000s) [135.903799] Subtest init-busy: SUCCESS (0.008s) [136.024550] [010/132] (934s left) syncobj_timeline (signal-point-0) [136.103011] Starting subtest: signal-point-0 [136.103917] Subtest signal-point-0: SUCCESS (0.000s) [136.282999] [011/132] (934s left) perf (invalid-remove-userspace-config) [136.704533] Starting subtest: invalid-remove-userspace-config [136.713231] Subtest invalid-remove-userspace-config: SUCCESS (0.009s) [136.793075] [012/132] (933s left) kms_vrr (flip-basic-fastset) [136.978454] Starting subtest: flip-basic-fastset [136.981144] Subtest flip-basic-fastset: SKIP (0.000s) [137.136192] [013/132] (933s left) kms_psr (psr-sprite-blt) [137.321895] Subtest psr-sprite-blt: SKIP (0.000s) [137.381478] [014/132] (933s left) gem_exec_schedule (pi-common) [137.628304] Starting subtest: pi-common [137.630079] Starting dynamic subtest: rcs0 [137.671459] Dynamic subtest rcs0: SUCCESS (0.043s) [137.680815] Starting dynamic subtest: bcs0 [137.700427] Dynamic subtest bcs0: SUCCESS (0.028s) [137.709431] Starting dynamic subtest: vcs0 [137.730400] Dynamic subtest vcs0: SUCCESS (0.030s) [137.739079] Starting dynamic subtest: vcs1 [137.760682] Dynamic subtest vcs1: SUCCESS (0.030s) [137.769333] Starting dynamic subtest: vecs0 [137.790405] Dynamic subtest vecs0: SUCCESS (0.029s) [137.799375] Starting dynamic subtest: vecs1 [137.818530] Dynamic subtest vecs1: SUCCESS (0.028s) [137.827534] Starting dynamic subtest: ccs0 [137.847883] Dynamic subtest ccs0: SUCCESS (0.029s) [137.848876] Subtest pi-common: SUCCESS (0.221s) [138.171458] [015/132] (932s left) kms_prop_blob (blob-prop-validate) [138.253161] Starting subtest: blob-prop-validate [138.253976] Subtest blob-prop-validate: SUCCESS (0.000s) [138.436772] [016/132] (932s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [138.631181] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [141.372863] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.742s) [141.586293] [017/132] (929s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [141.774168] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [142.862560] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.088s) [143.161592] [018/132] (928s left) perf_pmu (interrupts) [143.232291] Starting subtest: interrupts [144.346247] Subtest interrupts: SUCCESS (1.114s) [144.523567] [019/132] (926s left) kms_psr (psr2-primary-mmap-cpu) [144.713307] Subtest psr2-primary-mmap-cpu: SKIP (0.000s) [144.770570] [020/132] (926s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [144.851493] Starting subtest: wait-all-for-submit-delayed-submit [144.956126] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s) [145.140839] [021/132] (926s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [145.341190] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [145.403102] [022/132] (926s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [145.586524] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [145.587434] Starting dynamic subtest: pipe-A-DP-3 [145.608832] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [145.617993] Starting dynamic subtest: pipe-B-DP-3 [145.639250] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [145.648528] Starting dynamic subtest: pipe-C-DP-3 [145.675070] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [145.684196] Starting dynamic subtest: pipe-D-DP-3 [145.706693] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [145.708158] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.013s) [146.110520] [023/132] (925s left) gem_exec_balancer (nop) [146.199625] Starting subtest: nop [195.887454] Subtest nop: SUCCESS (49.686s) [196.281198] [024/132] (875s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [196.481682] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [196.497106] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.014s) [196.666708] [025/132] (874s left) core_sysfs (read-all-entries) [196.743278] Starting subtest: read-all-entries [196.798726] Subtest read-all-entries: SUCCESS (0.055s) [196.960204] [026/132] (874s left) i915_drm_fdinfo (virtual-busy-hang-all) [197.030946] Starting subtest: virtual-busy-hang-all [197.032811] Subtest virtual-busy-hang-all: SKIP (0.000s) [197.197410] [027/132] (874s left) gem_pxp (fail-invalid-protected-context) [199.803460] Starting subtest: fail-invalid-protected-context [199.805582] Subtest fail-invalid-protected-context: SKIP (0.000s) [199.943295] [028/132] (871s left) kms_color (invalid-degamma-lut-sizes) [200.130058] Starting subtest: invalid-degamma-lut-sizes [200.130908] Starting dynamic subtest: pipe-A [200.205343] Dynamic subtest pipe-A: SUCCESS (0.076s) [200.216107] Starting dynamic subtest: pipe-B [200.217056] Dynamic subtest pipe-B: SUCCESS (0.001s) [200.227450] Starting dynamic subtest: pipe-C [200.228365] Dynamic subtest pipe-C: SUCCESS (0.001s) [200.237599] Starting dynamic subtest: pipe-D [200.238487] Dynamic subtest pipe-D: SUCCESS (0.001s) [200.239424] Subtest invalid-degamma-lut-sizes: SUCCESS (0.081s) [200.463939] [029/132] (871s left) gem_create (create-ext-cpu-access-big) [200.663761] Starting subtest: create-ext-cpu-access-big [203.154891] Subtest create-ext-cpu-access-big: FAIL (2.186s) [203.472682] [030/132] (868s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [203.663398] Starting subtest: fbc-rgb101010-draw-pwrite [206.550628] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (2.887s) [206.729351] [031/132] (865s left) kms_big_fb (x-tiled-8bpp-rotate-270) [206.929063] Starting subtest: x-tiled-8bpp-rotate-270 [206.985375] Subtest x-tiled-8bpp-rotate-270: SKIP (0.055s) [207.232461] [032/132] (864s left) gem_softpin (safe-alignment) [207.326492] Starting subtest: safe-alignment [207.388011] Subtest safe-alignment: SUCCESS (0.061s) [207.596322] [033/132] (864s left) gem_exec_schedule (semaphore-codependency) [207.688289] Starting subtest: semaphore-codependency [207.730468] Subtest semaphore-codependency: SUCCESS (0.042s) [208.183738] [034/132] (864s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [208.371432] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [208.373133] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [208.564284] [035/132] (863s left) kms_sequence (queue-idle) [208.745912] Starting subtest: queue-idle [208.746829] Starting dynamic subtest: pipe-A-DP-3 [211.122764] Dynamic subtest pipe-A-DP-3: SUCCESS (2.376s) [211.134030] Starting dynamic subtest: pipe-B-DP-3 [213.423992] Dynamic subtest pipe-B-DP-3: SUCCESS (2.299s) [213.434061] Starting dynamic subtest: pipe-C-DP-3 [215.712549] Dynamic subtest pipe-C-DP-3: SUCCESS (2.288s) [215.722194] Starting dynamic subtest: pipe-D-DP-3 [218.005744] Dynamic subtest pipe-D-DP-3: SUCCESS (2.292s) [218.006612] Subtest queue-idle: SUCCESS (9.260s) [218.333808] [036/132] (854s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [218.519938] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [218.520902] Starting dynamic subtest: pipe-A-valid-mode [218.612058] Dynamic subtest pipe-A-valid-mode: SKIP (0.090s) [218.613959] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.091s) [218.869493] [037/132] (853s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [219.064601] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [219.066277] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [219.253800] [038/132] (853s left) kms_flip (flip-vs-expired-vblank-interruptible) [219.444279] Starting subtest: flip-vs-expired-vblank-interruptible [219.448740] Starting dynamic subtest: A-DP3 [227.257405] Dynamic subtest A-DP3: SUCCESS (7.808s) [227.270604] Starting dynamic subtest: B-DP3 [235.005438] Dynamic subtest B-DP3: SUCCESS (7.747s) [235.016411] Starting dynamic subtest: C-DP3 [240.482257] Dynamic subtest C-DP3: FAIL (5.290s) [240.492394] Starting dynamic subtest: D-DP3 [248.057721] Dynamic subtest D-DP3: SUCCESS (7.759s) [248.065354] Subtest flip-vs-expired-vblank-interruptible: FAIL (28.620s) [248.439214] [039/132] (824s left) gem_ctx_persistence (smoketest) [248.524192] Starting subtest: smoketest [287.241396] Subtest smoketest: SUCCESS (38.717s) [287.431680] [040/132] (785s left) kms_cursor_crc (cursor-onscreen-256x85) [287.867130] Starting subtest: cursor-onscreen-256x85 [287.871611] Starting dynamic subtest: pipe-A-DP-3 [290.672160] Dynamic subtest pipe-A-DP-3: SUCCESS (2.800s) [290.723140] Starting dynamic subtest: pipe-D-DP-3 [293.402917] Dynamic subtest pipe-D-DP-3: SUCCESS (2.689s) [293.403919] Subtest cursor-onscreen-256x85: SUCCESS (5.536s) [293.776246] [041/132] (779s left) gem_flink_basic (double-flink) [293.864418] Starting subtest: double-flink [293.865300] Subtest double-flink: SUCCESS (0.000s) [294.072293] [042/132] (778s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [294.258778] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [294.260413] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [294.454591] [043/132] (778s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [294.656202] Starting subtest: extended-modeset-hang-oldfb-with-reset [294.658215] Starting dynamic subtest: pipe-A [305.517583] Dynamic subtest pipe-A: SUCCESS (10.860s) [305.532509] Starting dynamic subtest: pipe-D [316.246872] Dynamic subtest pipe-D: SUCCESS (10.724s) [316.247950] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.590s) [316.571877] [044/132] (756s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [316.761450] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [316.763633] Starting dynamic subtest: pipe-A-DP-3 [316.771937] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [316.782239] Starting dynamic subtest: pipe-B-DP-3 [316.790674] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [316.800969] Starting dynamic subtest: pipe-C-DP-3 [316.809179] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [316.819602] Starting dynamic subtest: pipe-D-DP-3 [316.830540] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [316.832544] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.008s) [317.246798] [045/132] (756s left) i915_selftest (live) [318.724323] Starting subtest: live [318.725263] Starting dynamic subtest: sanitycheck [320.323105] Dynamic subtest sanitycheck: SUCCESS (1.598s) [320.331835] Starting dynamic subtest: uncore [321.946018] Dynamic subtest uncore: SUCCESS (1.622s) [321.954532] Starting dynamic subtest: workarounds [337.963213] Dynamic subtest workarounds: FAIL (15.816s) [337.970366] Starting dynamic subtest: gt_engines [340.147893] Dynamic subtest gt_engines: SUCCESS (2.383s) [340.156801] Starting dynamic subtest: gt_timelines [359.686040] Dynamic subtest gt_timelines: SUCCESS (19.537s) [359.697173] Starting dynamic subtest: gt_contexts [361.348886] Dynamic subtest gt_contexts: SUCCESS (1.662s) [361.358929] Starting dynamic subtest: gt_lrc [367.733953] Dynamic subtest gt_lrc: SUCCESS (6.384s) [367.743706] Starting dynamic subtest: gt_mocs [370.637873] Dynamic subtest gt_mocs: SUCCESS (2.903s) [370.647153] Starting dynamic subtest: gt_pm [374.879961] Dynamic subtest gt_pm: SUCCESS (4.241s) [374.889148] Starting dynamic subtest: gt_heartbeat [376.515888] Dynamic subtest gt_heartbeat: SUCCESS (1.635s) [376.527606] Starting dynamic subtest: gt_tlb [389.153053] Dynamic subtest gt_tlb: SUCCESS (12.635s) [389.163715] Starting dynamic subtest: requests [402.828895] Dynamic subtest requests: SUCCESS (13.674s) [402.837487] Starting dynamic subtest: migrate [408.260222] Dynamic subtest migrate: SUCCESS (5.430s) [408.272360] Starting dynamic subtest: active [409.876627] Dynamic subtest active: SUCCESS (1.606s) [409.884920] Starting dynamic subtest: objects [412.227125] Dynamic subtest objects: SUCCESS (2.358s) [412.238804] Starting dynamic subtest: mman [418.961868] Dynamic subtest mman: SUCCESS (6.733s) [418.970205] Starting dynamic subtest: dmabuf [420.620866] Dynamic subtest dmabuf: SUCCESS (1.658s) [420.629661] Starting dynamic subtest: vma [422.246895] Dynamic subtest vma: SUCCESS (1.625s) [422.256436] Starting dynamic subtest: coherency [426.082992] Dynamic subtest coherency: SUCCESS (3.835s) [426.092062] Starting dynamic subtest: gtt [436.203102] Dynamic subtest gtt: SUCCESS (10.119s) [436.213816] Starting dynamic subtest: gem [438.012901] Dynamic subtest gem: SUCCESS (1.808s) [438.021845] Starting dynamic subtest: evict [441.045943] Dynamic subtest evict: SUCCESS (3.032s) [441.055575] Starting dynamic subtest: hugepages [459.448045] Dynamic subtest hugepages: SUCCESS (18.400s) [459.457139] Starting dynamic subtest: gem_contexts [480.936907] Dynamic subtest gem_contexts: FAIL (21.281s) [480.944201] Starting dynamic subtest: client [482.420124] Dynamic subtest client: SUCCESS (1.688s) [482.430520] Starting dynamic subtest: gem_migrate [486.000912] Dynamic subtest gem_migrate: SUCCESS (3.579s) [486.011173] Starting dynamic subtest: reset [487.734892] Dynamic subtest reset: SUCCESS (1.733s) [487.743517] Starting dynamic subtest: memory_region [490.952018] Dynamic subtest memory_region: SUCCESS (3.216s) [490.960506] Starting dynamic subtest: hangcheck [520.458120] Dynamic subtest hangcheck: SUCCESS (29.505s) [520.467506] Starting dynamic subtest: execlists [522.088950] Dynamic subtest execlists: SUCCESS (1.629s) [522.099377] Starting dynamic subtest: ring_submission [523.696999] Dynamic subtest ring_submission: SUCCESS (1.607s) [523.707713] Starting dynamic subtest: perf [525.474108] Dynamic subtest perf: SUCCESS (1.776s) [525.483162] Starting dynamic subtest: slpc [532.784159] Dynamic subtest slpc: SUCCESS (7.309s) [532.795985] Starting dynamic subtest: guc [535.716039] Dynamic subtest guc: SUCCESS (2.930s) [535.725582] Starting dynamic subtest: guc_multi_lrc [537.340847] Dynamic subtest guc_multi_lrc: SUCCESS (1.623s) [537.350387] Starting dynamic subtest: guc_hang [539.784400] Dynamic subtest guc_hang: SUCCESS (2.442s) [539.798179] Starting dynamic subtest: late_gt_pm [541.413779] Dynamic subtest late_gt_pm: SUCCESS (1.627s) [541.414728] Subtest live: FAIL (222.687s) [541.448440] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [541.449484] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [541.451594] [046/132] (531s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [543.208189] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [543.209966] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [543.412547] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [543.414856] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true [543.417461] [047/132] (529s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [543.607913] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [543.609556] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [543.816730] [048/132] (529s left) perf (polling) [544.224993] Starting subtest: polling [544.225875] Starting dynamic subtest: 0-rcs0 [554.243452] Dynamic subtest 0-rcs0: SUCCESS (10.018s) [554.244438] Subtest polling: SUCCESS (10.020s) [554.299345] [049/132] (519s left) kms_flip (plain-flip-fb-recreate) [554.489700] Starting subtest: plain-flip-fb-recreate [554.494374] Starting dynamic subtest: A-DP3 [562.647108] Dynamic subtest A-DP3: SUCCESS (8.144s) [562.683866] Starting dynamic subtest: B-DP3 [570.726442] Dynamic subtest B-DP3: SUCCESS (8.080s) [570.768629] Starting dynamic subtest: C-DP3 [578.813518] Dynamic subtest C-DP3: SUCCESS (8.081s) [578.851203] Starting dynamic subtest: D-DP3 [586.900137] Dynamic subtest D-DP3: SUCCESS (8.080s) [586.908532] Subtest plain-flip-fb-recreate: SUCCESS (32.417s) [587.324815] [050/132] (486s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [587.517973] Starting subtest: cursor-vs-flip-atomic-transitions [618.909229] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (31.390s) [619.198892] [051/132] (454s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render) [619.395939] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render [621.671189] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (2.276s) [621.855137] [052/132] (451s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [622.044861] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [622.046525] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [622.247412] [053/132] (451s left) gem_flink_basic (flink-lifetime) [622.328676] Starting subtest: flink-lifetime [622.361373] Subtest flink-lifetime: SUCCESS (0.034s) [622.572456] [054/132] (451s left) gem_exec_reloc (basic-cpu-read-noreloc) [622.658203] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [622.751502] [055/132] (451s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [622.848926] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [622.849847] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [623.058871] [056/132] (451s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [623.146224] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [623.148225] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [623.406056] [057/132] (450s left) kms_mmap_write_crc (main) [623.607280] Starting subtest: main [623.608203] Starting dynamic subtest: pipe-A-DP-3 [627.398823] Dynamic subtest pipe-A-DP-3: SUCCESS (3.790s) [627.399883] Subtest main: SUCCESS (3.792s) [627.740363] [058/132] (446s left) gem_exec_whisper (basic-queues-all) [627.832295] Starting subtest: basic-queues-all [649.634057] Subtest basic-queues-all: SUCCESS (21.800s) [649.929180] [059/132] (424s left) kms_psr (fbc-pr-sprite-mmap-cpu) [650.121469] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [650.179156] [060/132] (424s left) kms_cursor_legacy (flip-vs-cursor-atomic) [650.369421] Starting subtest: flip-vs-cursor-atomic [660.530695] Subtest flip-vs-cursor-atomic: SUCCESS (10.162s) [660.838373] [061/132] (413s left) api_intel_bb (simple-bb) [660.914527] Starting subtest: simple-bb [660.942237] Subtest simple-bb: SUCCESS (0.028s) [661.170587] [062/132] (413s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [661.254282] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [661.344905] [063/132] (413s left) kms_invalid_mode (bad-vsync-end) [661.527650] Starting subtest: bad-vsync-end [661.528506] Starting dynamic subtest: pipe-A-DP-3 [661.603434] Dynamic subtest pipe-A-DP-3: SUCCESS (0.075s) [661.617225] Starting dynamic subtest: pipe-B-DP-3 [661.618498] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s) [661.630460] Starting dynamic subtest: pipe-C-DP-3 [661.631586] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s) [661.642938] Starting dynamic subtest: pipe-D-DP-3 [661.643889] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s) [661.644829] Subtest bad-vsync-end: SUCCESS (0.085s) [661.891344] [064/132] (412s left) kms_addfb_basic (framebuffer-vs-set-tiling) [661.970637] Starting subtest: framebuffer-vs-set-tiling [661.972322] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [662.272133] [065/132] (412s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [662.461267] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [662.462165] Starting dynamic subtest: pipe-A-valid-mode [664.873389] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.410s) [664.874811] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (2.413s) [665.185448] [066/132] (409s left) gem_lmem_swapping (verify-ccs) [667.958657] Starting subtest: verify-ccs [667.959403] Starting dynamic subtest: lmem0 [713.823302] Dynamic subtest lmem0: SUCCESS (45.864s) [713.824242] Subtest verify-ccs: SUCCESS (45.865s) [715.694280] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [715.695626] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true [715.697864] [067/132] (359s left) vgem_basic (bad-flag) [715.736391] Starting subtest: bad-flag [715.737270] Subtest bad-flag: SUCCESS (0.000s) [715.767830] [068/132] (359s left) kms_big_fb (linear-32bpp-rotate-180) [717.550084] Starting subtest: linear-32bpp-rotate-180 [719.554726] Subtest linear-32bpp-rotate-180: SUCCESS (2.003s) [719.800888] [FACT kms_big_fb (linear-32bpp-rotate-180)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [719.803278] [FACT kms_big_fb (linear-32bpp-rotate-180)] new: kernel.kmod_is_loaded.i915: true [719.806186] [069/132] (355s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [719.928656] Subtest writes-after-reads: SKIP (0.000s) [719.997624] [070/132] (355s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [720.194216] Starting subtest: fbc-rgb101010-draw-mmap-gtt [720.195879] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [720.397298] [071/132] (354s left) gem_ctx_bad_destroy (double-destroy) [720.484866] Starting subtest: double-destroy [720.485784] Subtest double-destroy: SUCCESS (0.000s) [720.634159] [072/132] (354s left) kms_chamelium_color (ctm-blue-to-red) [720.827440] Subtest ctm-blue-to-red: SKIP (0.000s) [720.881949] [073/132] (354s left) kms_psr (fbc-psr-cursor-mmap-cpu) [721.070593] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s) [721.132834] [074/132] (354s left) i915_drm_fdinfo (isolation) [721.203755] Starting subtest: isolation [721.204600] Starting dynamic subtest: rcs0 [721.232274] Dynamic subtest rcs0: SKIP (0.027s) [721.242549] Starting dynamic subtest: bcs0 [721.244509] Dynamic subtest bcs0: SKIP (0.000s) [721.254756] Starting dynamic subtest: vcs0 [721.256807] Dynamic subtest vcs0: SKIP (0.000s) [721.267057] Starting dynamic subtest: vcs1 [721.269039] Dynamic subtest vcs1: SKIP (0.000s) [721.279388] Starting dynamic subtest: vecs0 [721.281771] Dynamic subtest vecs0: SKIP (0.000s) [721.291503] Starting dynamic subtest: vecs1 [721.293781] Dynamic subtest vecs1: SKIP (0.000s) [721.303581] Starting dynamic subtest: ccs0 [721.305907] Dynamic subtest ccs0: SKIP (0.000s) [721.308369] Subtest isolation: SKIP (0.037s) [721.370528] [075/132] (354s left) gem_ctx_sseu (invalid-args) [721.457456] Subtest invalid-args: SKIP (0.000s) [721.552930] [076/132] (353s left) gen9_exec_parse (allowed-all) [721.638766] Subtest allowed-all: SKIP (0.000s) [721.716270] [077/132] (353s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [721.916731] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [721.981946] [078/132] (353s left) kms_chamelium_frames (dp-crc-multiple) [722.250359] Subtest dp-crc-multiple: SKIP (0.000s) [722.402167] [079/132] (353s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [722.589935] Starting subtest: plane-downscale-factor-0-5-with-modifiers [722.590862] Starting dynamic subtest: pipe-A [723.145163] Dynamic subtest pipe-A: SUCCESS (0.555s) [723.163170] Starting dynamic subtest: pipe-B [723.792521] Dynamic subtest pipe-B: SUCCESS (0.645s) [723.816994] Starting dynamic subtest: pipe-C [724.439388] Dynamic subtest pipe-C: SUCCESS (0.645s) [724.463029] Starting dynamic subtest: pipe-D [725.085690] Dynamic subtest pipe-D: SUCCESS (0.644s) [725.086998] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.497s) [725.434596] [080/132] (350s left) kms_big_fb (y-tiled-8bpp-rotate-270) [725.640229] Starting subtest: y-tiled-8bpp-rotate-270 [725.642027] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [725.850444] [081/132] (349s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [726.043960] Starting subtest: psr-rgb565-draw-blt [726.045576] Subtest psr-rgb565-draw-blt: SKIP (0.000s) [726.251545] [082/132] (349s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [726.443351] Starting subtest: cursorB-vs-flipA-atomic-transitions [726.445145] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s) [726.599321] [083/132] (349s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt) [726.794969] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt [726.796537] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [727.001158] [084/132] (349s left) kms_big_fb (4-tiled-addfb) [727.198546] Starting subtest: 4-tiled-addfb [727.199428] Subtest 4-tiled-addfb: SUCCESS (0.001s) [727.402690] [085/132] (348s left) kms_chamelium_hpd (dp-hpd-storm-disable) [727.678491] Subtest dp-hpd-storm-disable: SKIP (0.000s) [727.835292] [086/132] (348s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [728.044176] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [728.045896] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [728.243887] [087/132] (348s left) gem_mmap_gtt (big-bo-tiledy) [728.324165] Subtest big-bo-tiledY: SKIP (0.000s) [728.388037] [088/132] (347s left) gem_ctx_persistence (engines-hang) [728.476568] Starting subtest: engines-hang [728.477438] Starting dynamic subtest: rcs0 [728.643404] Dynamic subtest rcs0: SUCCESS (0.165s) [728.689219] Starting dynamic subtest: bcs0 [728.690390] Dynamic subtest bcs0: SUCCESS (0.040s) [728.703417] Starting dynamic subtest: vcs0 [728.784210] Dynamic subtest vcs0: SUCCESS (0.094s) [728.828908] Starting dynamic subtest: vcs1 [728.839308] Dynamic subtest vcs1: SUCCESS (0.051s) [728.856646] Starting dynamic subtest: vecs0 [728.940250] Dynamic subtest vecs0: SUCCESS (0.098s) [728.983891] Starting dynamic subtest: vecs1 [728.994256] Dynamic subtest vecs1: SUCCESS (0.050s) [729.011716] Starting dynamic subtest: ccs0 [729.045317] Dynamic subtest ccs0: SUCCESS (0.049s) [729.046334] Subtest engines-hang: SUCCESS (0.569s) [729.260562] [089/132] (347s left) prime_self_import (export-vs-gem_close-race) [729.308993] Starting subtest: export-vs-gem_close-race [734.397247] Subtest export-vs-gem_close-race: SUCCESS (5.089s) [734.614018] [090/132] (341s left) kms_big_fb (4-tiled-16bpp-rotate-0) [734.814675] Starting subtest: 4-tiled-16bpp-rotate-0 [736.561913] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.746s) [736.776651] [091/132] (339s left) drm_read (short-buffer-block) [737.045015] Starting subtest: short-buffer-block [737.045968] Subtest short-buffer-block: SUCCESS (0.000s) [737.325861] [092/132] (339s left) sriov_basic (bind-unbind-vf) [737.404210] Subtest bind-unbind-vf: SKIP (0.000s) [737.471761] [093/132] (339s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [737.555490] Starting subtest: multi-wait-all-available-submitted-signaled [737.556411] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s) [737.765777] [094/132] (339s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [738.003555] Starting subtest: cursor-tearing-framebuffer-change [738.005920] Starting dynamic subtest: pipe-A-DP-3 [738.495741] Dynamic subtest pipe-A-DP-3: SUCCESS (0.488s) [738.518314] Starting dynamic subtest: pipe-D-DP-3 [738.953098] Dynamic subtest pipe-D-DP-3: SUCCESS (0.454s) [738.957141] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.950s) [739.597290] [095/132] (337s left) gem_mmap_wc (write-wc-read-gtt) [739.676226] Subtest write-wc-read-gtt: SKIP (0.000s) [739.740235] [096/132] (337s left) kms_flip (bo-too-big-interruptible) [739.931424] Starting subtest: bo-too-big-interruptible [739.936288] Starting dynamic subtest: A-DP3 [740.227493] Dynamic subtest A-DP3: SUCCESS (0.290s) [740.270551] Starting dynamic subtest: B-DP3 [740.470708] Dynamic subtest B-DP3: SUCCESS (0.238s) [740.509141] Starting dynamic subtest: C-DP3 [740.716935] Dynamic subtest C-DP3: SUCCESS (0.243s) [740.755928] Starting dynamic subtest: D-DP3 [740.958754] Dynamic subtest D-DP3: SUCCESS (0.238s) [740.964245] Subtest bo-too-big-interruptible: SUCCESS (1.032s) [741.387839] [097/132] (335s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [741.584987] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [744.404679] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.820s) [744.638091] [098/132] (332s left) gem_mmap_gtt (ptrace) [744.719160] Subtest ptrace: SKIP (0.000s) [744.806986] [099/132] (332s left) gem_exec_gttfill (engines) [744.904512] Starting subtest: engines [744.905443] Starting dynamic subtest: rcs0 [770.993574] Dynamic subtest rcs0: SUCCESS (26.085s) [771.004487] Starting dynamic subtest: bcs0 [797.157594] Dynamic subtest bcs0: SUCCESS (26.165s) [797.170153] Starting dynamic subtest: vcs0 [823.283422] Dynamic subtest vcs0: SUCCESS (26.124s) [823.295029] Starting dynamic subtest: vcs1 [849.422738] Dynamic subtest vcs1: SUCCESS (26.138s) [849.433903] Starting dynamic subtest: vecs0 [875.658036] Dynamic subtest vecs0: SUCCESS (26.234s) [875.669577] Starting dynamic subtest: vecs1 [901.893471] Dynamic subtest vecs1: SUCCESS (26.234s) [901.906557] Starting dynamic subtest: ccs0 [928.258950] Dynamic subtest ccs0: SUCCESS (26.364s) [928.259939] Subtest engines: SUCCESS (183.352s) [928.551272] [100/132] (148s left) gem_ppgtt (blt-vs-render-ctx0) [928.684192] Starting subtest: blt-vs-render-ctx0 [961.613138] Subtest blt-vs-render-ctx0: SUCCESS (32.928s) [961.850780] [101/132] (115s left) dumb_buffer (map-valid) [961.977795] Starting subtest: map-valid [961.978844] Subtest map-valid: SUCCESS (0.000s) [962.144797] [102/132] (115s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [962.345562] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [962.347271] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [962.539969] [103/132] (114s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [962.742437] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [962.744200] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [962.928370] [104/132] (114s left) prime_busy (after) [963.018295] Starting subtest: after [963.023395] Starting dynamic subtest: rcs0 [963.075147] Dynamic subtest rcs0: SUCCESS (0.052s) [963.088122] Starting dynamic subtest: bcs0 [963.113591] Dynamic subtest bcs0: SUCCESS (0.037s) [963.126477] Starting dynamic subtest: vcs0 [963.153473] Dynamic subtest vcs0: SUCCESS (0.039s) [963.167501] Starting dynamic subtest: vcs1 [963.193114] Dynamic subtest vcs1: SUCCESS (0.038s) [963.210745] Starting dynamic subtest: vecs0 [963.232510] Dynamic subtest vecs0: SUCCESS (0.038s) [963.250143] Starting dynamic subtest: vecs1 [963.272222] Dynamic subtest vecs1: SUCCESS (0.038s) [963.290042] Starting dynamic subtest: ccs0 [963.312582] Dynamic subtest ccs0: SUCCESS (0.039s) [963.422228] Subtest after: SUCCESS (0.402s) [963.642679] [105/132] (114s left) gem_exec_store (cachelines) [963.737531] Starting subtest: cachelines [963.738477] Starting dynamic subtest: rcs0 [963.841545] Dynamic subtest rcs0: SUCCESS (0.103s) [963.860108] Starting dynamic subtest: bcs0 [963.900100] Dynamic subtest bcs0: SUCCESS (0.056s) [963.917375] Starting dynamic subtest: vcs0 [963.955610] Dynamic subtest vcs0: SUCCESS (0.052s) [963.977637] Starting dynamic subtest: vcs1 [964.012386] Dynamic subtest vcs1: SUCCESS (0.055s) [964.052853] Starting dynamic subtest: vecs0 [964.083542] Dynamic subtest vecs0: SUCCESS (0.068s) [964.102874] Starting dynamic subtest: vecs1 [964.137764] Dynamic subtest vecs1: SUCCESS (0.052s) [964.175917] Starting dynamic subtest: ccs0 [964.209875] Dynamic subtest ccs0: SUCCESS (0.069s) [964.213930] Subtest cachelines: SUCCESS (0.474s) [964.528791] [106/132] (113s left) gem_exec_reloc (basic-wc) [964.618176] Subtest basic-wc: SKIP (0.000s) [964.694884] [107/132] (113s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [964.781608] Starting subtest: multi-wait-for-submit-submitted-signaled [964.782484] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [964.963456] [108/132] (112s left) kms_hdr (bpc-switch-suspend) [965.150974] Starting subtest: bpc-switch-suspend [968.452920] Starting dynamic subtest: pipe-A-DP-3 [988.870723] Dynamic subtest pipe-A-DP-3: SUCCESS (5.048s) [988.871650] Subtest bpc-switch-suspend: SUCCESS (8.350s) [989.230802] [109/132] ( 88s left) kms_pm_dc (dc5-dpms) [990.451071] Starting subtest: dc5-dpms [991.863162] Subtest dc5-dpms: SUCCESS (1.412s) [991.998258] [110/132] ( 86s left) api_intel_allocator (execbuf-with-allocator) [992.076583] Starting subtest: execbuf-with-allocator [992.106608] Subtest execbuf-with-allocator: SUCCESS (0.030s) [992.335418] [111/132] ( 85s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [992.528725] Starting subtest: fbcpsr-stridechange [992.530447] Subtest fbcpsr-stridechange: SKIP (0.000s) [992.726173] [112/132] ( 85s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [992.930215] Starting subtest: yf-tiled-32bpp-rotate-90 [992.931803] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [993.144193] [113/132] ( 85s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [993.339475] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [993.341168] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [993.525238] [114/132] ( 84s left) gem_exec_balancer (parallel-keep-submit-fence) [993.888617] Starting subtest: parallel-keep-submit-fence [996.390598] Subtest parallel-keep-submit-fence: SUCCESS (2.502s) [996.534019] [115/132] ( 81s left) kms_cursor_crc (cursor-size-change) [996.723726] Starting subtest: cursor-size-change [996.724619] Starting dynamic subtest: pipe-A-DP-3 [997.611679] Dynamic subtest pipe-A-DP-3: SUCCESS (0.885s) [997.627211] Starting dynamic subtest: pipe-D-DP-3 [998.407643] Dynamic subtest pipe-D-DP-3: SUCCESS (0.792s) [998.408682] Subtest cursor-size-change: SUCCESS (1.685s) [999.063480] [116/132] ( 79s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [999.151758] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [999.152663] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [999.362751] [117/132] ( 79s left) gem_exec_reloc (basic-write-gtt-active) [999.457665] Subtest basic-write-gtt-active: SKIP (0.000s) [999.575662] [118/132] ( 79s left) syncobj_basic (test-valid-cycle) [999.653960] Starting subtest: test-valid-cycle [999.654898] Subtest test-valid-cycle: SUCCESS (0.000s) [999.863136] [119/132] ( 78s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [1000.056651] Starting subtest: crc-primary-suspend-yf-tiled-ccs [1000.057550] Starting dynamic subtest: pipe-A-DP-3 [1000.060971] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [1000.074691] Starting dynamic subtest: pipe-B-DP-3 [1000.078234] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [1000.091777] Starting dynamic subtest: pipe-C-DP-3 [1000.095377] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [1000.108984] Starting dynamic subtest: pipe-D-DP-3 [1000.112397] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [1000.114383] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.008s) [1000.555597] [120/132] ( 78s left) gem_unfence_active_buffers [1000.809056] [121/132] ( 78s left) kms_universal_plane (disable-primary-vs-flip) [1001.000512] Starting subtest: disable-primary-vs-flip [1001.001423] Starting dynamic subtest: pipe-A-DP-3 [1001.591561] Dynamic subtest pipe-A-DP-3: SUCCESS (0.591s) [1001.610281] Starting dynamic subtest: pipe-B-DP-3 [1002.077626] Dynamic subtest pipe-B-DP-3: SUCCESS (0.483s) [1002.092376] Starting dynamic subtest: pipe-C-DP-3 [1002.534049] Dynamic subtest pipe-C-DP-3: SUCCESS (0.455s) [1002.556188] Starting dynamic subtest: pipe-D-DP-3 [1003.014670] Dynamic subtest pipe-D-DP-3: SUCCESS (0.477s) [1003.015563] Subtest disable-primary-vs-flip: SUCCESS (2.014s) [1003.267532] [122/132] ( 75s left) kms_addfb_basic (invalid-set-prop) [1003.347937] Starting subtest: invalid-set-prop [1003.348779] Subtest invalid-set-prop: SUCCESS (0.000s) [1003.642384] [123/132] ( 75s left) kms_psr (pr-primary-mmap-gtt) [1003.828810] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [1003.887275] [124/132] ( 75s left) kms_cursor_legacy (torture-move) [1004.078646] Starting subtest: torture-move [1004.079519] Starting dynamic subtest: pipe-A [1009.577529] Dynamic subtest pipe-A: SUCCESS (5.499s) [1009.591027] Starting dynamic subtest: pipe-B [1015.561781] Dynamic subtest pipe-B: SUCCESS (5.983s) [1015.574631] Starting dynamic subtest: pipe-C [1021.067429] Dynamic subtest pipe-C: SUCCESS (5.504s) [1021.080708] Starting dynamic subtest: pipe-D [1026.565203] Dynamic subtest pipe-D: SUCCESS (5.495s) [1026.581122] Starting dynamic subtest: all-pipes [1032.179712] Dynamic subtest all-pipes: SUCCESS (5.613s) [1032.180623] Subtest torture-move: SUCCESS (28.099s) [1032.345514] [125/132] ( 46s left) i915_pm_rpm (debugfs-forcewake-user) [1034.375168] Starting subtest: debugfs-forcewake-user [1045.100561] Subtest debugfs-forcewake-user: SUCCESS (10.724s) [1045.473554] [126/132] ( 33s left) gem_exec_fence (syncobj-timeline-invalid-flags) [1046.162140] Starting subtest: syncobj-timeline-invalid-flags [1046.163187] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [1046.473902] [127/132] ( 32s left) gem_userptr_blits (process-exit) [1046.566837] Starting subtest: process-exit [1046.576238] Subtest process-exit: SUCCESS (0.009s) [1046.816867] [128/132] ( 32s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [1046.897713] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [1047.000697] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.102s) [1047.188620] [129/132] ( 32s left) gem_userptr_blits (input-checking) [1047.278659] Starting subtest: input-checking [1047.279544] Subtest input-checking: SUCCESS (0.000s) [1047.477006] [130/132] ( 32s left) kms_content_protection (lic-type-0-hdcp14) [1047.735510] Starting subtest: lic-type-0-hdcp14 [1047.771369] Starting dynamic subtest: pipe-A-DP-3 [1168.618174] Dynamic subtest pipe-A-DP-3: FAIL (120.674s) [1168.619723] Subtest lic-type-0-hdcp14: FAIL (120.812s) [1168.865356] Overall timeout time exceeded, stopping. [1168.899287] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_pm_rpm results: parsing output: 2/ for test: kms_plane_scaling results: parsing output: 3/ for test: kms_cursor_crc results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: kms_ccs results: parsing output: 6/ for test: kms_plane_multiple results: parsing output: 7/ for test: gem_wait results: parsing output: 8/ for test: perf_pmu results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: perf results: parsing output: 11/ for test: kms_vrr results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: gem_exec_schedule results: parsing output: 14/ for test: kms_prop_blob results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_cursor_legacy results: parsing output: 17/ for test: perf_pmu results: parsing output: 18/ for test: kms_psr results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: kms_psr2_sf results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: gem_exec_balancer results: parsing output: 23/ for test: kms_flip results: parsing output: 24/ for test: core_sysfs results: parsing output: 25/ for test: i915_drm_fdinfo results: parsing output: 26/ for test: gem_pxp results: parsing output: 27/ for test: kms_color results: parsing output: 28/ for test: gem_create results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_big_fb results: parsing output: 31/ for test: gem_softpin results: parsing output: 32/ for test: gem_exec_schedule results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_sequence results: parsing output: 35/ for test: kms_flip_scaled_crc results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_flip results: parsing output: 38/ for test: gem_ctx_persistence results: parsing output: 39/ for test: kms_cursor_crc results: parsing output: 40/ for test: gem_flink_basic results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_busy results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: i915_selftest results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: perf results: parsing output: 48/ for test: kms_flip results: parsing output: 49/ for test: kms_cursor_legacy results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_flink_basic results: parsing output: 53/ for test: gem_exec_reloc results: parsing output: 54/ for test: syncobj_wait results: parsing output: 55/ for test: gem_render_copy results: parsing output: 56/ for test: kms_mmap_write_crc results: parsing output: 57/ for test: gem_exec_whisper results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: kms_cursor_legacy results: parsing output: 60/ for test: api_intel_bb results: parsing output: 61/ for test: kms_pipe_b_c_ivb results: parsing output: 62/ for test: kms_invalid_mode results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_flip_scaled_crc results: parsing output: 65/ for test: gem_lmem_swapping results: parsing output: 66/ for test: vgem_basic results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: gem_ctx_bad_destroy results: parsing output: 71/ for test: kms_chamelium_color results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: i915_drm_fdinfo results: parsing output: 74/ for test: gem_ctx_sseu results: parsing output: 75/ for test: gen9_exec_parse results: parsing output: 76/ for test: kms_psr2_sf results: parsing output: 77/ for test: kms_chamelium_frames results: parsing output: 78/ for test: kms_plane_scaling results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_cursor_legacy results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_big_fb results: parsing output: 84/ for test: kms_chamelium_hpd results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: gem_mmap_gtt results: parsing output: 87/ for test: gem_ctx_persistence results: parsing output: 88/ for test: prime_self_import results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: drm_read results: parsing output: 91/ for test: sriov_basic results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: kms_cursor_crc results: parsing output: 94/ for test: gem_mmap_wc results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_mmap_gtt results: parsing output: 98/ for test: gem_exec_gttfill results: parsing output: 99/ for test: gem_ppgtt results: parsing output: 100/ for test: dumb_buffer results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: prime_busy results: parsing output: 104/ for test: gem_exec_store results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: syncobj_wait results: parsing output: 107/ for test: kms_hdr results: parsing output: 108/ for test: kms_pm_dc results: parsing output: 109/ for test: api_intel_allocator results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_big_fb results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gem_exec_balancer results: parsing output: 114/ for test: kms_cursor_crc results: parsing output: 115/ for test: syncobj_timeline results: parsing output: 116/ for test: gem_exec_reloc results: parsing output: 117/ for test: syncobj_basic results: parsing output: 118/ for test: kms_ccs results: parsing output: 119/ for test: gem_unfence_active_buffers results: parsing output: 120/ for test: kms_universal_plane results: parsing output: 121/ for test: kms_addfb_basic results: parsing output: 122/ for test: kms_psr results: parsing output: 123/ for test: kms_cursor_legacy results: parsing output: 124/ for test: i915_pm_rpm results: parsing output: 125/ for test: gem_exec_fence results: parsing output: 126/ for test: gem_userptr_blits results: parsing output: 127/ for test: syncobj_timeline results: parsing output: 128/ for test: gem_userptr_blits results: parsing output: 129/ for test: kms_content_protection results: parsing output: 130/ for test: kms_plane_alpha_blend results: no output, setting notrun results: parsing output: 131/ for test: kms_addfb_basic results: no output, setting notrun Done.