[64.955978] Initializing watchdogs [64.956050] /dev/watchdog0 [64.974861] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [64.985827] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [64.989627] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [64.992036] [001/133] (960s left) prime_vgem (basic-fence-mmap) [65.121163] Starting subtest: basic-fence-mmap [65.123203] Subtest basic-fence-mmap: SKIP (0.000s) [65.273245] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true [65.274956] [002/133] (960s left) gem_exec_reloc (basic-wc-cpu) [65.358079] Subtest basic-wc-cpu: SKIP (0.000s) [65.441642] [003/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [65.640857] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [65.642492] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [65.822182] [004/133] (959s left) kms_psr (fbc-psr2-sprite-render) [66.009494] Subtest fbc-psr2-sprite-render: SKIP (0.000s) [66.070373] [005/133] (959s left) gem_sync (basic-store-each) [66.160925] Starting subtest: basic-store-each [69.810325] Subtest basic-store-each: SUCCESS (3.647s) [70.074548] [006/133] (955s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [70.259216] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [70.261059] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [70.581474] [007/133] (955s left) gem_exec_fence (submit) [70.787730] Starting subtest: submit [70.789741] Subtest submit: SKIP (0.000s) [71.519782] [008/133] (954s left) kms_atomic (plane-primary-overlay-mutable-zpos) [71.703639] Starting subtest: plane-primary-overlay-mutable-zpos [73.667189] Subtest plane-primary-overlay-mutable-zpos: SKIP (1.961s) [74.073934] [009/133] (951s left) gem_render_copy (yf-tiled) [74.161413] Starting subtest: yf-tiled [74.163559] Subtest yf-tiled: SKIP (0.000s) [74.420536] [010/133] (951s left) kms_invalid_mode (bad-htotal) [74.605598] Starting subtest: bad-htotal [74.606477] Starting dynamic subtest: pipe-A-DP-3 [74.684520] Dynamic subtest pipe-A-DP-3: SUCCESS (0.078s) [74.694597] Starting dynamic subtest: pipe-B-DP-3 [74.695745] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s) [74.705336] Starting dynamic subtest: pipe-C-DP-3 [74.706308] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s) [74.715963] Starting dynamic subtest: pipe-D-DP-3 [74.716944] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s) [74.717907] Subtest bad-htotal: SUCCESS (0.085s) [74.953483] [011/133] (951s left) kms_color_pipeline (plane-lut1d-lut1d) [75.165960] Starting subtest: plane-lut1d-lut1d [75.190571] Starting dynamic subtest: pipe-A-DP-3 [75.573572] Dynamic subtest pipe-A-DP-3: SUCCESS (0.383s) [75.771853] Starting dynamic subtest: pipe-B-DP-3 [76.112933] Dynamic subtest pipe-B-DP-3: SUCCESS (0.349s) [76.319767] Starting dynamic subtest: pipe-C-DP-3 [76.658915] Dynamic subtest pipe-C-DP-3: SUCCESS (0.348s) [76.840662] Starting dynamic subtest: pipe-D-DP-3 [77.181798] Dynamic subtest pipe-D-DP-3: SUCCESS (0.349s) [77.287996] Subtest plane-lut1d-lut1d: SUCCESS (2.121s) [77.603981] [012/133] (948s left) gem_userptr_blits (map-fixed-invalidate-overlap) [77.696867] Starting subtest: map-fixed-invalidate-overlap [77.698570] Subtest map-fixed-invalidate-overlap: SKIP (0.000s) [77.889485] [013/133] (948s left) gem_exec_reloc (basic-gtt-wc) [77.980145] Subtest basic-gtt-wc: SKIP (0.000s) [78.062951] [014/133] (948s left) gem_fence_thrash (bo-write-verify-y) [78.108206] Starting subtest: bo-write-verify-y [78.139805] Subtest bo-write-verify-y: SKIP (0.031s) [78.212757] [015/133] (948s left) syncobj_timeline (invalid-signal-illegal-handle) [78.289966] Starting subtest: invalid-signal-illegal-handle [78.291085] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [78.434740] [016/133] (948s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [78.727295] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [78.874775] [017/133] (947s left) kms_addfb_basic (basic) [78.966975] Starting subtest: basic [78.967909] Subtest basic: SUCCESS (0.000s) [79.254262] [018/133] (947s left) gem_exec_basic (basic) [79.334501] Starting subtest: basic [79.335422] Starting dynamic subtest: rcs0-smem [79.338569] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [79.347472] Starting dynamic subtest: bcs0-smem [79.348556] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [79.356655] Starting dynamic subtest: vcs0-smem [79.357689] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [79.365735] Starting dynamic subtest: vcs1-smem [79.366776] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [79.374808] Starting dynamic subtest: vecs0-smem [79.375979] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [79.383678] Starting dynamic subtest: vecs1-smem [79.384763] Dynamic subtest vecs1-smem: SUCCESS (0.001s) [79.392620] Starting dynamic subtest: ccs0-smem [79.393667] Dynamic subtest ccs0-smem: SUCCESS (0.001s) [79.401473] Starting dynamic subtest: rcs0-lmem0 [79.402555] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s) [79.410428] Starting dynamic subtest: bcs0-lmem0 [79.411555] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s) [79.419443] Starting dynamic subtest: vcs0-lmem0 [79.420451] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s) [79.428320] Starting dynamic subtest: vcs1-lmem0 [79.429458] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s) [79.437325] Starting dynamic subtest: vecs0-lmem0 [79.438458] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s) [79.446495] Starting dynamic subtest: vecs1-lmem0 [79.447610] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s) [79.455525] Starting dynamic subtest: ccs0-lmem0 [79.456432] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s) [79.457533] Subtest basic: SUCCESS (0.014s) [79.594852] [019/133] (947s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [79.794568] Starting subtest: yf-tiled-8bpp-rotate-90 [79.796288] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [79.982617] [020/133] (946s left) gem_exec_alignment (many) [80.070203] Starting subtest: many [108.275948] Subtest many: SUCCESS (28.200s) [108.973444] [021/133] (917s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [109.204616] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [109.206282] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [109.393516] [022/133] (917s left) kms_dirtyfb (psr-dirtyfb-ioctl) [109.582915] Starting subtest: psr-dirtyfb-ioctl [109.587855] Subtest psr-dirtyfb-ioctl: SKIP (0.000s) [109.801613] [023/133] (917s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [109.988027] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [110.048893] [024/133] (917s left) gem_ctx_param (invalid-set-ringsize) [110.127376] Starting subtest: invalid-set-ringsize [110.128302] Subtest invalid-set-ringsize: SUCCESS (0.000s) [110.279340] [025/133] (916s left) kms_big_fb (x-tiled-16bpp-rotate-0) [110.473052] Starting subtest: x-tiled-16bpp-rotate-0 [112.374829] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.902s) [112.598611] [026/133] (914s left) kms_cursor_crc (cursor-dpms) [112.851789] Starting subtest: cursor-dpms [112.853649] Starting dynamic subtest: pipe-A-DP-3 [114.125662] Dynamic subtest pipe-A-DP-3: SUCCESS (1.272s) [114.139391] Starting dynamic subtest: pipe-D-DP-3 [115.307546] Dynamic subtest pipe-D-DP-3: SUCCESS (1.180s) [115.308474] Subtest cursor-dpms: SUCCESS (2.455s) [115.849057] [027/133] (911s left) kms_pipe_crc_basic (nonblocking-crc) [116.049955] Starting subtest: nonblocking-crc [116.050893] Starting dynamic subtest: pipe-A-DP-3 [116.791028] Dynamic subtest pipe-A-DP-3: SUCCESS (0.741s) [116.802946] Starting dynamic subtest: pipe-B-DP-3 [117.433597] Dynamic subtest pipe-B-DP-3: SUCCESS (0.641s) [117.448462] Starting dynamic subtest: pipe-C-DP-3 [118.097992] Dynamic subtest pipe-C-DP-3: SUCCESS (0.662s) [118.110421] Starting dynamic subtest: pipe-D-DP-3 [118.711872] Dynamic subtest pipe-D-DP-3: SUCCESS (0.611s) [118.712942] Subtest nonblocking-crc: SUCCESS (2.662s) [119.048691] [028/133] (908s left) kms_plane_cursor (viewport) [119.233581] Starting subtest: viewport [119.235391] Starting dynamic subtest: pipe-A-DP-3-size-64 [122.452301] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.217s) [122.529692] Starting dynamic subtest: pipe-A-DP-3-size-128 [125.735057] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.216s) [125.836190] Starting dynamic subtest: pipe-A-DP-3-size-256 [129.035516] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.233s) [129.196208] Starting dynamic subtest: pipe-B-DP-3-size-64 [132.469486] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.286s) [132.534902] Starting dynamic subtest: pipe-B-DP-3-size-128 [135.768904] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.250s) [135.844836] Starting dynamic subtest: pipe-B-DP-3-size-256 [139.036588] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.216s) [139.174295] Starting dynamic subtest: pipe-C-DP-3-size-64 [142.515056] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.350s) [142.584426] Starting dynamic subtest: pipe-C-DP-3-size-128 [145.864659] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.300s) [145.939683] Starting dynamic subtest: pipe-C-DP-3-size-256 [149.115242] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.199s) [149.250565] Starting dynamic subtest: pipe-D-DP-3-size-64 [152.540746] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.299s) [152.610481] Starting dynamic subtest: pipe-D-DP-3-size-128 [155.841136] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.250s) [155.898379] Starting dynamic subtest: pipe-D-DP-3-size-256 [159.056631] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.166s) [159.184686] Subtest viewport: SUCCESS (39.950s) [159.486385] [029/133] (868s left) prime_busy (hang) [159.571133] Starting subtest: hang [159.572083] Starting dynamic subtest: rcs0 [185.517543] Dynamic subtest rcs0: SUCCESS (25.945s) [185.526699] Starting dynamic subtest: bcs0 [192.608982] Dynamic subtest bcs0: SUCCESS (7.091s) [192.618166] Starting dynamic subtest: vcs0 [199.646428] Dynamic subtest vcs0: SUCCESS (7.035s) [199.655616] Starting dynamic subtest: vcs1 [206.620948] Dynamic subtest vcs1: SUCCESS (6.974s) [206.630131] Starting dynamic subtest: vecs0 [213.596427] Dynamic subtest vecs0: SUCCESS (6.975s) [213.605565] Starting dynamic subtest: vecs1 [220.647055] Dynamic subtest vecs1: SUCCESS (7.050s) [220.656116] Starting dynamic subtest: ccs0 [234.461925] Dynamic subtest ccs0: SUCCESS (13.814s) [234.462937] Subtest hang: SUCCESS (74.890s) [234.616970] [030/133] (792s left) i915_drm_fdinfo (virtual-busy-all) [234.686451] Starting subtest: virtual-busy-all [234.688271] Subtest virtual-busy-all: SKIP (0.000s) [234.820657] [031/133] (792s left) gem_userptr_blits (vma-merge) [234.922198] Starting subtest: vma-merge [235.000702] Subtest vma-merge: SUCCESS (0.080s) [235.184283] [032/133] (792s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [235.372918] Starting subtest: fbc-rgb565-draw-blt [238.109329] Subtest fbc-rgb565-draw-blt: SUCCESS (2.737s) [238.353477] [033/133] (789s left) gem_exec_schedule (independent) [238.455185] Starting subtest: independent [238.456125] Starting dynamic subtest: rcs0 [238.888329] Dynamic subtest rcs0: SUCCESS (0.433s) [238.897825] Starting dynamic subtest: bcs0 [239.269281] Dynamic subtest bcs0: SUCCESS (0.380s) [239.279077] Starting dynamic subtest: vcs0 [239.649568] Dynamic subtest vcs0: SUCCESS (0.379s) [239.660138] Starting dynamic subtest: vcs1 [240.037820] Dynamic subtest vcs1: SUCCESS (0.387s) [240.053293] Starting dynamic subtest: vecs0 [240.419510] Dynamic subtest vecs0: SUCCESS (0.380s) [240.431530] Starting dynamic subtest: vecs1 [240.824684] Dynamic subtest vecs1: SUCCESS (0.403s) [240.865125] Starting dynamic subtest: ccs0 [241.199403] Dynamic subtest ccs0: SUCCESS (0.372s) [241.200497] Subtest independent: SUCCESS (2.745s) [241.590897] [034/133] (786s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [241.784176] Starting subtest: short-flip-after-cursor-toggle [242.817447] Subtest short-flip-after-cursor-toggle: SUCCESS (1.033s) [243.078959] [035/133] (784s left) kms_prop_blob (blob-prop-core) [243.166495] Starting subtest: blob-prop-core [243.167453] Subtest blob-prop-core: SUCCESS (0.000s) [243.347548] [036/133] (784s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [243.548850] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [243.550583] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [243.695186] [037/133] (784s left) syncobj_wait (invalid-signal-illegal-handle) [243.775237] Starting subtest: invalid-signal-illegal-handle [243.776187] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [243.950625] [038/133] (784s left) gem_exec_reloc (basic-write-wc-active) [244.034380] Subtest basic-write-wc-active: SKIP (0.000s) [244.113209] [039/133] (784s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [244.303977] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [244.305743] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [244.479720] [040/133] (783s left) gem_lmem_swapping (heavy-random) [247.262368] Starting subtest: heavy-random [247.263379] Starting dynamic subtest: lmem0 [252.553205] Dynamic subtest lmem0: SUCCESS (5.291s) [252.554159] Subtest heavy-random: SUCCESS (5.292s) [253.786847] [FACT gem_lmem_swapping (heavy-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [253.788708] [FACT gem_lmem_swapping (heavy-random)] deleted: kernel.kmod_is_loaded.i915: true [253.790848] [041/133] (774s left) kms_sequence (get-busy) [255.518367] Starting subtest: get-busy [255.520443] Starting dynamic subtest: pipe-A-DP-3 [258.114169] Dynamic subtest pipe-A-DP-3: SUCCESS (2.595s) [258.124592] Starting dynamic subtest: pipe-B-DP-3 [260.603406] Dynamic subtest pipe-B-DP-3: SUCCESS (2.487s) [260.614302] Starting dynamic subtest: pipe-C-DP-3 [263.073654] Dynamic subtest pipe-C-DP-3: SUCCESS (2.469s) [263.085142] Starting dynamic subtest: pipe-D-DP-3 [265.550395] Dynamic subtest pipe-D-DP-3: SUCCESS (2.475s) [265.551397] Subtest get-busy: SUCCESS (10.032s) [265.811152] [FACT kms_sequence (get-busy)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [265.813419] [FACT kms_sequence (get-busy)] new: kernel.kmod_is_loaded.i915: true [265.816085] [042/133] (762s left) gen7_exec_parse (basic-offset) [265.904548] Subtest basic-offset: SKIP (0.000s) [265.971906] [043/133] (762s left) gem_mmap_gtt (basic-small-bo-tiledy) [266.048161] Subtest basic-small-bo-tiledY: SKIP (0.000s) [266.116702] [044/133] (762s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [266.190229] Starting subtest: invalid-multi-wait-unsubmitted-signaled [266.191141] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [266.367839] [045/133] (762s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [266.446412] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [266.549102] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s) [266.685525] [046/133] (761s left) gem_create (create-invalid-size) [266.766210] Starting subtest: create-invalid-size [266.767134] Subtest create-invalid-size: SUCCESS (0.000s) [267.019276] [047/133] (761s left) kms_fb_coherency (memset-crc) [267.215165] Starting subtest: memset-crc [267.216052] Starting dynamic subtest: mmap-offset-fixed [267.743113] Dynamic subtest mmap-offset-fixed: SUCCESS (0.527s) [267.840130] Subtest memset-crc: SUCCESS (0.625s) [268.174453] [048/133] (760s left) gem_pxp (create-regular-context-1) [270.779433] Starting subtest: create-regular-context-1 [270.781191] Subtest create-regular-context-1: SKIP (0.000s) [270.925429] [049/133] (757s left) kms_flip (2x-busy-flip) [271.110090] Starting subtest: 2x-busy-flip [271.125079] Subtest 2x-busy-flip: SKIP (0.014s) [271.267110] [050/133] (757s left) syncobj_timeline (wait-all-snapshot) [271.343453] Starting subtest: wait-all-snapshot [271.425783] Subtest wait-all-snapshot: SUCCESS (0.082s) [271.591079] [051/133] (757s left) kms_big_fb (4-tiled-8bpp-rotate-270) [271.785422] Starting subtest: 4-tiled-8bpp-rotate-270 [271.846457] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.060s) [272.074036] [052/133] (756s left) api_intel_bb (misplaced-blitter) [272.150401] Starting subtest: misplaced-blitter [272.183277] Subtest misplaced-blitter: SUCCESS (0.034s) [272.409799] [053/133] (756s left) kms_async_flips (async-flip-suspend-resume) [272.594297] Starting subtest: async-flip-suspend-resume [272.821641] Starting dynamic subtest: pipe-A-DP-3 [293.580271] Dynamic subtest pipe-A-DP-3: SUCCESS (5.062s) [293.780213] Starting dynamic subtest: pipe-B-DP-3 [313.717461] Dynamic subtest pipe-B-DP-3: SUCCESS (4.609s) [313.892745] Starting dynamic subtest: pipe-C-DP-3 [333.861112] Dynamic subtest pipe-C-DP-3: SUCCESS (4.634s) [334.035256] Starting dynamic subtest: pipe-D-DP-3 [353.978112] Dynamic subtest pipe-D-DP-3: SUCCESS (4.596s) [353.978871] Subtest async-flip-suspend-resume: SUCCESS (19.656s) [354.421574] [054/133] (674s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [354.611203] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [357.474579] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.864s) [357.747578] [055/133] (671s left) gem_create (create-ext-cpu-access-big) [357.943304] Starting subtest: create-ext-cpu-access-big [360.188804] Subtest create-ext-cpu-access-big: FAIL (2.235s) [360.759213] [056/133] (668s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [360.953281] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [360.955047] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [361.135981] [057/133] (668s left) kms_prime (basic-modeset-hybrid) [361.322607] Subtest basic-modeset-hybrid: SKIP (0.000s) [361.516605] [058/133] (668s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [361.708388] Starting subtest: psr-modesetfrombusy [361.710147] Subtest psr-modesetfrombusy: SKIP (0.000s) [361.887666] [059/133] (667s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [362.079044] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [362.080693] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [362.287675] [060/133] (667s left) kms_psr (psr2-cursor-blt) [362.471351] Subtest psr2-cursor-blt: SKIP (0.000s) [362.535148] [061/133] (667s left) kms_lease (lease-get) [362.720644] Starting subtest: lease-get [362.721527] Starting dynamic subtest: pipe-A-DP-3 [362.723708] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s) [362.736949] Starting dynamic subtest: pipe-B-DP-3 [362.737781] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s) [362.749376] Starting dynamic subtest: pipe-C-DP-3 [362.750603] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s) [362.762296] Starting dynamic subtest: pipe-D-DP-3 [362.763409] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s) [362.764619] Subtest lease-get: SUCCESS (0.015s) [362.875431] [062/133] (666s left) kms_cursor_crc (cursor-size-hints) [363.137589] Starting subtest: cursor-size-hints [363.139731] Starting dynamic subtest: pipe-A-DP-3 [363.742545] Dynamic subtest pipe-A-DP-3: SUCCESS (0.603s) [363.756522] Starting dynamic subtest: pipe-D-DP-3 [364.240258] Dynamic subtest pipe-D-DP-3: SUCCESS (0.495s) [364.241264] Subtest cursor-size-hints: SUCCESS (1.103s) [364.795603] [063/133] (665s left) kms_vblank (query-forked-busy-hang) [364.982671] Starting subtest: query-forked-busy-hang [364.983564] Starting dynamic subtest: pipe-A-DP-3 [391.329712] Dynamic subtest pipe-A-DP-3: SUCCESS (26.344s) [391.345981] Starting dynamic subtest: pipe-D-DP-3 [416.274440] Dynamic subtest pipe-D-DP-3: SUCCESS (24.938s) [416.275406] Subtest query-forked-busy-hang: SUCCESS (51.292s) [416.582639] [064/133] (613s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [416.772179] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [416.773103] Starting dynamic subtest: pipe-A [418.747739] Dynamic subtest pipe-A: SUCCESS (1.975s) [418.771216] Starting dynamic subtest: pipe-B [420.863546] Dynamic subtest pipe-B: SUCCESS (2.114s) [420.889453] Starting dynamic subtest: pipe-C [421.177960] Dynamic subtest pipe-C: SUCCESS (0.312s) [421.194923] Starting dynamic subtest: pipe-D [421.474400] Dynamic subtest pipe-D: SUCCESS (0.295s) [421.478097] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (4.703s) [421.822360] [065/133] (608s left) gem_mmap_gtt (hang-busy) [421.907378] Subtest hang-busy: SKIP (0.000s) [421.987695] [066/133] (608s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [422.184154] Starting subtest: yf-tiled-16bpp-rotate-0 [422.185954] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [422.344674] [067/133] (607s left) i915_query (query-topology-garbage-items) [422.421795] Starting subtest: query-topology-garbage-items [422.422645] Subtest query-topology-garbage-items: SUCCESS (0.000s) [422.620591] [068/133] (607s left) gem_exec_balancer (bonded-semaphore) [422.713811] Starting subtest: bonded-semaphore [422.715690] Subtest bonded-semaphore: SKIP (0.000s) [423.109110] [069/133] (607s left) kms_cursor_crc (cursor-tearing-position-change) [423.348592] Starting subtest: cursor-tearing-position-change [423.350799] Starting dynamic subtest: pipe-A-DP-3 [423.847133] Dynamic subtest pipe-A-DP-3: SUCCESS (0.496s) [423.864552] Starting dynamic subtest: pipe-D-DP-3 [424.291193] Dynamic subtest pipe-D-DP-3: SUCCESS (0.442s) [424.292150] Subtest cursor-tearing-position-change: SUCCESS (0.942s) [424.865917] [070/133] (605s left) kms_chamelium_color (ctm-max) [425.059696] Subtest ctm-max: SKIP (0.000s) [425.151624] [071/133] (605s left) gem_exec_flush (basic-batch-kernel-default-uc) [425.235307] Subtest basic-batch-kernel-default-uc: SKIP (0.000s) [425.347954] [072/133] (605s left) gem_exec_fence (syncobj-wait) [425.849585] Starting subtest: syncobj-wait [425.972159] Subtest syncobj-wait: SUCCESS (0.122s) [426.446055] [073/133] (604s left) kms_addfb_basic (small-bo) [426.628613] Starting subtest: small-bo [426.629488] Subtest small-bo: SUCCESS (0.000s) [426.827875] [074/133] (603s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [427.016630] Starting subtest: plane-all-modeset-transition-fencing [427.017496] Starting dynamic subtest: pipe-A-DP-3 [453.865298] Dynamic subtest pipe-A-DP-3: SUCCESS (26.847s) [453.979385] Starting dynamic subtest: pipe-B-DP-3 [477.318334] Dynamic subtest pipe-B-DP-3: SUCCESS (23.374s) [477.370903] Subtest plane-all-modeset-transition-fencing: SUCCESS (50.351s) [477.660815] [075/133] (553s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [477.847443] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [477.849164] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [478.040435] [076/133] (552s left) perf (disabled-read-error) [478.460149] Starting subtest: disabled-read-error [478.494188] Subtest disabled-read-error: SUCCESS (0.034s) [478.577580] [077/133] (552s left) fbdev (nullptr) [478.641626] Starting subtest: nullptr [478.642579] Subtest nullptr: SUCCESS (0.000s) [478.802181] [078/133] (552s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [478.877666] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [478.878751] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [479.059895] [079/133] (552s left) gem_exec_reloc (basic-cpu-read-active) [479.142537] Subtest basic-cpu-read-active: SKIP (0.000s) [479.219685] [080/133] (552s left) gem_exec_whisper (basic-contexts-priority) [479.306726] Starting subtest: basic-contexts-priority [501.900327] Subtest basic-contexts-priority: SUCCESS (22.590s) [502.149802] [081/133] (529s left) i915_pm_rpm (gem-pread) [503.755966] Starting subtest: gem-pread [504.608649] Subtest gem-pread: SUCCESS (0.858s) [504.905175] [082/133] (526s left) kms_content_protection (dp-mst-type-1-suspend-resume) [505.169555] Starting subtest: dp-mst-type-1-suspend-resume [505.171371] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s) [505.404901] [083/133] (526s left) kms_rotation_crc (sprite-rotation-270) [505.588972] Starting subtest: sprite-rotation-270 [505.590669] Subtest sprite-rotation-270: SKIP (0.001s) [505.759421] [084/133] (525s left) gem_userptr_blits (input-checking) [505.842114] Starting subtest: input-checking [505.843029] Subtest input-checking: SUCCESS (0.000s) [506.070755] [085/133] (525s left) kms_cursor_crc (cursor-size-change) [506.251656] Starting subtest: cursor-size-change [506.252541] Starting dynamic subtest: pipe-A-DP-3 [507.127192] Dynamic subtest pipe-A-DP-3: SUCCESS (0.874s) [507.159014] Starting dynamic subtest: pipe-D-DP-3 [507.987653] Dynamic subtest pipe-D-DP-3: SUCCESS (0.853s) [507.988550] Subtest cursor-size-change: SUCCESS (1.738s) [508.637219] [086/133] (523s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [508.834437] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [508.836160] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [509.035293] [087/133] (522s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [509.224745] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s) [509.281899] [088/133] (522s left) gem_userptr_blits (unsync-unmap-after-close) [509.366622] Subtest unsync-unmap-after-close: SKIP (0.000s) [509.630775] [089/133] (522s left) perf (global-sseu-config) [509.858557] Starting subtest: global-sseu-config [509.860705] Subtest global-sseu-config: SKIP (0.000s) [509.916823] [090/133] (522s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [510.104386] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [510.106127] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [510.280796] [091/133] (521s left) kms_psr (fbc-pr-sprite-blt) [510.464545] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [510.530919] [092/133] (521s left) syncobj_wait (invalid-signal-zero-handles) [510.610550] Starting subtest: invalid-signal-zero-handles [510.611487] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [510.804135] [093/133] (521s left) syncobj_basic (bad-fd-to-handle) [510.876554] Starting subtest: bad-fd-to-handle [510.877465] Subtest bad-fd-to-handle: SUCCESS (0.000s) [511.070173] [094/133] (521s left) sysfs_heartbeat_interval (nopreempt) [511.156524] Starting subtest: nopreempt [511.157447] Starting dynamic subtest: vecs0 [515.466431] Dynamic subtest vecs0: SUCCESS (4.309s) [515.481855] Starting dynamic subtest: ccs0 [519.786491] Dynamic subtest ccs0: SUCCESS (4.319s) [519.806145] Starting dynamic subtest: vcs0 [524.044431] Dynamic subtest vcs0: SUCCESS (4.256s) [524.057833] Starting dynamic subtest: bcs0 [528.258246] Dynamic subtest bcs0: SUCCESS (4.212s) [528.271873] Starting dynamic subtest: vecs1 [532.474284] Dynamic subtest vecs1: SUCCESS (4.214s) [532.487599] Starting dynamic subtest: rcs0 [536.847291] Dynamic subtest rcs0: SUCCESS (4.372s) [536.863477] Starting dynamic subtest: vcs1 [541.088507] Dynamic subtest vcs1: SUCCESS (4.239s) [541.089473] Subtest nopreempt: SUCCESS (29.932s) [541.257625] [095/133] (491s left) gem_exec_reloc (basic-wc) [541.347659] Subtest basic-wc: SKIP (0.000s) [541.440291] [096/133] (491s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [541.626779] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [541.627627] Starting dynamic subtest: pipe-A [541.721317] Dynamic subtest pipe-A: SUCCESS (0.094s) [541.744956] Starting dynamic subtest: pipe-B [541.950646] Dynamic subtest pipe-B: SUCCESS (0.228s) [541.969088] Starting dynamic subtest: pipe-C [542.149085] Dynamic subtest pipe-C: SUCCESS (0.197s) [542.173603] Starting dynamic subtest: pipe-D [542.362035] Dynamic subtest pipe-D: SUCCESS (0.211s) [542.363066] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.736s) [542.724301] [097/133] (489s left) kms_pm_dc (dc6-dpms) [543.917512] Starting subtest: dc6-dpms [543.919329] Subtest dc6-dpms: SKIP (0.000s) [544.080423] [098/133] (488s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [544.270452] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [544.272230] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s) [544.463770] [099/133] (488s left) gem_softpin (noreloc) [544.549456] Starting subtest: noreloc [549.988774] Subtest noreloc: SUCCESS (5.439s) [550.135592] [100/133] (482s left) kms_psr (psr-sprite-blt) [550.320109] Subtest psr-sprite-blt: SKIP (0.000s) [550.388720] [101/133] (482s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [550.581598] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [550.586479] Starting dynamic subtest: A-DP3 [551.400519] Dynamic subtest A-DP3: SUCCESS (0.813s) [551.426559] Starting dynamic subtest: B-DP3 [552.158070] Dynamic subtest B-DP3: SUCCESS (0.756s) [552.172999] Starting dynamic subtest: C-DP3 [552.878751] Dynamic subtest C-DP3: SUCCESS (0.719s) [552.893665] Starting dynamic subtest: D-DP3 [553.628158] Dynamic subtest D-DP3: SUCCESS (0.748s) [553.630412] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.048s) [553.927444] [102/133] (479s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [554.115501] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [554.116403] Starting dynamic subtest: pipe-A-DP-3 [554.124735] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [554.138428] Starting dynamic subtest: pipe-B-DP-3 [554.154487] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [554.167794] Starting dynamic subtest: pipe-C-DP-3 [554.177756] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [554.191366] Starting dynamic subtest: pipe-D-DP-3 [554.202590] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [554.204766] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s) [554.568354] [103/133] (478s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [554.753675] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [554.754649] Starting dynamic subtest: pipe-A-DP-3 [554.763264] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [554.776990] Starting dynamic subtest: pipe-B-DP-3 [554.787275] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [554.800328] Starting dynamic subtest: pipe-C-DP-3 [554.809769] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [554.822987] Starting dynamic subtest: pipe-D-DP-3 [554.833272] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [554.835205] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s) [555.255326] [104/133] (477s left) gem_ctx_persistence (heartbeat-stop) [555.341688] Starting subtest: heartbeat-stop [555.343794] Subtest heartbeat-stop: SKIP (0.000s) [555.549444] [105/133] (477s left) kms_flip (2x-absolute-wf_vblank) [555.731207] Starting subtest: 2x-absolute-wf_vblank [555.746696] Subtest 2x-absolute-wf_vblank: SKIP (0.015s) [555.893626] [106/133] (477s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render) [556.085147] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render [556.086779] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [556.261810] [107/133] (477s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [556.451472] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [556.453161] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [556.628783] [108/133] (476s left) kms_flip (2x-flip-vs-suspend-interruptible) [556.816755] Starting subtest: 2x-flip-vs-suspend-interruptible [556.832713] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.015s) [557.010213] [109/133] (476s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [557.194087] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [557.229539] Starting dynamic subtest: pipe-A-plane-0 [557.231345] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [557.244743] Starting dynamic subtest: pipe-A-plane-3 [557.246490] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [557.259710] Starting dynamic subtest: pipe-A-plane-5 [557.261456] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [557.467799] Starting dynamic subtest: pipe-B-plane-0 [557.469718] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [557.489126] Starting dynamic subtest: pipe-B-plane-3 [557.490848] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [557.504613] Starting dynamic subtest: pipe-B-plane-5 [557.506388] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [557.555468] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.360s) [557.819717] [110/133] (475s left) gem_spin_batch (legacy-resubmit) [557.907576] Starting subtest: legacy-resubmit [557.909928] Starting dynamic subtest: default [557.938127] Dynamic subtest default: SUCCESS (0.030s) [557.953671] Starting dynamic subtest: render [557.954653] Dynamic subtest render: SUCCESS (0.002s) [557.968415] Starting dynamic subtest: bsd [557.969638] Dynamic subtest bsd: SUCCESS (0.002s) [557.982579] Starting dynamic subtest: bsd1 [557.983555] Dynamic subtest bsd1: SUCCESS (0.002s) [557.996373] Starting dynamic subtest: bsd2 [557.997425] Dynamic subtest bsd2: SUCCESS (0.002s) [558.010433] Starting dynamic subtest: blt [558.011379] Dynamic subtest blt: SUCCESS (0.002s) [558.024437] Starting dynamic subtest: vebox [558.025377] Dynamic subtest vebox: SUCCESS (0.002s) [558.026582] Subtest legacy-resubmit: SUCCESS (0.050s) [558.267592] [111/133] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [558.456407] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [558.458104] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [558.627037] [112/133] (475s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [558.711895] Starting subtest: yf-tiled-to-vebox-y-tiled [558.713791] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [558.965827] [113/133] (474s left) kms_chamelium_frames (dp-crc-single) [559.228053] Subtest dp-crc-single: SKIP (0.000s) [559.380730] [114/133] (474s left) gem_partial_pwrite_pread (reads) [559.469388] Subtest reads: SKIP (0.000s) [559.580182] [115/133] (474s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [559.770389] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [559.772114] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [559.958834] [116/133] (474s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu) [560.151148] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu [563.391813] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.241s) [563.589496] [117/133] (470s left) syncobj_eventfd (timeline-wait-before-signal) [563.668669] Starting subtest: timeline-wait-before-signal [563.699521] Subtest timeline-wait-before-signal: SUCCESS (0.031s) [563.816523] [118/133] (470s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [564.000644] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [564.001513] Starting dynamic subtest: pipe-A-DP-3 [564.009886] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [564.023662] Starting dynamic subtest: pipe-B-DP-3 [564.032018] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [564.045593] Starting dynamic subtest: pipe-C-DP-3 [564.054000] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [564.067656] Starting dynamic subtest: pipe-D-DP-3 [564.078302] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [564.080218] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s) [564.506442] [119/133] (469s left) kms_getfb (getfb2-handle-closed) [564.691682] Starting subtest: getfb2-handle-closed [564.692614] Subtest getfb2-handle-closed: SUCCESS (0.000s) [564.903116] [120/133] (469s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [565.091450] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [565.093126] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [565.288364] [121/133] (469s left) dmabuf_sync_file (export-multiwait) [565.352595] Starting subtest: export-multiwait [565.353504] Subtest export-multiwait: SUCCESS (0.000s) [565.485656] [122/133] (469s left) gem_exec_schedule (preempt-self) [565.575685] Starting subtest: preempt-self [565.576584] Starting dynamic subtest: rcs0 [565.637410] Dynamic subtest rcs0: SUCCESS (0.061s) [565.653796] Starting dynamic subtest: bcs0 [565.667790] Dynamic subtest bcs0: SUCCESS (0.029s) [565.683401] Starting dynamic subtest: vcs0 [565.698585] Dynamic subtest vcs0: SUCCESS (0.030s) [565.713734] Starting dynamic subtest: vcs1 [565.727578] Dynamic subtest vcs1: SUCCESS (0.028s) [565.743015] Starting dynamic subtest: vecs0 [565.759418] Dynamic subtest vecs0: SUCCESS (0.031s) [565.774671] Starting dynamic subtest: vecs1 [565.788579] Dynamic subtest vecs1: SUCCESS (0.028s) [565.803976] Starting dynamic subtest: ccs0 [565.819349] Dynamic subtest ccs0: SUCCESS (0.029s) [565.820162] Subtest preempt-self: SUCCESS (0.244s) [566.306958] [123/133] (468s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [566.492459] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [566.494135] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [566.675776] [124/133] (468s left) gem_lmem_swapping (parallel-random-verify-ccs) [569.844341] Starting subtest: parallel-random-verify-ccs [569.845303] Starting dynamic subtest: lmem0 [635.383785] Dynamic subtest lmem0: SUCCESS (65.534s) [635.386667] Subtest parallel-random-verify-ccs: SUCCESS (65.535s) [636.458391] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [636.459323] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true [636.461127] [125/133] (398s left) kms_flip (blocking-wf_vblank) [638.206076] Starting subtest: blocking-wf_vblank [638.209498] Starting dynamic subtest: A-DP3 [646.366354] Dynamic subtest A-DP3: SUCCESS (8.157s) [646.383157] Starting dynamic subtest: B-DP3 [654.420286] Dynamic subtest B-DP3: SUCCESS (8.052s) [654.434499] Starting dynamic subtest: C-DP3 [662.478316] Dynamic subtest C-DP3: SUCCESS (8.057s) [662.492368] Starting dynamic subtest: D-DP3 [670.537354] Dynamic subtest D-DP3: SUCCESS (8.057s) [670.539564] Subtest blocking-wf_vblank: SUCCESS (32.334s) [670.839530] [FACT kms_flip (blocking-wf_vblank)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [670.842108] [FACT kms_flip (blocking-wf_vblank)] new: kernel.kmod_is_loaded.i915: true [670.844732] [126/133] (364s left) i915_pciid [671.050801] [127/133] (363s left) api_intel_allocator (execbuf-with-allocator) [671.128492] Starting subtest: execbuf-with-allocator [671.161973] Subtest execbuf-with-allocator: SUCCESS (0.033s) [671.337278] [128/133] (363s left) perf_pmu (busy-idle) [671.412542] Starting subtest: busy-idle [671.413428] Starting dynamic subtest: rcs0 [672.152525] Dynamic subtest rcs0: SUCCESS (0.740s) [672.170554] Starting dynamic subtest: bcs0 [672.822740] Dynamic subtest bcs0: SUCCESS (0.665s) [672.842925] Starting dynamic subtest: vcs0 [673.503786] Dynamic subtest vcs0: SUCCESS (0.676s) [673.525180] Starting dynamic subtest: vcs1 [674.169762] Dynamic subtest vcs1: SUCCESS (0.661s) [674.190730] Starting dynamic subtest: vecs0 [674.838422] Dynamic subtest vecs0: SUCCESS (0.664s) [674.859276] Starting dynamic subtest: vecs1 [675.503750] Dynamic subtest vecs1: SUCCESS (0.660s) [675.524281] Starting dynamic subtest: ccs0 [676.169822] Dynamic subtest ccs0: SUCCESS (0.661s) [676.175571] Subtest busy-idle: SUCCESS (4.760s) [676.401583] [129/133] (358s left) kms_panel_fitting (legacy) [676.588830] Starting subtest: legacy [676.590613] Subtest legacy: SKIP (0.000s) [676.758492] [130/133] (358s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [676.950758] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [678.186107] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.234s) [678.438280] [131/133] (356s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [678.627303] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [681.302610] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.675s) [681.536021] [132/133] (353s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [681.723692] Starting subtest: nonblocking-modeset-vs-cursor-atomic [682.088505] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.366s) [682.447616] [133/133] (352s left) kms_psr (psr-cursor-mmap-gtt) [682.636612] Subtest psr-cursor-mmap-gtt: SKIP (0.000s) [682.689248] Closing watchdogs results: parsing output: 0/ for test: prime_vgem results: parsing output: 1/ for test: gem_exec_reloc results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_psr results: parsing output: 4/ for test: gem_sync results: parsing output: 5/ for test: kms_ccs results: parsing output: 6/ for test: gem_exec_fence results: parsing output: 7/ for test: kms_atomic results: parsing output: 8/ for test: gem_render_copy results: parsing output: 9/ for test: kms_invalid_mode results: parsing output: 10/ for test: kms_color_pipeline results: parsing output: 11/ for test: gem_userptr_blits results: parsing output: 12/ for test: gem_exec_reloc results: parsing output: 13/ for test: gem_fence_thrash results: parsing output: 14/ for test: syncobj_timeline results: parsing output: 15/ for test: kms_chamelium_hpd results: parsing output: 16/ for test: kms_addfb_basic results: parsing output: 17/ for test: gem_exec_basic results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: gem_exec_alignment results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_dirtyfb results: parsing output: 22/ for test: kms_psr2_sf results: parsing output: 23/ for test: gem_ctx_param results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: kms_cursor_crc results: parsing output: 26/ for test: kms_pipe_crc_basic results: parsing output: 27/ for test: kms_plane_cursor results: parsing output: 28/ for test: prime_busy results: parsing output: 29/ for test: i915_drm_fdinfo results: parsing output: 30/ for test: gem_userptr_blits results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: gem_exec_schedule results: parsing output: 33/ for test: kms_cursor_legacy results: parsing output: 34/ for test: kms_prop_blob results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: syncobj_wait results: parsing output: 37/ for test: gem_exec_reloc results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_lmem_swapping results: parsing output: 40/ for test: kms_sequence results: parsing output: 41/ for test: gen7_exec_parse results: parsing output: 42/ for test: gem_mmap_gtt results: parsing output: 43/ for test: syncobj_wait results: parsing output: 44/ for test: syncobj_timeline results: parsing output: 45/ for test: gem_create results: parsing output: 46/ for test: kms_fb_coherency results: parsing output: 47/ for test: gem_pxp results: parsing output: 48/ for test: kms_flip results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: api_intel_bb results: parsing output: 52/ for test: kms_async_flips results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_create results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_prime results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: kms_lease results: parsing output: 61/ for test: kms_cursor_crc results: parsing output: 62/ for test: kms_vblank results: parsing output: 63/ for test: kms_plane_scaling results: parsing output: 64/ for test: gem_mmap_gtt results: parsing output: 65/ for test: kms_big_fb results: parsing output: 66/ for test: i915_query results: parsing output: 67/ for test: gem_exec_balancer results: parsing output: 68/ for test: kms_cursor_crc results: parsing output: 69/ for test: kms_chamelium_color results: parsing output: 70/ for test: gem_exec_flush results: parsing output: 71/ for test: gem_exec_fence results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_atomic_transition results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: perf results: parsing output: 76/ for test: fbdev results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: gem_exec_reloc results: parsing output: 79/ for test: gem_exec_whisper results: parsing output: 80/ for test: i915_pm_rpm results: parsing output: 81/ for test: kms_content_protection results: parsing output: 82/ for test: kms_rotation_crc results: parsing output: 83/ for test: gem_userptr_blits results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_psr2_sf results: parsing output: 87/ for test: gem_userptr_blits results: parsing output: 88/ for test: perf results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_psr results: parsing output: 91/ for test: syncobj_wait results: parsing output: 92/ for test: syncobj_basic results: parsing output: 93/ for test: sysfs_heartbeat_interval results: parsing output: 94/ for test: gem_exec_reloc results: parsing output: 95/ for test: kms_plane_scaling results: parsing output: 96/ for test: kms_pm_dc results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: gem_softpin results: parsing output: 99/ for test: kms_psr results: parsing output: 100/ for test: kms_flip results: parsing output: 101/ for test: kms_ccs results: parsing output: 102/ for test: kms_ccs results: parsing output: 103/ for test: gem_ctx_persistence results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: kms_plane results: parsing output: 109/ for test: gem_spin_batch results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: gem_render_copy results: parsing output: 112/ for test: kms_chamelium_frames results: parsing output: 113/ for test: gem_partial_pwrite_pread results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: syncobj_eventfd results: parsing output: 117/ for test: kms_ccs results: parsing output: 118/ for test: kms_getfb results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: dmabuf_sync_file results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: kms_flip_scaled_crc results: parsing output: 123/ for test: gem_lmem_swapping results: parsing output: 124/ for test: kms_flip results: parsing output: 125/ for test: i915_pciid results: parsing output: 126/ for test: api_intel_allocator results: parsing output: 127/ for test: perf_pmu results: parsing output: 128/ for test: kms_panel_fitting results: parsing output: 129/ for test: kms_big_fb results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_cursor_legacy results: parsing output: 132/ for test: kms_psr Done.