[59.004719] Initializing watchdogs [59.004768] /dev/watchdog0 [59.019171] [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] [59.023614] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.026090] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.029357] [001/131] (960s left) kms_addfb_basic (bad-pitch-0) [59.118975] Starting subtest: bad-pitch-0 [59.121474] Subtest bad-pitch-0: SUCCESS (0.000s) [59.275458] [002/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [59.376378] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [59.380389] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [59.493687] [003/131] (960s left) kms_big_fb (x-tiled-64bpp-rotate-90) [59.596710] Starting subtest: x-tiled-64bpp-rotate-90 [59.629266] Subtest x-tiled-64bpp-rotate-90: SKIP (0.032s) [59.770568] [004/131] (959s left) kms_vrr (negative-basic) [59.871033] Starting subtest: negative-basic [59.876406] Starting dynamic subtest: pipe-A-eDP-1 [65.310305] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.412s) [65.610124] Subtest negative-basic: SUCCESS (5.728s) [66.489402] [005/131] (953s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [66.548903] Starting subtest: etime-multi-wait-available-unsubmitted [66.657252] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s) [66.754846] [006/131] (952s left) gem_exec_fence (syncobj-channel) [67.338686] Starting subtest: syncobj-channel [68.361910] Subtest syncobj-channel: SUCCESS (1.021s) [69.004869] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true [69.007985] [007/131] (950s left) perf_pmu (interrupts-sync) [69.054118] Starting subtest: interrupts-sync [70.155411] Subtest interrupts-sync: SUCCESS (1.099s) [70.308641] [008/131] (949s left) kms_plane_multiple (2x-tiling-x) [70.405805] Starting subtest: 2x-tiling-x [70.409981] Subtest 2x-tiling-x: SKIP (0.000s) [70.499538] [009/131] (949s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [70.605431] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [71.241119] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s) [71.439889] [010/131] (948s left) kms_big_fb (linear-64bpp-rotate-270) [71.547434] Starting subtest: linear-64bpp-rotate-270 [71.566818] Subtest linear-64bpp-rotate-270: SKIP (0.019s) [71.736728] [011/131] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [71.844032] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [76.567936] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.724s) [77.709224] [012/131] (942s left) gem_exec_whisper (basic-contexts-forked) [77.779616] Starting subtest: basic-contexts-forked [102.412801] Subtest basic-contexts-forked: SUCCESS (24.627s) [102.612571] [013/131] (917s left) sw_sync (alloc_fence) [102.653858] Starting subtest: alloc_fence [102.656287] Subtest alloc_fence: SUCCESS (0.000s) [102.737408] [014/131] (917s left) i915_query (query-garbage) [102.790867] Starting subtest: query-garbage [102.793179] Subtest query-garbage: SUCCESS (0.000s) [102.916993] [015/131] (917s left) gem_exec_reloc (basic-cpu-gtt-active) [103.000801] Subtest basic-cpu-gtt-active: SKIP (0.000s) [103.093294] [016/131] (917s left) gem_exec_endless (dispatch) [103.161082] Starting subtest: dispatch [103.163397] Starting dynamic subtest: rcs0 [103.169661] Dynamic subtest rcs0: SUCCESS (0.005s) [103.178960] Starting dynamic subtest: bcs0 [103.183422] Dynamic subtest bcs0: SUCCESS (0.004s) [103.191293] Starting dynamic subtest: vcs0 [103.195578] Dynamic subtest vcs0: SUCCESS (0.005s) [103.203085] Starting dynamic subtest: vcs1 [103.207164] Dynamic subtest vcs1: SUCCESS (0.005s) [103.214629] Starting dynamic subtest: vecs0 [103.218722] Dynamic subtest vecs0: SUCCESS (0.004s) [103.226253] Starting dynamic subtest: ccs0 [103.230449] Dynamic subtest ccs0: SUCCESS (0.005s) [103.232589] Subtest dispatch: SUCCESS (0.030s) [104.983471] [017/131] (915s left) kms_selftest (drm_dp_mst_helper) [105.021846] Starting subtest: drm_dp_mst_helper [105.081027] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [105.232319] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.154s) [105.242421] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [105.367294] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.134s) [105.375251] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [105.505617] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.139s) [105.507653] Subtest drm_dp_mst_helper: SUCCESS (0.483s) [105.720555] [018/131] (914s left) kms_big_fb (y-tiled-64bpp-rotate-0) [105.825644] Starting subtest: y-tiled-64bpp-rotate-0 [105.830150] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [105.968057] [019/131] (914s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [106.070389] Starting subtest: fbc-rgb565-draw-mmap-cpu [110.187184] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.122s) [111.402097] [020/131] (908s left) gem_mmap_wc (bad-size) [111.456235] Subtest bad-size: SKIP (0.000s) [111.521806] [021/131] (908s left) gem_mmap_gtt (basic-read-write) [111.581165] Subtest basic-read-write: SKIP (0.000s) [111.658803] [022/131] (908s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [111.761764] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [118.895765] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.136s) [119.089990] [023/131] (901s left) kms_psr (psr-cursor-plane-onoff) [119.201955] Starting subtest: psr-cursor-plane-onoff [119.204325] Starting dynamic subtest: eDP-1 [120.882975] Dynamic subtest eDP-1: SUCCESS (1.682s) [120.885216] Subtest psr-cursor-plane-onoff: SUCCESS (1.683s) [121.772716] [024/131] (898s left) dmabuf_sync_file (export-wait-after-attach) [121.813852] Starting subtest: export-wait-after-attach [121.816019] Subtest export-wait-after-attach: SUCCESS (0.000s) [121.892116] [025/131] (898s left) kms_pm_rpm (modeset-lpsp-stress) [124.119769] Starting subtest: modeset-lpsp-stress [140.478538] Subtest modeset-lpsp-stress: SUCCESS (16.361s) [140.594842] [026/131] (879s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [140.698257] Starting subtest: plane-upscale-20x20-with-rotation [140.700564] Starting dynamic subtest: pipe-A [140.923056] Dynamic subtest pipe-A: SUCCESS (0.227s) [140.931969] Starting dynamic subtest: pipe-B [142.221139] Dynamic subtest pipe-B: SUCCESS (1.297s) [142.230554] Starting dynamic subtest: pipe-C [143.544040] Dynamic subtest pipe-C: SUCCESS (1.322s) [143.553453] Starting dynamic subtest: pipe-D [144.874706] Dynamic subtest pipe-D: SUCCESS (1.330s) [144.876937] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.180s) [146.089221] [027/131] (874s left) prime_vgem (basic-fence-flip) [146.176726] Starting subtest: basic-fence-flip [146.468811] Subtest basic-fence-flip: SUCCESS (0.292s) [146.610293] [028/131] (873s left) gem_mmap_gtt (big-copy-xy) [146.667150] Subtest big-copy-XY: SKIP (0.000s) [146.733441] [029/131] (873s left) kms_cursor_crc (cursor-onscreen-512x512) [146.999527] Starting subtest: cursor-onscreen-512x512 [147.003891] Subtest cursor-onscreen-512x512: SKIP (0.001s) [147.191844] [030/131] (873s left) i915_pm_sseu (full-enable) [147.257589] Subtest full-enable: SKIP (0.000s) [147.375904] [031/131] (873s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [147.465109] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [147.466993] Starting dynamic subtest: pipe-A-eDP-1 [147.489360] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [147.504906] Starting dynamic subtest: pipe-B-eDP-1 [147.525192] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [147.532665] Starting dynamic subtest: pipe-C-eDP-1 [147.560043] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [147.567547] Starting dynamic subtest: pipe-D-eDP-1 [147.586755] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [147.590085] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [149.654674] [032/131] (871s left) kms_dp_link_training (non-uhbr-sst) [149.745244] Starting subtest: non-uhbr-sst [149.753796] Subtest non-uhbr-sst: SKIP (0.000s) [149.842521] [033/131] (870s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [149.933151] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [149.935464] Starting dynamic subtest: pipe-A-eDP-1 [149.961297] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [149.975664] Starting dynamic subtest: pipe-B-eDP-1 [149.999919] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [150.008885] Starting dynamic subtest: pipe-C-eDP-1 [150.032604] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [150.040790] Starting dynamic subtest: pipe-D-eDP-1 [150.064609] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [150.068934] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s) [152.226643] [034/131] (868s left) gem_pxp (regular-baseline-src-copy-readible) [152.367119] Starting subtest: regular-baseline-src-copy-readible [152.427923] Subtest regular-baseline-src-copy-readible: SUCCESS (0.063s) [152.596431] [035/131] (868s left) gem_exec_flush (basic-wb-rw-default) [152.672305] Starting subtest: basic-wb-rw-default [158.126867] Subtest basic-wb-rw-default: SUCCESS (5.454s) [158.338460] [036/131] (862s left) syncobj_timeline (signal-array) [158.406189] Starting subtest: signal-array [158.408504] Subtest signal-array: SUCCESS (0.001s) [158.533723] [037/131] (862s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [158.655324] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [159.668585] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.015s) [159.860763] [038/131] (861s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [159.965562] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [159.968773] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [160.082907] [039/131] (860s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [160.141196] Subtest writes-after-reads-uncached: SKIP (0.000s) [160.203031] [040/131] (860s left) gem_flink_basic (bad-open) [160.259488] Starting subtest: bad-open [160.261461] Subtest bad-open: SUCCESS (0.000s) [160.380502] [041/131] (860s left) gem_ctx_shared (q-promotion) [160.457677] Starting subtest: Q-promotion [160.459731] Starting dynamic subtest: rcs0 [160.563628] Dynamic subtest rcs0: SUCCESS (0.105s) [160.581886] Starting dynamic subtest: vcs0 [160.648069] Dynamic subtest vcs0: SUCCESS (0.084s) [160.664418] Starting dynamic subtest: vcs1 [160.724035] Dynamic subtest vcs1: SUCCESS (0.076s) [160.738569] Starting dynamic subtest: vecs0 [160.800524] Dynamic subtest vecs0: SUCCESS (0.075s) [160.815941] Starting dynamic subtest: ccs0 [160.875067] Dynamic subtest ccs0: SUCCESS (0.073s) [160.877364] Subtest Q-promotion: SUCCESS (0.417s) [162.074923] [042/131] (859s left) kms_cursor_legacy (forked-bo) [162.199128] Starting subtest: forked-bo [162.200920] Starting dynamic subtest: pipe-A [167.657896] Dynamic subtest pipe-A: SUCCESS (5.456s) [167.670557] Starting dynamic subtest: pipe-B [173.138100] Dynamic subtest pipe-B: SUCCESS (5.477s) [173.148184] Starting dynamic subtest: pipe-C [178.621187] Dynamic subtest pipe-C: SUCCESS (5.480s) [178.631161] Starting dynamic subtest: pipe-D [184.095085] Dynamic subtest pipe-D: SUCCESS (5.472s) [184.104668] Starting dynamic subtest: all-pipes [189.632900] Dynamic subtest all-pipes: SUCCESS (5.536s) [189.635697] Subtest forked-bo: SUCCESS (27.430s) [189.805920] [043/131] (831s left) gem_readwrite (new-obj) [189.876249] Subtest new-obj: SKIP (0.000s) [189.945295] [044/131] (831s left) kms_busy (extended-modeset-hang-newfb) [190.057812] Starting subtest: extended-modeset-hang-newfb [190.059994] Starting dynamic subtest: pipe-A [224.866057] Dynamic subtest pipe-A: SUCCESS (34.807s) [224.880073] Starting dynamic subtest: pipe-D [247.834918] Dynamic subtest pipe-D: SUCCESS (22.965s) [247.837159] Subtest extended-modeset-hang-newfb: SUCCESS (57.777s) [248.655454] [045/131] (772s left) kms_color (ctm-0-50) [248.748911] Starting subtest: ctm-0-50 [248.750766] Starting dynamic subtest: pipe-A-eDP-1 [252.244454] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.494s) [252.253560] Starting dynamic subtest: pipe-B-eDP-1 [256.370767] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.125s) [256.380113] Starting dynamic subtest: pipe-C-eDP-1 [260.346458] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.977s) [260.356712] Starting dynamic subtest: pipe-D-eDP-1 [264.338186] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.992s) [264.340450] Subtest ctm-0-50: SUCCESS (15.591s) [265.184818] [046/131] (756s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [265.275975] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [265.277868] Starting dynamic subtest: pipe-A-eDP-1 [267.345485] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.068s) [267.354523] Starting dynamic subtest: pipe-B-eDP-1 [269.703245] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.358s) [269.711128] Starting dynamic subtest: pipe-C-eDP-1 [271.894422] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.190s) [271.906579] Starting dynamic subtest: pipe-D-eDP-1 [273.973332] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.078s) [273.975447] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.699s) [275.214075] [047/131] (746s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [275.327564] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [275.332083] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [275.458882] [048/131] (745s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [275.559099] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [275.563318] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [275.702526] [049/131] (745s left) i915_drm_fdinfo (busy) [275.743413] Starting subtest: busy [275.745699] Starting dynamic subtest: rcs0 [275.765051] Dynamic subtest rcs0: SKIP (0.023s) [275.774034] Starting dynamic subtest: bcs0 [275.793925] Dynamic subtest bcs0: SKIP (0.028s) [275.802234] Starting dynamic subtest: vcs0 [275.806129] Dynamic subtest vcs0: SKIP (0.001s) [275.814220] Starting dynamic subtest: vcs1 [275.818442] Dynamic subtest vcs1: SKIP (0.000s) [275.826427] Starting dynamic subtest: vecs0 [275.830373] Dynamic subtest vecs0: SKIP (0.000s) [275.838089] Starting dynamic subtest: ccs0 [275.842099] Dynamic subtest ccs0: SKIP (0.000s) [275.846112] Subtest busy: SKIP (0.058s) [275.892328] [050/131] (745s left) kms_addfb_basic (bad-pitch-32) [275.944634] Starting subtest: bad-pitch-32 [275.946746] Subtest bad-pitch-32: SUCCESS (0.000s) [276.126954] [051/131] (745s left) sysfs_heartbeat_interval (invalid) [276.183344] Starting subtest: invalid [276.185322] Starting dynamic subtest: vecs0 [276.187349] Dynamic subtest vecs0: SUCCESS (0.000s) [276.197327] Starting dynamic subtest: ccs0 [276.198920] Dynamic subtest ccs0: SUCCESS (0.000s) [276.206299] Starting dynamic subtest: vcs0 [276.207876] Dynamic subtest vcs0: SUCCESS (0.000s) [276.215142] Starting dynamic subtest: bcs0 [276.216702] Dynamic subtest bcs0: SUCCESS (0.000s) [276.224074] Starting dynamic subtest: rcs0 [276.225638] Dynamic subtest rcs0: SUCCESS (0.000s) [276.233033] Starting dynamic subtest: vcs1 [276.234595] Dynamic subtest vcs1: SUCCESS (0.000s) [276.236134] Subtest invalid: SUCCESS (0.005s) [276.322580] [052/131] (745s left) kms_atomic (test-only) [276.423468] Starting subtest: test-only [276.470459] Starting dynamic subtest: pipe-A-eDP-1 [278.987328] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.515s) [278.989482] Subtest test-only: SUCCESS (2.564s) [279.807730] [053/131] (741s left) kms_sequence (get-busy) [279.919373] Starting subtest: get-busy [279.921316] Starting dynamic subtest: pipe-A-eDP-1 [281.843961] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s) [281.853305] Starting dynamic subtest: pipe-B-eDP-1 [284.482825] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.640s) [284.491738] Starting dynamic subtest: pipe-C-eDP-1 [287.106680] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.621s) [287.124183] Starting dynamic subtest: pipe-D-eDP-1 [289.652605] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s) [289.654550] Subtest get-busy: SUCCESS (9.732s) [290.471263] [054/131] (731s left) kms_invalid_mode (zero-hdisplay) [290.573925] Starting subtest: zero-hdisplay [290.576198] Starting dynamic subtest: pipe-A-eDP-1 [290.868339] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s) [290.877116] Starting dynamic subtest: pipe-B-eDP-1 [290.879264] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [290.887171] Starting dynamic subtest: pipe-C-eDP-1 [290.889329] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [290.897198] Starting dynamic subtest: pipe-D-eDP-1 [290.899069] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [290.900947] Subtest zero-hdisplay: SUCCESS (0.303s) [291.712342] [055/131] (729s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [291.816043] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [295.525461] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.714s) [296.701572] [056/131] (725s left) gem_softpin (allocator-evict) [296.762654] Starting subtest: allocator-evict [296.765105] Starting dynamic subtest: rcs0 [320.108287] Dynamic subtest rcs0: SUCCESS (23.343s) [320.117998] Starting dynamic subtest: bcs0 [343.730574] Dynamic subtest bcs0: SUCCESS (23.619s) [343.741325] Starting dynamic subtest: vcs0 [367.675820] Dynamic subtest vcs0: SUCCESS (23.942s) [367.687697] Starting dynamic subtest: vcs1 [391.664940] Dynamic subtest vcs1: SUCCESS (23.986s) [391.676698] Starting dynamic subtest: vecs0 [415.144393] Dynamic subtest vecs0: SUCCESS (23.476s) [415.154616] Starting dynamic subtest: ccs0 [438.637136] Dynamic subtest ccs0: SUCCESS (23.490s) [438.639563] Subtest allocator-evict: SUCCESS (141.868s) [438.747217] [057/131] (583s left) kms_cursor_crc (cursor-offscreen-256x85) [439.068172] Starting subtest: cursor-offscreen-256x85 [439.116729] Subtest cursor-offscreen-256x85: SKIP (0.042s) [439.328362] [058/131] (582s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [439.440410] Starting subtest: fbcpsr-rgb101010-draw-blt [446.242558] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.804s) [446.422567] [059/131] (575s left) kms_color (deep-color) [446.513883] Starting subtest: deep-color [447.575198] Starting dynamic subtest: pipe-A-eDP-1-gamma [448.302303] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.726s) [448.311892] Starting dynamic subtest: pipe-A-eDP-1-degamma [449.801413] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.501s) [449.810960] Starting dynamic subtest: pipe-A-eDP-1-ctm [451.186384] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.384s) [451.970465] Starting dynamic subtest: pipe-B-eDP-1-gamma [452.679689] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.714s) [452.688919] Starting dynamic subtest: pipe-B-eDP-1-degamma [454.154562] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.476s) [454.164292] Starting dynamic subtest: pipe-B-eDP-1-ctm [455.599780] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.442s) [456.368228] Starting dynamic subtest: pipe-C-eDP-1-gamma [457.051876] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.693s) [457.061545] Starting dynamic subtest: pipe-C-eDP-1-degamma [458.428819] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.375s) [458.438596] Starting dynamic subtest: pipe-C-eDP-1-ctm [459.852786] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.421s) [460.656993] Starting dynamic subtest: pipe-D-eDP-1-gamma [461.344606] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.693s) [461.354170] Starting dynamic subtest: pipe-D-eDP-1-degamma [462.700289] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.357s) [462.709990] Starting dynamic subtest: pipe-D-eDP-1-ctm [464.150688] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.447s) [464.152606] Subtest deep-color: SUCCESS (17.636s) [465.019081] [060/131] (556s left) gem_exec_create (forked) [465.099384] Starting subtest: forked [465.101738] Starting dynamic subtest: smem [486.869709] Dynamic subtest smem: SUCCESS (21.767s) [486.872774] Subtest forked: SUCCESS (21.769s) [487.085902] [061/131] (534s left) gem_exec_schedule (pi-common) [487.273703] Starting subtest: pi-common [487.276045] Starting dynamic subtest: rcs0 [487.309357] Dynamic subtest rcs0: SUCCESS (0.040s) [487.319088] Starting dynamic subtest: bcs0 [487.353126] Dynamic subtest bcs0: SUCCESS (0.043s) [487.362183] Starting dynamic subtest: vcs0 [487.387560] Dynamic subtest vcs0: SUCCESS (0.033s) [487.396450] Starting dynamic subtest: vcs1 [487.425612] Dynamic subtest vcs1: SUCCESS (0.037s) [487.434185] Starting dynamic subtest: vecs0 [487.458374] Dynamic subtest vecs0: SUCCESS (0.032s) [487.467046] Starting dynamic subtest: ccs0 [487.492616] Dynamic subtest ccs0: SUCCESS (0.033s) [487.494909] Subtest pi-common: SUCCESS (0.224s) [487.759121] [062/131] (534s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [487.828810] Starting subtest: invalid-multi-wait-unsubmitted-submitted [487.831326] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [487.950961] [063/131] (534s left) syncobj_timeline (single-wait-signaled) [488.007765] Starting subtest: single-wait-signaled [488.010081] Subtest single-wait-signaled: SUCCESS (0.000s) [488.146775] [064/131] (533s left) gem_ctx_persistence (saturated-hostile) [488.211737] Starting subtest: saturated-hostile [488.214063] Starting dynamic subtest: rcs0 [489.078335] Dynamic subtest rcs0: SUCCESS (0.866s) [489.089067] Starting dynamic subtest: bcs0 [489.860669] Dynamic subtest bcs0: SUCCESS (0.780s) [489.872779] Starting dynamic subtest: vcs0 [490.674893] Dynamic subtest vcs0: SUCCESS (0.812s) [490.686566] Starting dynamic subtest: vcs1 [491.443933] Dynamic subtest vcs1: SUCCESS (0.768s) [491.456329] Starting dynamic subtest: vecs0 [492.259220] Dynamic subtest vecs0: SUCCESS (0.813s) [492.270668] Starting dynamic subtest: ccs0 [493.097479] Dynamic subtest ccs0: SUCCESS (0.836s) [493.100163] Subtest saturated-hostile: SUCCESS (4.886s) [493.202659] [065/131] (528s left) gem_close_race (multigpu-basic-threads) [493.280778] Starting subtest: multigpu-basic-threads [493.285263] Subtest multigpu-basic-threads: SKIP (0.000s) [493.552395] [066/131] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [493.653084] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [493.657179] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [493.771040] [067/131] (528s left) kms_pm_rpm (i2c) [496.019086] Starting subtest: i2c [501.344475] Subtest i2c: SUCCESS (5.324s) [501.458209] [068/131] (520s left) kms_psr (fbc-pr-sprite-plane-move) [501.569900] Starting subtest: fbc-pr-sprite-plane-move [501.574521] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [501.669489] [069/131] (520s left) gem_mmap_offset (bad-extensions) [501.738416] Starting subtest: bad-extensions [501.741024] Subtest bad-extensions: SUCCESS (0.000s) [501.900529] [070/131] (520s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [502.012621] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [502.017171] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [502.160556] [071/131] (520s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [502.261107] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [502.265112] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [502.386068] [072/131] (520s left) perf_pmu (most-busy-idle-check-all) [502.435967] Starting subtest: most-busy-idle-check-all [502.437790] Starting dynamic subtest: rcs0 [503.893200] Dynamic subtest rcs0: SUCCESS (1.455s) [503.905631] Starting dynamic subtest: bcs0 [505.877350] Dynamic subtest bcs0: SUCCESS (1.981s) [505.889568] Starting dynamic subtest: vcs0 [507.924814] Dynamic subtest vcs0: SUCCESS (2.044s) [507.936665] Starting dynamic subtest: vcs1 [509.909066] Dynamic subtest vcs1: SUCCESS (1.981s) [509.920999] Starting dynamic subtest: vecs0 [511.892295] Dynamic subtest vecs0: SUCCESS (1.981s) [511.904330] Starting dynamic subtest: ccs0 [513.876712] Dynamic subtest ccs0: SUCCESS (1.981s) [513.879242] Subtest most-busy-idle-check-all: SUCCESS (11.441s) [514.018815] [073/131] (508s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [514.407326] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [515.224038] [074/131] (507s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [515.335304] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [515.339411] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [515.456906] [075/131] (507s left) gem_ctx_persistence (engines-cleanup) [515.505908] Starting subtest: engines-cleanup [515.508044] Starting dynamic subtest: rcs0 [515.590093] Dynamic subtest rcs0: SUCCESS (0.086s) [515.602190] Starting dynamic subtest: bcs0 [515.643714] Dynamic subtest bcs0: SUCCESS (0.052s) [515.654601] Starting dynamic subtest: vcs0 [515.699864] Dynamic subtest vcs0: SUCCESS (0.054s) [515.710533] Starting dynamic subtest: vcs1 [515.767729] Dynamic subtest vcs1: SUCCESS (0.066s) [515.779228] Starting dynamic subtest: vecs0 [515.817921] Dynamic subtest vecs0: SUCCESS (0.048s) [515.828874] Starting dynamic subtest: ccs0 [515.870704] Dynamic subtest ccs0: SUCCESS (0.051s) [515.873425] Subtest engines-cleanup: SUCCESS (0.368s) [515.976387] [076/131] (506s left) prime_mmap (test_map_unmap) [516.046944] Starting subtest: test_map_unmap [516.049273] Starting dynamic subtest: test_map_unmap-smem [516.077447] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s) [516.079733] Subtest test_map_unmap: SUCCESS (0.032s) [516.216057] [077/131] (506s left) gem_userptr_blits (set-cache-level) [516.286883] Starting subtest: set-cache-level [516.290536] Subtest set-cache-level: SKIP (0.000s) [516.450759] [078/131] (506s left) gem_busy (busy) [516.515066] Starting subtest: busy [516.517084] Starting dynamic subtest: all-engines [516.568057] Dynamic subtest all-engines: SUCCESS (0.053s) [516.579106] Starting dynamic subtest: rcs0 [517.916597] Dynamic subtest rcs0: SUCCESS (1.346s) [517.927509] Starting dynamic subtest: bcs0 [518.000952] Dynamic subtest bcs0: SUCCESS (0.081s) [518.011416] Starting dynamic subtest: vcs0 [518.040846] Dynamic subtest vcs0: SUCCESS (0.039s) [518.051149] Starting dynamic subtest: vcs1 [519.898082] Dynamic subtest vcs1: SUCCESS (1.854s) [519.908855] Starting dynamic subtest: vecs0 [521.945274] Dynamic subtest vecs0: SUCCESS (2.046s) [521.955649] Starting dynamic subtest: ccs0 [523.929933] Dynamic subtest ccs0: SUCCESS (1.984s) [523.932044] Subtest busy: SUCCESS (7.412s) [524.327892] [079/131] (498s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [524.450352] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [531.781305] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.332s) [531.952656] [080/131] (490s left) core_auth (basic-auth) [532.023739] Starting subtest: basic-auth [532.025792] Subtest basic-auth: SUCCESS (0.001s) [532.165561] [081/131] (490s left) prime_mmap_coherency (write) [532.225775] Starting subtest: write [537.603065] Subtest write: SUCCESS (5.375s) [537.772923] [082/131] (485s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [537.840775] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [537.845257] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [538.056505] [083/131] (484s left) perf (gen12-invalid-class-instance) [538.209107] Starting subtest: gen12-invalid-class-instance [538.219951] Subtest gen12-invalid-class-instance: SUCCESS (0.010s) [538.264306] [084/131] (484s left) kms_lease (lease-get) [538.366785] Starting subtest: lease-get [538.369022] Starting dynamic subtest: pipe-A-eDP-1 [538.371291] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [538.380081] Starting dynamic subtest: pipe-B-eDP-1 [538.381930] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [538.390300] Starting dynamic subtest: pipe-C-eDP-1 [538.392317] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [538.400433] Starting dynamic subtest: pipe-D-eDP-1 [538.402267] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [538.404064] Subtest lease-get: SUCCESS (0.009s) [538.516711] [085/131] (484s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [538.625352] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [538.629310] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [538.760953] [086/131] (484s left) i915_pm_rpm (system-suspend-devices) [541.001719] Starting subtest: system-suspend-devices [552.508313] Subtest system-suspend-devices: SUCCESS (11.508s) [563.943646] [087/131] (470s left) kms_cursor_edge_walk (128x128-right-edge) [564.072746] Starting subtest: 128x128-right-edge [564.075024] Starting dynamic subtest: pipe-A-eDP-1 [567.547530] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s) [567.562526] Starting dynamic subtest: pipe-D-eDP-1 [570.678667] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s) [570.680969] Subtest 128x128-right-edge: SUCCESS (6.605s) [571.505244] [088/131] (462s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [576.463374] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [576.465605] Starting dynamic subtest: pipe-A-eDP-1 [577.250315] Dynamic subtest pipe-A-eDP-1: SKIP (0.782s) [577.260862] Starting dynamic subtest: pipe-B-eDP-1 [578.383997] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s) [578.388073] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.920s) [579.703608] [089/131] (454s left) perf (i915-ref-count) [579.793819] Starting subtest: i915-ref-count [579.818977] Subtest i915-ref-count: SUCCESS (0.023s) [579.876596] [090/131] (454s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [579.974048] Starting subtest: fbc-2p-primscrn-spr-indfb-move [579.978199] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [580.096370] [091/131] (454s left) core_auth (getclient-simple) [580.129037] Starting subtest: getclient-simple [580.150658] Subtest getclient-simple: SUCCESS (0.019s) [580.283771] [092/131] (453s left) i915_pciid [580.487859] [093/131] (453s left) gem_exec_fence (syncobj-timeline-signal) [581.113338] Starting subtest: syncobj-timeline-signal [581.120480] Subtest syncobj-timeline-signal: SUCCESS (0.009s) [583.052072] [094/131] (451s left) kms_flip (bo-too-big) [583.165783] Starting subtest: bo-too-big [583.167988] Starting dynamic subtest: A-eDP1 [584.427272] Dynamic subtest A-eDP1: SUCCESS (1.263s) [584.440837] Starting dynamic subtest: B-eDP1 [585.753143] Dynamic subtest B-eDP1: SUCCESS (1.325s) [585.765466] Starting dynamic subtest: C-eDP1 [587.095579] Dynamic subtest C-eDP1: SUCCESS (1.339s) [587.107139] Starting dynamic subtest: D-eDP1 [588.430379] Dynamic subtest D-eDP1: SUCCESS (1.334s) [588.432763] Subtest bo-too-big: SUCCESS (5.270s) [589.656976] [095/131] (444s left) kms_psr (pr-basic) [589.749602] Starting subtest: pr-basic [589.753839] Subtest pr-basic: SKIP (0.000s) [589.851092] [096/131] (444s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [589.942589] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [589.946748] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [590.098747] [097/131] (444s left) kms_addfb_basic (tile-pitch-mismatch) [590.156236] Starting subtest: tile-pitch-mismatch [590.159950] Subtest tile-pitch-mismatch: SKIP (0.000s) [590.336314] [098/131] (444s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [590.450144] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [590.452401] Starting dynamic subtest: pipe-A-eDP-1 [590.461017] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [590.471065] Starting dynamic subtest: pipe-B-eDP-1 [590.479499] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [590.488642] Starting dynamic subtest: pipe-C-eDP-1 [590.496805] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [590.505956] Starting dynamic subtest: pipe-D-eDP-1 [590.514086] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [590.518146] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s) [592.625081] [099/131] (441s left) gem_exec_reloc (basic-write-cpu-active) [592.705813] Subtest basic-write-cpu-active: SKIP (0.000s) [592.819778] [100/131] (441s left) gem_exec_whisper (basic-queues-forked-all) [592.895823] Starting subtest: basic-queues-forked-all [611.105395] Subtest basic-queues-forked-all: SUCCESS (18.204s) [611.313532] [101/131] (423s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [611.416229] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [611.418528] Starting dynamic subtest: pipe-A-default-mode [612.562302] Dynamic subtest pipe-A-default-mode: SKIP (1.143s) [612.565971] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.145s) [612.741319] [102/131] (421s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [612.831943] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [612.834280] Starting dynamic subtest: pipe-A-default-mode [613.120972] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [613.125639] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.287s) [613.983329] [103/131] (420s left) prime_mmap (test_dup) [614.037731] Starting subtest: test_dup [614.039774] Starting dynamic subtest: test_dup-smem [614.066894] Dynamic subtest test_dup-smem: SUCCESS (0.031s) [614.069409] Subtest test_dup: SUCCESS (0.032s) [614.168090] [104/131] (420s left) kms_addfb_basic (legacy-format) [614.222865] Starting subtest: legacy-format [614.253582] Subtest legacy-format: SUCCESS (0.028s) [614.433846] [105/131] (420s left) gem_workarounds (suspend-resume-context) [614.518179] Starting subtest: suspend-resume-context [630.746341] Subtest suspend-resume-context: SUCCESS (1.632s) [640.923599] [106/131] (404s left) gem_fence_thrash (bo-write-verify-none) [640.972577] Starting subtest: bo-write-verify-none [640.986403] Subtest bo-write-verify-none: SKIP (0.013s) [641.050491] [107/131] (403s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [646.150116] Starting subtest: psr2-cursor-plane-move-continuous-sf [646.152362] Starting dynamic subtest: pipe-A-eDP-1 [657.280566] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.066s) [657.290486] Starting dynamic subtest: pipe-B-eDP-1 [668.326001] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.024s) [668.327901] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.093s) [669.146218] [108/131] (375s left) kms_rotation_crc (primary-rotation-270) [669.249931] Starting subtest: primary-rotation-270 [669.254260] Subtest primary-rotation-270: SKIP (0.001s) [669.347580] [109/131] (375s left) syncobj_wait (invalid-reset-illegal-handle) [669.402621] Starting subtest: invalid-reset-illegal-handle [669.404911] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [669.544754] [110/131] (375s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [669.605773] Starting subtest: y-tiled-ccs-to-y-tiled [669.610198] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [669.813822] [111/131] (375s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [669.913675] Starting subtest: primary-y-tiled-reflect-x-270 [669.917739] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [670.013388] [112/131] (375s left) gen9_exec_parse (bb-large) [670.077291] Subtest bb-large: SKIP (0.000s) [670.159130] [113/131] (375s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [670.215048] Starting subtest: multi-wait-all-for-submit-signaled [670.217367] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [670.332012] [114/131] (374s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [670.426691] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [670.428907] Starting dynamic subtest: pipe-A [670.537632] Dynamic subtest pipe-A: SKIP (0.107s) [670.547374] Starting dynamic subtest: pipe-B [671.709748] Dynamic subtest pipe-B: SKIP (1.171s) [671.719633] Starting dynamic subtest: pipe-C [672.936940] Dynamic subtest pipe-C: SUCCESS (1.231s) [672.947276] Starting dynamic subtest: pipe-D [674.168425] Dynamic subtest pipe-D: SUCCESS (1.230s) [674.170728] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.742s) [675.390461] [115/131] (369s left) kms_psr (psr2-cursor-render) [675.490922] Starting subtest: psr2-cursor-render [675.493178] Starting dynamic subtest: eDP-1 [677.226975] Dynamic subtest eDP-1: SUCCESS (1.737s) [677.229344] Subtest psr2-cursor-render: SUCCESS (1.738s) [678.045737] [116/131] (367s left) gem_userptr_blits (invalid-null-pointer) [678.119001] Starting subtest: invalid-null-pointer [678.120985] Subtest invalid-null-pointer: SUCCESS (0.001s) [678.294274] [117/131] (367s left) api_intel_allocator (simple-allocator) [678.358987] Starting subtest: simple-allocator [678.361331] Starting dynamic subtest: basic [678.363554] Dynamic subtest basic: SUCCESS (0.003s) [678.380403] Starting dynamic subtest: parallel-one [678.542753] Dynamic subtest parallel-one: SUCCESS (0.181s) [678.552622] Starting dynamic subtest: print [678.554748] Dynamic subtest print: SUCCESS (0.000s) [678.564064] Starting dynamic subtest: reuse [678.565913] Dynamic subtest reuse: SUCCESS (0.000s) [678.574785] Starting dynamic subtest: reserve [678.577202] Dynamic subtest reserve: SUCCESS (0.000s) [678.586083] Starting dynamic subtest: fork-reopen-allocator [678.587945] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s) [678.589801] Subtest simple-allocator: SUCCESS (0.200s) [678.698180] [118/131] (366s left) kms_pipe_stress (stress-xrgb8888-yftiled) [678.795742] Starting subtest: stress-xrgb8888-yftiled [678.800059] Subtest stress-xrgb8888-yftiled: SKIP (0.000s) [678.880284] [119/131] (366s left) kms_flip (wf_vblank-ts-check) [678.975048] Starting subtest: wf_vblank-ts-check [678.977304] Starting dynamic subtest: A-eDP1 [687.871040] Dynamic subtest A-eDP1: SUCCESS (8.895s) [687.881588] Starting dynamic subtest: B-eDP1 [696.806122] Dynamic subtest B-eDP1: SUCCESS (8.932s) [696.817428] Starting dynamic subtest: C-eDP1 [705.732933] Dynamic subtest C-eDP1: SUCCESS (8.922s) [705.743806] Starting dynamic subtest: D-eDP1 [714.669537] Dynamic subtest D-eDP1: SUCCESS (8.933s) [714.674356] Subtest wf_vblank-ts-check: SUCCESS (35.692s) [715.921626] [120/131] (329s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [716.019750] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [716.022071] Starting dynamic subtest: pipe-A-eDP-1 [716.046116] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [716.058586] Starting dynamic subtest: pipe-B-eDP-1 [716.080073] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [716.089752] Starting dynamic subtest: pipe-C-eDP-1 [716.111210] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [716.120789] Starting dynamic subtest: pipe-D-eDP-1 [716.142925] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [716.146981] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s) [718.271954] [121/131] (327s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [718.334341] Starting subtest: invalid-multi-wait-unsubmitted [718.336389] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [718.467437] [122/131] (327s left) prime_mmap (test_errors) [718.523750] Starting subtest: test_errors [718.526095] Starting dynamic subtest: test_errors-smem [718.618409] Dynamic subtest test_errors-smem: SUCCESS (0.097s) [718.620929] Subtest test_errors: SUCCESS (0.097s) [718.755141] [123/131] (326s left) gem_exec_async (forked-writes) [718.823158] Starting subtest: forked-writes [718.825465] Starting dynamic subtest: rcs0 [718.850537] Dynamic subtest rcs0: SUCCESS (0.027s) [718.861784] Starting dynamic subtest: bcs0 [718.874824] Dynamic subtest bcs0: SUCCESS (0.023s) [718.884692] Starting dynamic subtest: vcs0 [718.895688] Dynamic subtest vcs0: SUCCESS (0.020s) [718.905385] Starting dynamic subtest: vcs1 [718.919065] Dynamic subtest vcs1: SUCCESS (0.022s) [718.929163] Starting dynamic subtest: vecs0 [718.941751] Dynamic subtest vecs0: SUCCESS (0.022s) [718.951963] Starting dynamic subtest: ccs0 [718.963775] Dynamic subtest ccs0: SUCCESS (0.021s) [718.966130] Subtest forked-writes: SUCCESS (0.141s) [719.223444] [124/131] (326s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [719.319229] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [723.869594] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.552s) [725.095451] [125/131] (320s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [725.196256] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [725.198696] Starting dynamic subtest: pipe-A-default-mode [725.508734] Dynamic subtest pipe-A-default-mode: SKIP (0.311s) [725.513243] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.313s) [726.312286] [126/131] (319s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [726.399583] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [735.714287] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.313s) [735.874423] [127/131] (309s left) gem_mmap_gtt (cpuset-basic-small-copy) [735.942510] Subtest cpuset-basic-small-copy: SKIP (0.000s) [736.006497] [128/131] (309s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [740.967982] Starting subtest: psr2-primary-plane-update-sf-dmg-area [740.970271] Starting dynamic subtest: pipe-A-eDP-1 [747.576903] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.609s) [747.593543] Starting dynamic subtest: pipe-B-eDP-1 [754.053396] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.476s) [754.055658] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.090s) [754.954654] [129/131] (290s left) sriov_basic (enable-vfs-bind-unbind-each) [755.025571] Starting subtest: enable-vfs-bind-unbind-each [755.028020] Starting dynamic subtest: numvfs-1 [755.106031] Dynamic subtest numvfs-1: FAIL (0.027s) [755.117601] Starting dynamic subtest: numvfs-2 [755.191572] Dynamic subtest numvfs-2: FAIL (0.004s) [755.213086] Starting dynamic subtest: numvfs-3 [755.287370] Dynamic subtest numvfs-3: FAIL (0.004s) [755.299072] Starting dynamic subtest: numvfs-4 [755.370943] Dynamic subtest numvfs-4: FAIL (0.004s) [755.381655] Starting dynamic subtest: numvfs-5 [755.453555] Dynamic subtest numvfs-5: FAIL (0.004s) [755.464974] Starting dynamic subtest: numvfs-6 [755.537850] Dynamic subtest numvfs-6: FAIL (0.004s) [755.548930] Starting dynamic subtest: numvfs-7 [755.622139] Dynamic subtest numvfs-7: FAIL (0.004s) [755.632464] Starting dynamic subtest: numvfs-random [755.704728] Dynamic subtest numvfs-random: FAIL (0.004s) [755.706778] Subtest enable-vfs-bind-unbind-each: FAIL (0.058s) [755.745614] [130/131] (290s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [755.839963] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [762.657317] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.820s) [762.809876] [131/131] (283s left) gem_exec_schedule (u-fairslice) [762.890688] Starting subtest: u-fairslice [762.892615] Starting dynamic subtest: rcs0 [764.904339] Dynamic subtest rcs0: SUCCESS (2.019s) [764.915036] Starting dynamic subtest: bcs0 [766.920888] Dynamic subtest bcs0: SUCCESS (2.016s) [766.931938] Starting dynamic subtest: vcs0 [768.940840] Dynamic subtest vcs0: SUCCESS (2.018s) [768.951433] Starting dynamic subtest: vcs1 [770.957913] Dynamic subtest vcs1: SUCCESS (2.018s) [770.968045] Starting dynamic subtest: vecs0 [772.982294] Dynamic subtest vecs0: SUCCESS (2.019s) [772.993684] Starting dynamic subtest: ccs0 [775.000211] Dynamic subtest ccs0: SUCCESS (2.018s) [775.002544] Subtest u-fairslice: SUCCESS (12.115s) [775.322764] Closing watchdogs results: parsing output: 0/ for test: kms_addfb_basic results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: kms_vrr results: parsing output: 4/ for test: syncobj_timeline results: parsing output: 5/ for test: gem_exec_fence results: parsing output: 6/ for test: perf_pmu results: parsing output: 7/ for test: kms_plane_multiple results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_exec_whisper results: parsing output: 12/ for test: sw_sync results: parsing output: 13/ for test: i915_query results: parsing output: 14/ for test: gem_exec_reloc results: parsing output: 15/ for test: gem_exec_endless results: parsing output: 16/ for test: kms_selftest results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_mmap_wc results: parsing output: 20/ for test: gem_mmap_gtt results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_psr results: parsing output: 23/ for test: dmabuf_sync_file results: parsing output: 24/ for test: kms_pm_rpm results: parsing output: 25/ for test: kms_plane_scaling results: parsing output: 26/ for test: prime_vgem results: parsing output: 27/ for test: gem_mmap_gtt results: parsing output: 28/ for test: kms_cursor_crc results: parsing output: 29/ for test: i915_pm_sseu results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: kms_dp_link_training results: parsing output: 32/ for test: kms_ccs results: parsing output: 33/ for test: gem_pxp results: parsing output: 34/ for test: gem_exec_flush results: parsing output: 35/ for test: syncobj_timeline results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_partial_pwrite_pread results: parsing output: 39/ for test: gem_flink_basic results: parsing output: 40/ for test: gem_ctx_shared results: parsing output: 41/ for test: kms_cursor_legacy results: parsing output: 42/ for test: gem_readwrite results: parsing output: 43/ for test: kms_busy results: parsing output: 44/ for test: kms_color results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: i915_drm_fdinfo results: parsing output: 49/ for test: kms_addfb_basic results: parsing output: 50/ for test: sysfs_heartbeat_interval results: parsing output: 51/ for test: kms_atomic results: parsing output: 52/ for test: kms_sequence results: parsing output: 53/ for test: kms_invalid_mode results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_softpin results: parsing output: 56/ for test: kms_cursor_crc results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_color results: parsing output: 59/ for test: gem_exec_create results: parsing output: 60/ for test: gem_exec_schedule results: parsing output: 61/ for test: syncobj_wait results: parsing output: 62/ for test: syncobj_timeline results: parsing output: 63/ for test: gem_ctx_persistence results: parsing output: 64/ for test: gem_close_race results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_pm_rpm results: parsing output: 67/ for test: kms_psr results: parsing output: 68/ for test: gem_mmap_offset results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: perf_pmu results: parsing output: 72/ for test: kms_chamelium_edid results: parsing output: 73/ for test: kms_big_fb results: parsing output: 74/ for test: gem_ctx_persistence results: parsing output: 75/ for test: prime_mmap results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: gem_busy results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: core_auth results: parsing output: 80/ for test: prime_mmap_coherency results: parsing output: 81/ for test: gem_render_copy results: parsing output: 82/ for test: perf results: parsing output: 83/ for test: kms_lease results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: i915_pm_rpm results: parsing output: 86/ for test: kms_cursor_edge_walk results: parsing output: 87/ for test: kms_psr2_sf results: parsing output: 88/ for test: perf results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: core_auth results: parsing output: 91/ for test: i915_pciid results: parsing output: 92/ for test: gem_exec_fence results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: kms_psr results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_addfb_basic results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: gem_exec_reloc results: parsing output: 99/ for test: gem_exec_whisper results: parsing output: 100/ for test: kms_flip_scaled_crc results: parsing output: 101/ for test: kms_flip_scaled_crc results: parsing output: 102/ for test: prime_mmap results: parsing output: 103/ for test: kms_addfb_basic results: parsing output: 104/ for test: gem_workarounds results: parsing output: 105/ for test: gem_fence_thrash results: parsing output: 106/ for test: kms_psr2_sf results: parsing output: 107/ for test: kms_rotation_crc results: parsing output: 108/ for test: syncobj_wait results: parsing output: 109/ for test: gem_render_copy results: parsing output: 110/ for test: kms_rotation_crc results: parsing output: 111/ for test: gen9_exec_parse results: parsing output: 112/ for test: syncobj_timeline results: parsing output: 113/ for test: kms_plane_scaling results: parsing output: 114/ for test: kms_psr results: parsing output: 115/ for test: gem_userptr_blits results: parsing output: 116/ for test: api_intel_allocator results: parsing output: 117/ for test: kms_pipe_stress results: parsing output: 118/ for test: kms_flip results: parsing output: 119/ for test: kms_ccs results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: prime_mmap results: parsing output: 122/ for test: gem_exec_async results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_flip_scaled_crc results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_mmap_gtt results: parsing output: 127/ for test: kms_psr2_sf results: parsing output: 128/ for test: sriov_basic results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_exec_schedule Done.