[62.246625] Initializing watchdogs [62.246679] /dev/watchdog0 [62.261097] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [62.265305] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.267940] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.271398] [001/156] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [62.397252] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [62.401673] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [62.512393] [002/156] (960s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt) [62.605189] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt [62.609210] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [62.705880] [003/156] (960s left) kms_psr (fbc-psr-cursor-blt) [62.794068] Starting subtest: fbc-psr-cursor-blt [62.796457] Starting dynamic subtest: eDP-1 [62.800704] Dynamic subtest eDP-1: SKIP (0.000s) [62.805062] Subtest fbc-psr-cursor-blt: SKIP (0.000s) [62.865415] [004/156] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [62.959400] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [62.963438] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [63.031960] [005/156] (959s left) sriov_basic (enable-vfs-bind-unbind-each) [63.080681] Starting subtest: enable-vfs-bind-unbind-each [63.082825] Starting dynamic subtest: numvfs-1 [63.145142] Dynamic subtest numvfs-1: FAIL (0.011s) [63.151788] Starting dynamic subtest: numvfs-2 [63.211399] Dynamic subtest numvfs-2: FAIL (0.003s) [63.219961] Starting dynamic subtest: numvfs-3 [63.282475] Dynamic subtest numvfs-3: FAIL (0.003s) [63.290550] Starting dynamic subtest: numvfs-4 [63.350863] Dynamic subtest numvfs-4: FAIL (0.003s) [63.361938] Starting dynamic subtest: numvfs-5 [63.421828] Dynamic subtest numvfs-5: FAIL (0.004s) [63.429987] Starting dynamic subtest: numvfs-6 [63.489071] Dynamic subtest numvfs-6: FAIL (0.004s) [63.497289] Starting dynamic subtest: numvfs-7 [63.560119] Dynamic subtest numvfs-7: FAIL (0.003s) [63.569272] Starting dynamic subtest: numvfs-random [63.628900] Dynamic subtest numvfs-random: FAIL (0.003s) [63.630727] Subtest enable-vfs-bind-unbind-each: FAIL (0.038s) [63.662220] [006/156] (959s left) syncobj_wait (wait-all-for-submit-snapshot) [63.717865] Starting subtest: wait-all-for-submit-snapshot [63.799931] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [63.884452] [007/156] (959s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [63.983355] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [63.995312] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s) [64.064740] [008/156] (958s left) gem_eio (wait-10ms) [64.205273] Starting subtest: wait-10ms [64.394309] Subtest wait-10ms: SUCCESS (0.190s) [64.566823] [009/156] (958s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [64.619140] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [64.728269] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.108s) [64.808604] [010/156] (958s left) syncobj_wait (multi-wait-all-for-submit-signaled) [64.862033] Starting subtest: multi-wait-all-for-submit-signaled [64.864463] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [64.974531] [011/156] (958s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [65.066646] Starting subtest: psr-shrfb-scaledprimary [71.139491] Subtest psr-shrfb-scaledprimary: SUCCESS (6.072s) [71.249825] [012/156] (951s left) kms_cursor_crc (cursor-rapid-movement-512x170) [71.591640] Starting subtest: cursor-rapid-movement-512x170 [71.596484] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [71.727027] [013/156] (951s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-plflip-blt) [71.821558] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-plflip-blt [71.825810] Subtest fbcpsrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [71.916212] [014/156] (951s left) sysfs_heartbeat_interval (idempotent) [71.975917] Starting subtest: idempotent [71.978369] Starting dynamic subtest: vecs0 [71.980779] Dynamic subtest vecs0: SUCCESS (0.000s) [71.990732] Starting dynamic subtest: ccs0 [71.992631] Dynamic subtest ccs0: SUCCESS (0.001s) [72.000342] Starting dynamic subtest: vcs0 [72.002254] Dynamic subtest vcs0: SUCCESS (0.000s) [72.009798] Starting dynamic subtest: bcs0 [72.011766] Dynamic subtest bcs0: SUCCESS (0.001s) [72.018827] Starting dynamic subtest: rcs0 [72.020646] Dynamic subtest rcs0: SUCCESS (0.001s) [72.029788] Starting dynamic subtest: vcs1 [72.031612] Dynamic subtest vcs1: SUCCESS (0.000s) [72.033467] Subtest idempotent: SUCCESS (0.005s) [72.091489] [015/156] (951s left) gem_render_copy (y-tiled) [72.140730] Starting subtest: y-tiled [72.144583] Subtest y-tiled: SKIP (0.000s) [72.316448] [016/156] (951s left) kms_busy (basic-hang) [72.407295] Starting subtest: basic-hang [72.409802] Starting dynamic subtest: flip-pipe-A [73.134101] Dynamic subtest flip-pipe-A: SUCCESS (0.721s) [73.144607] Starting dynamic subtest: modeset-pipe-A [76.608069] Dynamic subtest modeset-pipe-A: SUCCESS (3.474s) [76.617922] Starting dynamic subtest: flip-pipe-D [77.811296] Dynamic subtest flip-pipe-D: SUCCESS (1.200s) [77.819719] Starting dynamic subtest: modeset-pipe-D [81.277073] Dynamic subtest modeset-pipe-D: SUCCESS (3.465s) [81.279296] Subtest basic-hang: SUCCESS (8.866s) [82.088173] [017/156] (941s left) kms_psr (psr2-cursor-plane-onoff) [82.175464] Starting subtest: psr2-cursor-plane-onoff [82.177781] Starting dynamic subtest: eDP-1 [83.871722] Dynamic subtest eDP-1: SUCCESS (1.695s) [83.874076] Subtest psr2-cursor-plane-onoff: SUCCESS (1.696s) [84.766626] [018/156] (938s left) gem_exec_schedule (u-semaphore-user) [84.837180] Starting subtest: u-semaphore-user [84.889340] Subtest u-semaphore-user: SUCCESS (0.059s) [86.309975] [019/156] (937s left) kms_atomic (atomic-plane-damage) [86.409113] Starting subtest: atomic-plane-damage [86.456589] Starting dynamic subtest: pipe-A-eDP-1 [86.995546] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.537s) [86.997479] Subtest atomic-plane-damage: SUCCESS (0.586s) [87.807330] [020/156] (935s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [87.860829] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [87.863118] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [87.969297] [021/156] (935s left) kms_invalid_mode (zero-clock) [88.059138] Starting subtest: zero-clock [88.061322] Starting dynamic subtest: pipe-A-eDP-1 [88.350724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [88.360094] Starting dynamic subtest: pipe-B-eDP-1 [88.362191] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [88.370167] Starting dynamic subtest: pipe-C-eDP-1 [88.372331] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [88.383015] Starting dynamic subtest: pipe-D-eDP-1 [88.385326] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [88.387611] Subtest zero-clock: SUCCESS (0.297s) [89.156143] [022/156] (934s left) kms_content_protection (lic-type-0-hdcp14) [89.292828] Starting subtest: lic-type-0-hdcp14 [89.297459] Subtest lic-type-0-hdcp14: SKIP (0.000s) [89.422092] [023/156] (934s left) kms_vblank (ts-continuation-modeset-rpm) [89.515352] Starting subtest: ts-continuation-modeset-rpm [89.517681] Starting dynamic subtest: pipe-A-eDP-1 [92.062486] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.544s) [92.076688] Starting dynamic subtest: pipe-D-eDP-1 [94.309034] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.246s) [94.311347] Subtest ts-continuation-modeset-rpm: SUCCESS (4.792s) [95.197108] [024/156] (928s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-pwrite) [95.298799] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-pwrite [95.303032] Subtest hdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [95.412479] [025/156] (928s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt) [95.504305] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt [95.508253] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [95.592029] [026/156] (928s left) gem_eio (reset-stress) [95.782621] Starting subtest: reset-stress [95.784745] Starting dynamic subtest: render [100.152927] Dynamic subtest render: SUCCESS (4.366s) [100.168121] Starting dynamic subtest: bsd1 [117.787480] Dynamic subtest bsd1: SUCCESS (17.633s) [117.802844] Starting dynamic subtest: bsd2 [135.759040] Dynamic subtest bsd2: SUCCESS (17.966s) [135.774583] Starting dynamic subtest: blt [135.778855] Dynamic subtest blt: SKIP (0.000s) [135.787208] Starting dynamic subtest: vebox [153.741691] Dynamic subtest vebox: SUCCESS (17.980s) [153.744238] Subtest reset-stress: SUCCESS (57.948s) [155.304087] [FACT gem_eio (reset-stress)] new: kernel.kmod_is_loaded.vgem: true [155.307039] [027/156] (868s left) gem_mmap_gtt (basic-small-bo) [155.375594] Subtest basic-small-bo: SKIP (0.000s) [155.433857] [028/156] (868s left) perf (gen12-group-concurrent-oa-buffer-read) [155.545762] Starting subtest: gen12-group-concurrent-oa-buffer-read [165.580858] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.034s) [165.628626] [029/156] (858s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [165.734189] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [173.128205] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.399s) [173.262378] [030/156] (850s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [173.364165] Starting subtest: plane-use-after-nonblocking-unbind-fencing [173.366458] Starting dynamic subtest: pipe-A-eDP-1 [173.431788] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.067s) [173.742900] Starting dynamic subtest: pipe-B-eDP-1 [174.537088] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.803s) [174.842091] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.477s) [175.685084] [031/156] (848s left) gem_eio (hibernate) [175.875860] Starting subtest: hibernate [191.324853] Subtest hibernate: SUCCESS (15.448s) [200.484742] [032/156] (832s left) kms_plane_multiple (tiling-none) [200.594086] Starting subtest: tiling-none [200.596455] Starting dynamic subtest: pipe-A-eDP-1 [204.372237] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.778s) [204.383325] Starting dynamic subtest: pipe-B-eDP-1 [208.811786] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.438s) [208.823276] Starting dynamic subtest: pipe-C-eDP-1 [213.338935] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.525s) [213.350131] Starting dynamic subtest: pipe-D-eDP-1 [217.704083] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.362s) [217.706458] Subtest tiling-none: SUCCESS (17.108s) [218.515599] [033/156] (814s left) gem_ctx_isolation (clean) [218.578950] Starting subtest: clean [218.581402] Starting dynamic subtest: rcs0 [218.624597] Dynamic subtest rcs0: SUCCESS (0.045s) [218.636321] Starting dynamic subtest: bcs0 [218.690224] Dynamic subtest bcs0: SUCCESS (0.065s) [218.700822] Starting dynamic subtest: vcs0 [218.749170] Dynamic subtest vcs0: SUCCESS (0.058s) [218.759826] Starting dynamic subtest: vcs1 [220.311284] Dynamic subtest vcs1: SUCCESS (1.561s) [220.323601] Starting dynamic subtest: vecs0 [222.272154] Dynamic subtest vecs0: SUCCESS (1.960s) [222.284735] Starting dynamic subtest: ccs0 [224.325396] Dynamic subtest ccs0: SUCCESS (2.052s) [224.327828] Subtest clean: SUCCESS (5.747s) [224.546072] [034/156] (808s left) api_intel_bb (blit-noreloc-purge-cache) [224.597130] Starting subtest: blit-noreloc-purge-cache [224.612478] Subtest blit-noreloc-purge-cache: SUCCESS (0.017s) [224.702495] [035/156] (808s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [224.796911] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [224.802086] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [224.895800] [036/156] (808s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-blt) [224.998584] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-blt [225.002688] Subtest hdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [225.086858] [037/156] (808s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [225.188143] Starting subtest: psr2-primary-plane-update-sf-dmg-area [225.190417] Starting dynamic subtest: pipe-A-eDP-1 [231.089591] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.905s) [231.100830] Starting dynamic subtest: pipe-B-eDP-1 [237.730975] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.640s) [237.733294] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.548s) [238.612472] [038/156] (794s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [238.726979] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [245.498132] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.777s) [245.659312] [039/156] (787s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [245.755112] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [245.757511] Starting dynamic subtest: pipe-A-eDP-1 [247.080504] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.325s) [247.358185] Starting dynamic subtest: pipe-B-eDP-1 [248.404873] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.053s) [248.678352] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.926s) [249.517818] [040/156] (783s left) kms_dsc (dsc-with-output-formats-with-bpc) [249.619132] Starting subtest: dsc-with-output-formats-with-bpc [249.676870] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s) [249.718126] [041/156] (783s left) syncobj_wait (wait-any-interrupted) [249.777925] Starting subtest: wait-any-interrupted [249.886963] Subtest wait-any-interrupted: SUCCESS (0.107s) [249.982530] [042/156] (783s left) gem_exec_fence (syncobj-timeline-signal) [250.526995] Starting subtest: syncobj-timeline-signal [250.534731] Subtest syncobj-timeline-signal: SUCCESS (0.009s) [252.354544] [043/156] (781s left) gem_close_race (multigpu-basic-threads) [252.427053] Starting subtest: multigpu-basic-threads [252.431930] Subtest multigpu-basic-threads: SKIP (0.000s) [252.674015] [044/156] (780s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu) [252.777974] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu [252.782371] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [252.876473] [045/156] (780s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [252.965413] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [252.967725] Starting dynamic subtest: pipe-A [252.988123] Dynamic subtest pipe-A: SKIP (0.018s) [252.998538] Starting dynamic subtest: pipe-B [253.023692] Dynamic subtest pipe-B: SKIP (0.034s) [253.038179] Starting dynamic subtest: pipe-C [253.059937] Dynamic subtest pipe-C: SKIP (0.036s) [253.069816] Starting dynamic subtest: pipe-D [253.092971] Dynamic subtest pipe-D: SKIP (0.033s) [253.097317] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.124s) [253.209254] [046/156] (780s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [253.306993] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [253.309217] Starting dynamic subtest: pipe-A-eDP-1 [255.518725] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.213s) [255.528571] Starting dynamic subtest: pipe-B-eDP-1 [257.999925] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.479s) [258.010352] Starting dynamic subtest: pipe-C-eDP-1 [260.204366] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.204s) [260.214710] Starting dynamic subtest: pipe-D-eDP-1 [262.361291] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.156s) [262.363260] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (9.057s) [263.546857] [047/156] (770s left) gem_userptr_blits (create-destroy-unsync) [263.610922] Subtest create-destroy-unsync: SKIP (0.000s) [263.728681] [048/156] (769s left) gem_exec_reloc (basic-write-gtt) [263.777703] Subtest basic-write-gtt: SKIP (0.000s) [263.857458] [049/156] (769s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [263.977904] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [264.938991] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.961s) [265.782104] [050/156] (767s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render) [265.880499] Starting subtest: hdr-rgb565-draw-render [265.884722] Subtest hdr-rgb565-draw-render: SKIP (0.000s) [265.981418] [051/156] (767s left) perf_pmu (semaphore-wait) [266.022055] Starting subtest: semaphore-wait [266.024546] Starting dynamic subtest: rcs0 [266.535624] Dynamic subtest rcs0: SUCCESS (0.513s) [266.546661] Starting dynamic subtest: bcs0 [267.050259] Dynamic subtest bcs0: SUCCESS (0.512s) [267.062316] Starting dynamic subtest: vcs0 [267.563417] Dynamic subtest vcs0: SUCCESS (0.510s) [267.575852] Starting dynamic subtest: vcs1 [268.076606] Dynamic subtest vcs1: SUCCESS (0.510s) [268.089245] Starting dynamic subtest: vecs0 [268.589877] Dynamic subtest vecs0: SUCCESS (0.511s) [268.603329] Starting dynamic subtest: ccs0 [269.108091] Dynamic subtest ccs0: SUCCESS (0.514s) [269.110966] Subtest semaphore-wait: SUCCESS (3.087s) [270.364840] [052/156] (763s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [270.465893] Starting subtest: compare-crc-sanitycheck-xr24 [270.468074] Starting dynamic subtest: pipe-A-eDP-1 [271.114388] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.649s) [271.125858] Starting dynamic subtest: pipe-B-eDP-1 [272.363349] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.246s) [272.374705] Starting dynamic subtest: pipe-C-eDP-1 [273.641266] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.278s) [273.651682] Starting dynamic subtest: pipe-D-eDP-1 [274.885275] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s) [274.887580] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.422s) [275.703368] [053/156] (758s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt) [275.800927] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt [275.805187] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [275.910082] [054/156] (757s left) syncobj_timeline (single-wait-available-signaled) [275.962040] Starting subtest: single-wait-available-signaled [275.967344] Subtest single-wait-available-signaled: SUCCESS (0.000s) [276.073622] [055/156] (757s left) kms_chamelium_color (ctm-limited-range) [276.171941] Subtest ctm-limited-range: SKIP (0.000s) [276.230047] [056/156] (757s left) gem_ctx_persistence (smoketest) [276.284506] Starting subtest: smoketest [316.256826] Subtest smoketest: SUCCESS (39.970s) [316.336986] [057/156] (717s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [316.441335] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [316.445789] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [316.541900] [058/156] (717s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [316.648804] Starting subtest: pr-overlay-plane-update-continuous-sf [316.653081] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [316.717978] [059/156] (717s left) kms_invalid_mode (bad-hsync-start) [316.806520] Starting subtest: bad-hsync-start [316.809805] Starting dynamic subtest: pipe-A-eDP-1 [317.097036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [317.108222] Starting dynamic subtest: pipe-B-eDP-1 [317.110419] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [317.120584] Starting dynamic subtest: pipe-C-eDP-1 [317.122500] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [317.132054] Starting dynamic subtest: pipe-D-eDP-1 [317.133923] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [317.135855] Subtest bad-hsync-start: SUCCESS (0.295s) [317.928127] [060/156] (716s left) gem_lmem_swapping (massive) [317.969371] Subtest massive: SKIP (0.000s) [318.016091] [061/156] (716s left) gem_exec_balancer (parallel-contexts) [318.277082] Starting subtest: parallel-contexts [321.551223] Subtest parallel-contexts: SUCCESS (3.275s) [322.496263] [062/156] (711s left) kms_async_flips (async-flip-dpms) [322.595781] Starting subtest: async-flip-dpms [322.974461] Starting dynamic subtest: pipe-A-eDP-1 [326.863052] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.887s) [327.245535] Starting dynamic subtest: pipe-B-eDP-1 [330.122435] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.885s) [330.510586] Starting dynamic subtest: pipe-C-eDP-1 [333.302933] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.800s) [333.683199] Starting dynamic subtest: pipe-D-eDP-1 [336.555727] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.878s) [336.557609] Subtest async-flip-dpms: SUCCESS (13.960s) [337.738600] [063/156] (696s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [337.843535] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc [337.847608] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [337.933213] [064/156] (696s left) kms_setmode (basic) [337.990234] Starting subtest: basic [338.311651] Starting dynamic subtest: pipe-A-eDP-1 [340.454548] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.139s) [340.797626] Starting dynamic subtest: pipe-B-eDP-1 [342.883661] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.092s) [343.191799] Subtest basic: SUCCESS (5.199s) [344.033373] [065/156] (690s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render) [344.132055] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render [344.136374] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [344.222871] [066/156] (690s left) kms_cursor_crc (cursor-offscreen-512x170) [344.512612] Starting subtest: cursor-offscreen-512x170 [344.517108] Subtest cursor-offscreen-512x170: SKIP (0.001s) [344.677865] [067/156] (689s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [344.789633] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu [344.793832] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [344.878107] [068/156] (689s left) kms_flip (nonblocking-read) [344.964830] Starting subtest: nonblocking-read [344.966672] Subtest nonblocking-read: SUCCESS (0.000s) [345.050896] [069/156] (689s left) gem_pxp (create-regular-buffer) [345.163792] Starting subtest: create-regular-buffer [345.165893] Subtest create-regular-buffer: SUCCESS (0.000s) [345.281352] [070/156] (689s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping) [345.371770] Starting subtest: pixel-format-y-tiled-modifier-source-clamping [345.375706] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s) [345.448067] [071/156] (689s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [345.529611] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [345.531543] Starting dynamic subtest: pipe-A-eDP-1 [346.370515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s) [346.380889] Starting dynamic subtest: pipe-B-eDP-1 [348.078231] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.703s) [348.091206] Starting dynamic subtest: pipe-C-eDP-1 [349.611388] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.531s) [349.622943] Starting dynamic subtest: pipe-D-eDP-1 [351.114316] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.504s) [351.116150] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.578s) [352.378323] [072/156] (682s left) gem_eio (in-flight-internal-10ms) [352.595034] Starting subtest: in-flight-internal-10ms [354.379025] Subtest in-flight-internal-10ms: SUCCESS (1.784s) [354.501669] [073/156] (680s left) gem_ccs (ctrl-surf-copy) [354.556938] Starting subtest: ctrl-surf-copy [354.561467] Subtest ctrl-surf-copy: SKIP (0.000s) [354.650341] [074/156] (680s left) kms_flip (plain-flip-ts-check-interruptible) [354.754391] Starting subtest: plain-flip-ts-check-interruptible [354.756669] Starting dynamic subtest: A-eDP1 [363.646713] Dynamic subtest A-eDP1: SUCCESS (8.891s) [363.657239] Starting dynamic subtest: B-eDP1 [372.476848] Dynamic subtest B-eDP1: SUCCESS (8.829s) [372.487457] Starting dynamic subtest: C-eDP1 [381.300618] Dynamic subtest C-eDP1: SUCCESS (8.822s) [381.312947] Starting dynamic subtest: D-eDP1 [390.132131] Dynamic subtest D-eDP1: SUCCESS (8.830s) [390.137484] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.381s) [391.314681] [075/156] (643s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs) [391.407879] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs [391.410216] Starting dynamic subtest: pipe-A-eDP-1 [391.430789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [391.443192] Starting dynamic subtest: pipe-B-eDP-1 [391.462754] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [391.472801] Starting dynamic subtest: pipe-C-eDP-1 [391.492483] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [391.502658] Starting dynamic subtest: pipe-D-eDP-1 [391.522169] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [391.524344] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s) [393.660222] [076/156] (641s left) kms_flip (absolute-wf_vblank-interruptible) [393.760414] Starting subtest: absolute-wf_vblank-interruptible [393.762621] Starting dynamic subtest: A-eDP1 [402.521256] Dynamic subtest A-eDP1: SUCCESS (8.759s) [402.532628] Starting dynamic subtest: B-eDP1 [411.256470] Dynamic subtest B-eDP1: SUCCESS (8.733s) [411.272061] Starting dynamic subtest: C-eDP1 [419.970820] Dynamic subtest C-eDP1: SUCCESS (8.711s) [419.983599] Starting dynamic subtest: D-eDP1 [428.695734] Dynamic subtest D-eDP1: SUCCESS (8.724s) [428.698706] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.938s) [429.909488] [077/156] (604s left) kms_chamelium_edid (hdmi-edid-read) [430.307839] Subtest hdmi-edid-read: SKIP (0.000s) [431.125113] [078/156] (603s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-move) [431.232738] Starting subtest: hdr-1p-primscrn-cur-indfb-move [431.236869] Subtest hdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [431.339149] [079/156] (603s left) gem_pipe_control_store_loop (fresh-buffer) [431.391764] Starting subtest: fresh-buffer [433.543644] Subtest fresh-buffer: SUCCESS (2.152s) [433.690486] [080/156] (601s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [433.741991] Starting subtest: x-tiled-to-vebox-y-tiled [433.746057] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [433.928622] [081/156] (601s left) syncobj_timeline (invalid-query-zero-handles) [433.983659] Starting subtest: invalid-query-zero-handles [433.986055] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [434.088851] [082/156] (601s left) core_getstats (basic) [434.154745] Starting subtest: basic [434.157074] Subtest basic: SUCCESS (0.000s) [434.261175] [083/156] (600s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt) [434.367811] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt [434.372209] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [434.483975] [084/156] (600s left) kms_color_pipeline (plane-lut1d-ctm3x4) [434.574624] Starting subtest: plane-lut1d-ctm3x4 [434.754447] Starting dynamic subtest: pipe-A-plane-0 [434.920890] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s) [434.931162] Starting dynamic subtest: pipe-A-plane-1 [435.109811] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s) [435.120100] Starting dynamic subtest: pipe-A-plane-2 [435.264962] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s) [436.462655] Starting dynamic subtest: pipe-B-plane-0 [436.640323] Dynamic subtest pipe-B-plane-0: SUCCESS (0.188s) [436.651238] Starting dynamic subtest: pipe-B-plane-1 [436.818096] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s) [436.829085] Starting dynamic subtest: pipe-B-plane-2 [436.996773] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s) [438.185503] Starting dynamic subtest: pipe-C-plane-0 [438.307719] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [438.318747] Starting dynamic subtest: pipe-C-plane-1 [438.464904] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [438.475999] Starting dynamic subtest: pipe-C-plane-2 [438.619195] Dynamic subtest pipe-C-plane-2: SUCCESS (0.154s) [439.821885] Starting dynamic subtest: pipe-D-plane-0 [439.968577] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s) [439.979404] Starting dynamic subtest: pipe-D-plane-1 [440.101379] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s) [440.111718] Starting dynamic subtest: pipe-D-plane-2 [440.257200] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [440.546899] Subtest plane-lut1d-ctm3x4: SUCCESS (5.973s) [441.367869] [085/156] (593s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [441.455349] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [441.457582] Starting dynamic subtest: pipe-A-default-mode [444.201501] Dynamic subtest pipe-A-default-mode: SUCCESS (2.747s) [444.203875] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.748s) [445.091022] [086/156] (590s left) kms_big_fb (y-tiled-32bpp-rotate-270) [445.189029] Starting subtest: y-tiled-32bpp-rotate-270 [445.193442] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [445.311893] [087/156] (590s left) prime_mmap (test_map_unmap) [445.358706] Starting subtest: test_map_unmap [445.360572] Starting dynamic subtest: test_map_unmap-smem [445.388411] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s) [445.390877] Subtest test_map_unmap: SUCCESS (0.032s) [445.486651] [088/156] (589s left) kms_frontbuffer_tracking (fbchdr-tiling-y) [445.572818] Starting subtest: fbchdr-tiling-y [445.577016] Subtest fbchdr-tiling-y: SKIP (0.000s) [445.686614] [089/156] (589s left) gem_spin_batch (engines) [445.743099] Starting subtest: engines [445.745222] Starting dynamic subtest: rcs0 [448.983607] Dynamic subtest rcs0: SUCCESS (3.239s) [448.996490] Starting dynamic subtest: bcs0 [452.220184] Dynamic subtest bcs0: SUCCESS (3.233s) [452.232792] Starting dynamic subtest: vcs0 [455.460248] Dynamic subtest vcs0: SUCCESS (3.236s) [455.473270] Starting dynamic subtest: vcs1 [458.697377] Dynamic subtest vcs1: SUCCESS (3.235s) [458.709207] Starting dynamic subtest: vecs0 [461.934993] Dynamic subtest vecs0: SUCCESS (3.234s) [461.945601] Starting dynamic subtest: ccs0 [465.173604] Dynamic subtest ccs0: SUCCESS (3.236s) [465.176214] Subtest engines: SUCCESS (19.430s) [465.409423] [090/156] (570s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [465.511337] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [465.515645] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [465.590985] [091/156] (569s left) gem_exec_gttfill (multigpu-basic) [465.755826] Starting subtest: multigpu-basic [479.454063] Subtest multigpu-basic: SUCCESS (13.698s) [479.511220] [092/156] (556s left) gem_lmem_swapping (verify-random-ccs) [479.602508] Subtest verify-random-ccs: SKIP (0.000s) [479.651057] [093/156] (555s left) syncobj_timeline (reset-signaled) [479.707067] Starting subtest: reset-signaled [479.709587] Subtest reset-signaled: SUCCESS (0.000s) [479.807471] [094/156] (555s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [479.875239] Subtest writes-after-reads: SKIP (0.000s) [479.949009] [095/156] (555s left) gem_exec_nop (basic-series) [480.022075] Starting subtest: basic-series [494.718663] Subtest basic-series: SUCCESS (14.703s) [494.945030] [096/156] (540s left) gen9_exec_parse (bb-chained) [495.011532] Subtest bb-chained: SKIP (0.000s) [495.082601] [097/156] (540s left) syncobj_wait (wait-delayed-signal) [495.135494] Starting subtest: wait-delayed-signal [495.239746] Subtest wait-delayed-signal: SUCCESS (0.103s) [495.341496] [098/156] (540s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [495.401045] Subtest no-spare-fences-interruptible: SKIP (0.000s) [495.474069] [099/156] (540s left) kms_big_fb (x-tiled-16bpp-rotate-90) [495.592918] Starting subtest: x-tiled-16bpp-rotate-90 [495.616417] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s) [495.730619] [100/156] (540s left) kms_big_fb (linear-32bpp-rotate-90) [495.829294] Starting subtest: linear-32bpp-rotate-90 [495.849617] Subtest linear-32bpp-rotate-90: SKIP (0.020s) [495.956984] [101/156] (539s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [496.048602] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [496.052708] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [496.157198] [102/156] (539s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render) [496.250829] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render [496.255259] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [496.340642] [103/156] (539s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render) [496.436133] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render [496.439524] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [496.529209] [104/156] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [496.624883] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [496.628536] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [496.706873] [105/156] (539s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [496.806071] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [497.508539] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.703s) [497.681020] [106/156] (538s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt) [497.793979] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt [497.798232] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [497.890077] [107/156] (538s left) gem_ctx_param (invalid-param-set) [497.930774] Starting subtest: invalid-param-set [497.933045] Subtest invalid-param-set: SUCCESS (0.000s) [497.998466] [108/156] (538s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [498.091966] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [498.096129] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [498.191309] [109/156] (538s left) gem_exec_reloc (basic-wc-cpu-noreloc) [498.249342] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [498.349221] [110/156] (537s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [498.451291] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [498.454798] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [498.557146] [111/156] (537s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [498.655988] Starting subtest: yf-tiled-16bpp-rotate-0 [498.659836] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [498.754507] [112/156] (537s left) syncobj_wait (single-wait-for-submit-submitted) [498.798625] Starting subtest: single-wait-for-submit-submitted [498.902302] Subtest single-wait-for-submit-submitted: SUCCESS (0.103s) [498.987128] [113/156] (537s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [499.081354] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [499.085268] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [499.168657] [114/156] (537s left) kms_psr (psr2-primary-mmap-cpu) [499.270584] Starting subtest: psr2-primary-mmap-cpu [499.272959] Starting dynamic subtest: eDP-1 [501.060241] Dynamic subtest eDP-1: SUCCESS (1.789s) [501.062624] Subtest psr2-primary-mmap-cpu: SUCCESS (1.790s) [501.933489] [115/156] (534s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary) [502.045258] Starting subtest: psrhdr-indfb-scaledprimary [502.049452] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s) [502.163330] [116/156] (534s left) gem_eio (kms) [502.434958] Starting subtest: kms [522.360699] Subtest kms: SUCCESS (19.924s) [523.556474] [117/156] (513s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [523.681345] Starting subtest: cursorB-vs-flipB-atomic [523.685947] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [523.832231] [118/156] (512s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [523.892329] Starting subtest: y-tiled-to-vebox-x-tiled [523.897019] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [524.078592] [119/156] (512s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [524.186160] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [524.190346] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [524.290075] [120/156] (512s left) gen9_exec_parse (unaligned-access) [524.355954] Subtest unaligned-access: SKIP (0.000s) [524.434934] [121/156] (512s left) gem_exec_schedule (noreorder-corked) [524.620567] Starting subtest: noreorder-corked [524.622980] Starting dynamic subtest: rcs0 [525.762977] Dynamic subtest rcs0: SUCCESS (1.143s) [525.776812] Starting dynamic subtest: vcs0 [527.292330] Dynamic subtest vcs0: SUCCESS (1.526s) [527.304648] Starting dynamic subtest: vcs1 [529.284734] Dynamic subtest vcs1: SUCCESS (1.989s) [529.298133] Starting dynamic subtest: vecs0 [531.328664] Dynamic subtest vecs0: SUCCESS (2.041s) [531.343244] Starting dynamic subtest: ccs0 [532.483237] Dynamic subtest ccs0: SUCCESS (1.153s) [532.485947] Subtest noreorder-corked: SUCCESS (7.864s) [532.682281] [122/156] (504s left) kms_plane (plane-position-covered) [532.793921] Starting subtest: plane-position-covered [533.320683] Starting dynamic subtest: pipe-A-plane-1 [534.618949] Dynamic subtest pipe-A-plane-1: SUCCESS (1.299s) [534.631468] Starting dynamic subtest: pipe-A-plane-2 [535.944755] Dynamic subtest pipe-A-plane-2: SUCCESS (1.325s) [535.957514] Starting dynamic subtest: pipe-A-plane-3 [537.318413] Dynamic subtest pipe-A-plane-3: SUCCESS (1.372s) [537.329294] Starting dynamic subtest: pipe-A-plane-4 [538.643951] Dynamic subtest pipe-A-plane-4: SUCCESS (1.327s) [538.657853] Starting dynamic subtest: pipe-A-plane-5 [538.672839] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s) [539.860583] Starting dynamic subtest: pipe-B-plane-1 [541.187573] Dynamic subtest pipe-B-plane-1: SUCCESS (1.339s) [541.199950] Starting dynamic subtest: pipe-B-plane-2 [542.512047] Dynamic subtest pipe-B-plane-2: SUCCESS (1.324s) [542.523311] Starting dynamic subtest: pipe-B-plane-3 [543.856949] Dynamic subtest pipe-B-plane-3: SUCCESS (1.343s) [543.867886] Starting dynamic subtest: pipe-B-plane-4 [545.162462] Dynamic subtest pipe-B-plane-4: SUCCESS (1.305s) [545.175892] Starting dynamic subtest: pipe-B-plane-5 [545.189992] Dynamic subtest pipe-B-plane-5: SUCCESS (0.027s) [545.192353] Subtest plane-position-covered: SUCCESS (12.395s) [545.976065] [123/156] (490s left) kms_pm_dc (dc5-dpms-negative) [547.069263] Starting subtest: dc5-dpms-negative [547.073707] Subtest dc5-dpms-negative: SKIP (0.000s) [547.145318] [124/156] (489s left) gem_mmap_gtt (basic-small-copy-odd) [547.203580] Subtest basic-small-copy-odd: SKIP (0.000s) [547.261390] [125/156] (489s left) kms_cursor_crc (cursor-sliding-max-size) [547.568116] Starting subtest: cursor-sliding-max-size [547.574633] Subtest cursor-sliding-max-size: SKIP (0.000s) [547.699026] [126/156] (489s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff) [547.804636] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff [547.808730] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [547.906202] [127/156] (489s left) kms_psr (fbc-psr2-primary-render) [548.000423] Starting subtest: fbc-psr2-primary-render [548.002722] Starting dynamic subtest: eDP-1 [548.006754] Dynamic subtest eDP-1: SKIP (0.000s) [548.010799] Subtest fbc-psr2-primary-render: SKIP (0.001s) [548.074373] [128/156] (489s left) gem_mmap_wc (fault-concurrent) [548.123020] Subtest fault-concurrent: SKIP (0.000s) [548.194200] [129/156] (488s left) kms_pm_rpm (pc8-residency) [550.429218] Starting subtest: pc8-residency [550.434474] Subtest pc8-residency: SKIP (0.000s) [550.848648] [130/156] (486s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [550.938833] Starting subtest: multiplane-rotation-cropping-bottom [568.409790] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.471s) [568.550939] [131/156] (468s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [568.654155] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [568.657489] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [568.770029] [132/156] (468s left) i915_hangman (engine-engine-error) [568.821076] Starting subtest: engine-engine-error [568.822834] Starting dynamic subtest: rcs0 [570.272737] Dynamic subtest rcs0: SUCCESS (1.451s) [570.285445] Starting dynamic subtest: bcs0 [572.256239] Dynamic subtest bcs0: SUCCESS (1.980s) [572.270410] Starting dynamic subtest: vcs0 [574.241063] Dynamic subtest vcs0: SUCCESS (1.982s) [574.254758] Starting dynamic subtest: vcs1 [576.289407] Dynamic subtest vcs1: SUCCESS (2.045s) [576.305101] Starting dynamic subtest: vecs0 [578.272898] Dynamic subtest vecs0: SUCCESS (1.980s) [578.287537] Starting dynamic subtest: ccs0 [580.257093] Dynamic subtest ccs0: SUCCESS (1.981s) [580.259901] Subtest engine-engine-error: SUCCESS (11.438s) [580.343955] [133/156] (456s left) gem_exec_whisper (basic-contexts) [580.403940] Starting subtest: basic-contexts [588.981074] Subtest basic-contexts: SUCCESS (8.576s) [589.169971] [134/156] (448s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [589.304714] Starting subtest: basic-flip-before-cursor-varying-size [590.230557] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.925s) [591.053725] [135/156] (446s left) syncobj_wait (reset-unsignaled) [591.111584] Starting subtest: reset-unsignaled [591.113837] Subtest reset-unsignaled: SUCCESS (0.000s) [591.229462] [136/156] (446s left) i915_pm_rpm (debugfs-forcewake-user) [593.457339] Starting subtest: debugfs-forcewake-user [604.855833] Subtest debugfs-forcewake-user: SUCCESS (11.401s) [605.253072] [137/156] (432s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [605.361846] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [609.812332] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.457s) [611.035920] [138/156] (426s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [611.143954] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [611.146271] Starting dynamic subtest: pipe-A-eDP-1 [611.166279] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [611.180229] Starting dynamic subtest: pipe-B-eDP-1 [611.199348] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [611.210866] Starting dynamic subtest: pipe-C-eDP-1 [611.230480] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [611.241087] Starting dynamic subtest: pipe-D-eDP-1 [611.259349] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [611.261461] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [613.491730] [139/156] (424s left) kms_chamelium_hpd (vga-hpd) [613.878570] Subtest vga-hpd: SKIP (0.000s) [614.689915] [140/156] (422s left) gem_mmap_gtt (hang-busy) [614.747827] Subtest hang-busy: SKIP (0.000s) [614.814176] [141/156] (422s left) kms_addfb_basic (unused-handle) [614.870490] Starting subtest: unused-handle [614.872493] Subtest unused-handle: SUCCESS (0.000s) [615.023098] [142/156] (422s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [615.117890] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [622.466805] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.354s) [622.611606] [143/156] (415s left) gem_pipe_control_store_loop (reused-buffer) [622.676116] Starting subtest: reused-buffer [624.827542] Subtest reused-buffer: SUCCESS (2.151s) [624.938290] [144/156] (412s left) dumb_buffer (create-valid-dumb) [625.000622] Starting subtest: create-valid-dumb [625.002503] Subtest create-valid-dumb: SUCCESS (0.000s) [625.093215] [145/156] (412s left) gem_wait (await) [625.157846] Starting subtest: await [625.160031] Starting dynamic subtest: all-engines [626.301966] Dynamic subtest all-engines: SUCCESS (1.146s) [626.321275] Starting dynamic subtest: rcs0 [627.368114] Dynamic subtest rcs0: SUCCESS (1.063s) [627.388626] Starting dynamic subtest: bcs0 [628.430120] Dynamic subtest bcs0: SUCCESS (1.060s) [628.450008] Starting dynamic subtest: vcs0 [629.485616] Dynamic subtest vcs0: SUCCESS (1.053s) [629.504847] Starting dynamic subtest: vcs1 [630.539892] Dynamic subtest vcs1: SUCCESS (1.052s) [630.558302] Starting dynamic subtest: vecs0 [631.598149] Dynamic subtest vecs0: SUCCESS (1.056s) [631.615774] Starting dynamic subtest: ccs0 [632.657195] Dynamic subtest ccs0: SUCCESS (1.056s) [632.660038] Subtest await: SUCCESS (7.502s) [632.854955] [146/156] (405s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [632.947310] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [632.949644] Starting dynamic subtest: pipe-A-default-mode [635.673513] Dynamic subtest pipe-A-default-mode: SUCCESS (2.726s) [635.675841] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.728s) [636.513076] [147/156] (401s left) i915_selftest (perf) [639.823647] Starting subtest: perf [639.830500] Starting dynamic subtest: engine_cs [644.226513] Dynamic subtest engine_cs: SUCCESS (4.401s) [644.238069] Starting dynamic subtest: request [649.567891] Dynamic subtest request: SUCCESS (5.339s) [649.578796] Starting dynamic subtest: migrate [653.910019] Dynamic subtest migrate: SUCCESS (4.340s) [653.920998] Starting dynamic subtest: region [659.724334] Dynamic subtest region: SUCCESS (5.812s) [659.727132] Subtest perf: SUCCESS (19.901s) [659.757890] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [659.760034] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [659.764108] [148/156] (378s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render) [661.375327] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render [661.379787] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [661.486205] [FACT kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [661.487400] [FACT kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true [661.491680] [149/156] (376s left) kms_pipe_crc_basic (nonblocking-crc) [661.596304] Starting subtest: nonblocking-crc [661.598230] Starting dynamic subtest: pipe-A-eDP-1 [662.385563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.790s) [662.400735] Starting dynamic subtest: pipe-B-eDP-1 [663.805667] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.418s) [663.818633] Starting dynamic subtest: pipe-C-eDP-1 [665.176267] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s) [665.187378] Starting dynamic subtest: pipe-D-eDP-1 [666.529655] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s) [666.532081] Subtest nonblocking-crc: SUCCESS (4.933s) [667.405678] [150/156] (370s left) kms_dirtyfb (psr-dirtyfb-ioctl) [667.496085] Starting subtest: psr-dirtyfb-ioctl [667.498267] Starting dynamic subtest: A-eDP-1 [671.410947] Dynamic subtest A-eDP-1: SUCCESS (3.913s) [671.413021] Subtest psr-dirtyfb-ioctl: SUCCESS (3.915s) [672.217300] [151/156] (365s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [672.326683] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [672.331163] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [672.426045] [152/156] (365s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-move) [672.522523] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-move [672.526697] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [672.622148] [153/156] (365s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt) [672.719767] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt [672.724246] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [672.814178] [154/156] (365s left) gem_exec_balancer (parallel-keep-submit-fence) [673.076018] Starting subtest: parallel-keep-submit-fence [674.201079] Subtest parallel-keep-submit-fence: SUCCESS (1.125s) [674.323062] [155/156] (363s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [674.413827] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc [674.418163] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [674.517270] [156/156] (363s left) kms_vblank (query-forked-busy) [674.601123] Starting subtest: query-forked-busy [674.602944] Starting dynamic subtest: pipe-A-eDP-1 [676.476723] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s) [676.493354] Starting dynamic subtest: pipe-D-eDP-1 [679.091251] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.612s) [679.093081] Subtest query-forked-busy: SUCCESS (4.490s) [679.980295] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_psr results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: sriov_basic results: parsing output: 5/ for test: syncobj_wait results: parsing output: 6/ for test: kms_flip results: parsing output: 7/ for test: gem_eio results: parsing output: 8/ for test: syncobj_timeline results: parsing output: 9/ for test: syncobj_wait results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_cursor_crc results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: sysfs_heartbeat_interval results: parsing output: 14/ for test: gem_render_copy results: parsing output: 15/ for test: kms_busy results: parsing output: 16/ for test: kms_psr results: parsing output: 17/ for test: gem_exec_schedule results: parsing output: 18/ for test: kms_atomic results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: kms_invalid_mode results: parsing output: 21/ for test: kms_content_protection results: parsing output: 22/ for test: kms_vblank results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: gem_eio results: parsing output: 26/ for test: gem_mmap_gtt results: parsing output: 27/ for test: perf results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_atomic_transition results: parsing output: 30/ for test: gem_eio results: parsing output: 31/ for test: kms_plane_multiple results: parsing output: 32/ for test: gem_ctx_isolation results: parsing output: 33/ for test: api_intel_bb results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_psr2_sf results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_atomic_transition results: parsing output: 39/ for test: kms_dsc results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: gem_exec_fence results: parsing output: 42/ for test: gem_close_race results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_plane_scaling results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: gem_userptr_blits results: parsing output: 47/ for test: gem_exec_reloc results: parsing output: 48/ for test: kms_cursor_legacy results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: perf_pmu results: parsing output: 51/ for test: kms_pipe_crc_basic results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: syncobj_timeline results: parsing output: 54/ for test: kms_chamelium_color results: parsing output: 55/ for test: gem_ctx_persistence results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: kms_psr2_sf results: parsing output: 58/ for test: kms_invalid_mode results: parsing output: 59/ for test: gem_lmem_swapping results: parsing output: 60/ for test: gem_exec_balancer results: parsing output: 61/ for test: kms_async_flips results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_setmode results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_cursor_crc results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: gem_pxp results: parsing output: 69/ for test: kms_plane results: parsing output: 70/ for test: kms_ccs results: parsing output: 71/ for test: gem_eio results: parsing output: 72/ for test: gem_ccs results: parsing output: 73/ for test: kms_flip results: parsing output: 74/ for test: kms_ccs results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: kms_chamelium_edid results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_pipe_control_store_loop results: parsing output: 79/ for test: gem_render_copy results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: core_getstats results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_color_pipeline results: parsing output: 84/ for test: kms_flip_scaled_crc results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: prime_mmap results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: gem_spin_batch results: parsing output: 89/ for test: kms_psr2_sf results: parsing output: 90/ for test: gem_exec_gttfill results: parsing output: 91/ for test: gem_lmem_swapping results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 94/ for test: gem_exec_nop results: parsing output: 95/ for test: gen9_exec_parse results: parsing output: 96/ for test: syncobj_wait results: parsing output: 97/ for test: gem_fenced_exec_thrash results: parsing output: 98/ for test: kms_big_fb results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: gem_ctx_param results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: gem_exec_reloc results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: syncobj_wait results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: gem_eio results: parsing output: 116/ for test: kms_cursor_legacy results: parsing output: 117/ for test: gem_render_copy results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gen9_exec_parse results: parsing output: 120/ for test: gem_exec_schedule results: parsing output: 121/ for test: kms_plane results: parsing output: 122/ for test: kms_pm_dc results: parsing output: 123/ for test: gem_mmap_gtt results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: gem_mmap_wc results: parsing output: 128/ for test: kms_pm_rpm results: parsing output: 129/ for test: kms_rotation_crc results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: i915_hangman results: parsing output: 132/ for test: gem_exec_whisper results: parsing output: 133/ for test: kms_cursor_legacy results: parsing output: 134/ for test: syncobj_wait results: parsing output: 135/ for test: i915_pm_rpm results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_ccs results: parsing output: 138/ for test: kms_chamelium_hpd results: parsing output: 139/ for test: gem_mmap_gtt results: parsing output: 140/ for test: kms_addfb_basic results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: gem_pipe_control_store_loop results: parsing output: 143/ for test: dumb_buffer results: parsing output: 144/ for test: gem_wait results: parsing output: 145/ for test: kms_flip_scaled_crc results: parsing output: 146/ for test: i915_selftest results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_pipe_crc_basic results: parsing output: 149/ for test: kms_dirtyfb results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: gem_exec_balancer results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: kms_vblank Done.