[84.897429] Initializing watchdogs [84.897597] /dev/watchdog0 [84.935547] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [84.949582] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [84.957352] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [84.965705] [001/133] (960s left) kms_psr (fbc-psr-sprite-blt) [85.182319] Subtest fbc-psr-sprite-blt: SKIP (0.000s) [85.284879] [002/133] (960s left) kms_pm_rpm (modeset-lpsp) [87.235970] Starting subtest: modeset-lpsp [87.438457] Subtest modeset-lpsp: SKIP (0.200s) [87.829508] [003/133] (957s left) gem_softpin (noreloc) [87.959499] Starting subtest: noreloc [93.392157] Subtest noreloc: SUCCESS (5.429s) [93.558655] [004/133] (952s left) kms_atomic_interruptible (legacy-cursor) [93.736586] Starting subtest: legacy-cursor [93.739912] Starting dynamic subtest: pipe-A-HDMI-A-1 [100.491421] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.748s) [100.496430] Subtest legacy-cursor: SUCCESS (6.752s) [100.777972] [005/133] (945s left) kms_cursor_crc (cursor-offscreen-512x170) [100.992327] Starting subtest: cursor-offscreen-512x170 [100.999053] Subtest cursor-offscreen-512x170: SKIP (0.003s) [101.159449] [006/133] (944s left) kms_big_fb (x-tiled-64bpp-rotate-90) [101.364158] Starting subtest: x-tiled-64bpp-rotate-90 [101.654776] Subtest x-tiled-64bpp-rotate-90: SKIP (0.282s) [101.892893] [007/133] (944s left) kms_hdmi_inject (inject-audio) [102.434973] Starting subtest: inject-audio [102.617635] Subtest inject-audio: SUCCESS (0.186s) [103.040664] [008/133] (943s left) kms_async_flips (alternate-sync-async-flip-atomic) [103.227769] Starting subtest: alternate-sync-async-flip-atomic [103.801641] Starting dynamic subtest: pipe-A-HDMI-A-1 [105.543427] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.745s) [105.570216] Starting dynamic subtest: pipe-A-HDMI-A-2 [107.031062] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.163s) [107.367792] Starting dynamic subtest: pipe-B-HDMI-A-1 [109.549668] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.188s) [109.877359] Starting dynamic subtest: pipe-B-HDMI-A-2 [112.018749] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.163s) [112.354682] Starting dynamic subtest: pipe-C-HDMI-A-1 [114.518129] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.188s) [114.865241] Starting dynamic subtest: pipe-C-HDMI-A-2 [117.003245] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.158s) [117.008050] Subtest alternate-sync-async-flip-atomic: FAIL (13.775s) [117.608423] [009/133] (928s left) gem_lmem_evict (dontneed-evict-race) [117.733991] Subtest dontneed-evict-race: SKIP (0.000s) [117.836862] [010/133] (928s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [118.038497] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [120.979883] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SUCCESS (2.938s) [121.174148] [011/133] (925s left) kms_psr (pr-sprite-render) [121.364784] Subtest pr-sprite-render: SKIP (0.000s) [121.475627] [012/133] (924s left) kms_color (legacy-gamma) [121.659304] Starting subtest: legacy-gamma [121.662336] Starting dynamic subtest: pipe-A-HDMI-A-1 [122.606426] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.949s) [122.626022] Starting dynamic subtest: pipe-A-HDMI-A-2 [123.287301] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.681s) [123.324341] Starting dynamic subtest: pipe-B-HDMI-A-1 [123.944603] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.655s) [123.982589] Starting dynamic subtest: pipe-B-HDMI-A-2 [124.594232] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.648s) [124.612768] Starting dynamic subtest: pipe-C-HDMI-A-1 [125.379669] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.657s) [125.448898] Starting dynamic subtest: pipe-C-HDMI-A-2 [126.029077] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.658s) [126.098818] Subtest legacy-gamma: SUCCESS (4.256s) [126.519268] [013/133] (920s left) gem_exec_fence (invalid-timeline-fence-array) [127.253344] Starting subtest: invalid-timeline-fence-array [127.261321] Subtest invalid-timeline-fence-array: SUCCESS (0.012s) [127.565718] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true [127.572355] [014/133] (919s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [127.745075] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [127.959700] Starting dynamic subtest: pipe-A-plane-0 [127.965649] Dynamic subtest pipe-A-plane-0: SKIP (0.001s) [128.045249] Starting dynamic subtest: pipe-A-plane-1 [128.056797] Dynamic subtest pipe-A-plane-1: SKIP (0.000s) [128.076789] Starting dynamic subtest: pipe-A-plane-2 [128.082987] Dynamic subtest pipe-A-plane-2: SKIP (0.000s) [128.103419] Starting dynamic subtest: pipe-A-plane-3 [128.111169] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [128.130790] Starting dynamic subtest: pipe-A-plane-4 [128.136884] Dynamic subtest pipe-A-plane-4: SKIP (0.000s) [128.378453] Starting dynamic subtest: pipe-B-plane-0 [128.387055] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [128.405360] Starting dynamic subtest: pipe-B-plane-1 [128.411754] Dynamic subtest pipe-B-plane-1: SKIP (0.000s) [128.432112] Starting dynamic subtest: pipe-B-plane-2 [128.437930] Dynamic subtest pipe-B-plane-2: SKIP (0.000s) [128.456471] Starting dynamic subtest: pipe-B-plane-3 [128.462279] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [128.480764] Starting dynamic subtest: pipe-B-plane-4 [128.486666] Dynamic subtest pipe-B-plane-4: SKIP (0.000s) [128.552602] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.802s) [128.881875] [015/133] (918s left) gem_readwrite (new-obj) [128.989471] Starting subtest: new-obj [128.996292] Subtest new-obj: SUCCESS (0.000s) [129.180437] [016/133] (917s left) kms_pipe_stress (stress-xrgb8888-ytiled) [129.372343] Starting subtest: stress-xrgb8888-ytiled [139.094654] Subtest stress-xrgb8888-ytiled: SUCCESS (9.724s) [139.632465] [017/133] (907s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [139.740831] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [139.842898] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s) [140.022901] [018/133] (907s left) kms_sequence (queue-busy) [140.195382] Starting subtest: queue-busy [140.198662] Starting dynamic subtest: pipe-A-HDMI-A-1 [143.106055] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.901s) [143.155394] Starting dynamic subtest: pipe-A-HDMI-A-2 [145.701267] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.592s) [145.720752] Starting dynamic subtest: pipe-B-HDMI-A-1 [148.301481] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.597s) [148.342035] Starting dynamic subtest: pipe-B-HDMI-A-2 [150.896510] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.591s) [150.925122] Starting dynamic subtest: pipe-C-HDMI-A-1 [153.474791] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.576s) [153.503040] Starting dynamic subtest: pipe-C-HDMI-A-2 [156.098436] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.582s) [156.101578] Subtest queue-busy: SUCCESS (15.867s) [156.357767] [019/133] (891s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [156.549188] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [156.552409] Starting dynamic subtest: pipe-A-HDMI-A-1 [156.622421] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [156.652463] Starting dynamic subtest: pipe-A-HDMI-A-2 [156.685293] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [156.704730] Starting dynamic subtest: pipe-B-HDMI-A-1 [156.737252] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [156.756726] Starting dynamic subtest: pipe-B-HDMI-A-2 [156.789444] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [156.808185] Starting dynamic subtest: pipe-C-HDMI-A-1 [156.839190] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [156.857900] Starting dynamic subtest: pipe-C-HDMI-A-2 [156.891594] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [156.898148] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.023s) [157.518278] [020/133] (889s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [157.713090] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s) [157.816232] [021/133] (889s left) kms_flip (dpms-off-confusion) [158.003781] Starting subtest: dpms-off-confusion [158.007959] Starting dynamic subtest: A-HDMI-A1 [163.651999] Dynamic subtest A-HDMI-A1: SUCCESS (5.645s) [163.673501] Starting dynamic subtest: B-HDMI-A1 [169.036423] Dynamic subtest B-HDMI-A1: SUCCESS (5.381s) [169.056417] Starting dynamic subtest: C-HDMI-A1 [174.407177] Dynamic subtest C-HDMI-A1: SUCCESS (5.365s) [174.428102] Starting dynamic subtest: A-HDMI-A2 [179.811586] Dynamic subtest A-HDMI-A2: SUCCESS (5.405s) [179.831991] Starting dynamic subtest: B-HDMI-A2 [185.184657] Dynamic subtest B-HDMI-A2: SUCCESS (5.370s) [185.204960] Starting dynamic subtest: C-HDMI-A2 [190.552734] Dynamic subtest C-HDMI-A2: SUCCESS (5.365s) [190.556067] Subtest dpms-off-confusion: SUCCESS (32.554s) [191.047321] [022/133] (856s left) gem_compute (compute-square) [191.155508] Starting subtest: compute-square [191.163148] Subtest compute-square: SKIP (0.000s) [191.323740] [023/133] (856s left) kms_addfb_basic (clobberred-modifier) [191.425661] Starting subtest: clobberred-modifier [191.428962] Subtest clobberred-modifier: SUCCESS (0.000s) [191.677589] [024/133] (856s left) gem_pread (display) [191.784595] Starting subtest: display [194.915748] Subtest display: SUCCESS (3.129s) [195.091630] [025/133] (852s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [195.206634] Starting subtest: y-tiled-to-vebox-yf-tiled [195.214981] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [195.475655] [026/133] (852s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling) [195.656907] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling [195.661215] Starting dynamic subtest: pipe-A-valid-mode [196.527228] Dynamic subtest pipe-A-valid-mode: SKIP (0.861s) [196.534329] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (0.865s) [197.027992] [027/133] (851s left) kms_flip (flip-vs-expired-vblank) [197.215115] Starting subtest: flip-vs-expired-vblank [197.219538] Starting dynamic subtest: A-HDMI-A1 [202.843879] Dynamic subtest A-HDMI-A1: SUCCESS (5.621s) [202.863165] Starting dynamic subtest: B-HDMI-A1 [208.202142] Dynamic subtest B-HDMI-A1: SUCCESS (5.356s) [208.222100] Starting dynamic subtest: C-HDMI-A1 [213.581832] Dynamic subtest C-HDMI-A1: SUCCESS (5.376s) [213.601389] Starting dynamic subtest: A-HDMI-A2 [218.970044] Dynamic subtest A-HDMI-A2: SUCCESS (5.384s) [218.991268] Starting dynamic subtest: B-HDMI-A2 [224.356957] Dynamic subtest B-HDMI-A2: SUCCESS (5.385s) [224.378472] Starting dynamic subtest: C-HDMI-A2 [229.748192] Dynamic subtest C-HDMI-A2: SUCCESS (5.384s) [229.751468] Subtest flip-vs-expired-vblank: SUCCESS (32.535s) [230.268652] [028/133] (818s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [230.379558] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [230.485132] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.105s) [230.666434] [029/133] (817s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [230.865935] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [230.876717] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [235.711214] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (4.836s) [235.737447] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [240.445209] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (4.723s) [240.488382] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [245.125895] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (4.673s) [245.129385] Subtest 2x-modeset-vs-vblank-race-interruptible: SUCCESS (14.259s) [245.757852] [030/133] (802s left) gem_exec_schedule (implicit-write-read) [245.924560] Starting subtest: implicit-write-read [245.927974] Starting dynamic subtest: rcs0 [246.051122] Dynamic subtest rcs0: SUCCESS (0.121s) [246.072354] Starting dynamic subtest: bcs0 [246.181669] Dynamic subtest bcs0: SUCCESS (0.131s) [246.203106] Starting dynamic subtest: vcs0 [246.307986] Dynamic subtest vcs0: SUCCESS (0.124s) [246.341118] Starting dynamic subtest: vecs0 [246.432093] Dynamic subtest vecs0: SUCCESS (0.114s) [246.435423] Subtest implicit-write-read: SUCCESS (0.511s) [246.864145] [031/133] (801s left) kms_scaling_modes (scaling-mode-none) [247.040443] Starting subtest: scaling-mode-none [247.067208] Subtest scaling-mode-none: SKIP (0.003s) [247.211437] [032/133] (801s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [247.388113] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [247.391492] Starting dynamic subtest: pipe-A-HDMI-A-1 [247.509920] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [247.544104] Starting dynamic subtest: pipe-A-HDMI-A-2 [247.576753] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [247.595577] Starting dynamic subtest: pipe-B-HDMI-A-1 [247.628487] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [247.647643] Starting dynamic subtest: pipe-B-HDMI-A-2 [247.680098] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [247.699135] Starting dynamic subtest: pipe-C-HDMI-A-1 [247.732193] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [247.751364] Starting dynamic subtest: pipe-C-HDMI-A-2 [247.783123] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [247.789613] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.032s) [248.358153] [033/133] (800s left) gem_exec_balancer (full-pulse) [248.491112] Starting subtest: full-pulse [252.864490] Subtest full-pulse: SUCCESS (4.373s) [253.173437] [034/133] (795s left) kms_psr (fbc-psr2-primary-page-flip) [253.356763] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s) [253.474115] [035/133] (795s left) gem_ctx_sseu (invalid-args) [253.597051] Subtest invalid-args: SKIP (0.000s) [253.723445] [036/133] (795s left) kms_cursor_crc (cursor-rapid-movement-32x10) [253.919185] Starting subtest: cursor-rapid-movement-32x10 [254.080840] Subtest cursor-rapid-movement-32x10: SKIP (0.153s) [254.277109] [037/133] (794s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [254.526141] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [254.739287] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.245s) [255.009784] [038/133] (794s left) kms_psr (fbc-pr-basic) [255.205723] Subtest fbc-pr-basic: SKIP (0.000s) [255.322331] [039/133] (794s left) syncobj_timeline (invalid-transfer-non-existent-point) [255.437273] Starting subtest: invalid-transfer-non-existent-point [255.440494] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [255.606628] [040/133] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [255.822790] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [255.829467] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [256.006580] [041/133] (793s left) dmabuf_sync_file (import-basic) [256.153066] Starting subtest: import-basic [256.163393] Subtest import-basic: SUCCESS (0.008s) [256.325839] [042/133] (793s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [256.516387] Starting subtest: cursorB-vs-flipA-atomic-transitions [267.854440] Subtest cursorB-vs-flipA-atomic-transitions: SUCCESS (11.335s) [268.165141] [043/133] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [268.392489] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [268.399738] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [268.577885] [044/133] (781s left) gem_userptr_blits (sync-unmap) [268.713865] Starting subtest: sync-unmap [268.766461] Subtest sync-unmap: SUCCESS (0.051s) [268.949193] [045/133] (781s left) gem_exec_parallel (contexts) [269.077730] Starting subtest: contexts [269.081246] Starting dynamic subtest: rcs0 [279.180065] Dynamic subtest rcs0: SUCCESS (10.106s) [279.202938] Starting dynamic subtest: bcs0 [290.195707] Dynamic subtest bcs0: SUCCESS (11.009s) [290.218487] Starting dynamic subtest: vcs0 [294.338359] Dynamic subtest vcs0: SUCCESS (4.143s) [294.360427] Starting dynamic subtest: vecs0 [298.383642] Dynamic subtest vecs0: SUCCESS (4.041s) [298.387914] Subtest contexts: SUCCESS (29.314s) [298.695097] [046/133] (751s left) sw_sync (sync_merge) [298.800781] Starting subtest: sync_merge [298.805178] Subtest sync_merge: SUCCESS (0.002s) [298.961910] [047/133] (751s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [299.153369] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [304.779293] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (5.621s) [305.101425] [048/133] (745s left) perf_pmu (pmu-read) [305.230849] Starting subtest: pmu-read [305.235735] Subtest pmu-read: SUCCESS (0.010s) [305.418771] [049/133] (745s left) gem_userptr_blits (readonly-unsync) [305.543244] Subtest readonly-unsync: SKIP (0.000s) [305.735552] [050/133] (744s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [305.949864] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [305.957100] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [306.135391] [051/133] (744s left) kms_chamelium_edid (vga-edid-read) [306.687157] Subtest vga-edid-read: SKIP (0.000s) [306.968252] [052/133] (743s left) kms_invalid_mode (clock-too-high) [307.194856] Starting subtest: clock-too-high [307.198662] Starting dynamic subtest: pipe-A-HDMI-A-1 [307.582209] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.412s) [307.632998] Starting dynamic subtest: pipe-A-HDMI-A-2 [307.636399] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.003s) [307.706469] Starting dynamic subtest: pipe-B-HDMI-A-1 [307.712547] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s) [307.755824] Starting dynamic subtest: pipe-B-HDMI-A-2 [307.760897] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s) [307.783648] Starting dynamic subtest: pipe-C-HDMI-A-1 [307.787021] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s) [307.809421] Starting dynamic subtest: pipe-C-HDMI-A-2 [307.812904] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.003s) [307.816316] Subtest clock-too-high: SUCCESS (0.494s) [307.979844] [053/133] (742s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [308.190675] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [308.197181] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [308.363591] [054/133] (742s left) gem_exec_balancer (smoke) [308.489044] Starting subtest: smoke [312.660435] Subtest smoke: SUCCESS (4.171s) [312.961494] [055/133] (738s left) drm_read (short-buffer-nonblock) [313.391382] Starting subtest: short-buffer-nonblock [313.395573] Subtest short-buffer-nonblock: SUCCESS (0.000s) [313.680322] [056/133] (737s left) gen3_render_mixed_blits [313.889993] [057/133] (737s left) kms_big_fb (4-tiled-32bpp-rotate-180) [314.088473] Starting subtest: 4-tiled-32bpp-rotate-180 [314.096155] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s) [314.280280] [058/133] (737s left) gen9_exec_parse (batch-zero-length) [314.404248] Starting subtest: batch-zero-length [314.408284] Subtest batch-zero-length: SUCCESS (0.002s) [314.712266] [059/133] (736s left) gem_lmem_swapping (verify-ccs) [314.826237] Subtest verify-ccs: SKIP (0.000s) [314.941371] [060/133] (736s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [315.121485] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [315.125175] Starting dynamic subtest: pipe-A-HDMI-A-1 [315.223529] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [315.249574] Starting dynamic subtest: pipe-A-HDMI-A-2 [315.282425] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [315.304483] Starting dynamic subtest: pipe-B-HDMI-A-1 [315.335907] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [315.358312] Starting dynamic subtest: pipe-B-HDMI-A-2 [315.390060] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [315.411630] Starting dynamic subtest: pipe-C-HDMI-A-1 [315.442352] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [315.466310] Starting dynamic subtest: pipe-C-HDMI-A-2 [315.495645] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [315.501729] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.034s) [316.122583] [061/133] (735s left) gem_exec_reloc (basic-cpu-wc) [316.247687] Starting subtest: basic-cpu-wc [316.264192] Subtest basic-cpu-wc: SUCCESS (0.021s) [316.521645] [062/133] (735s left) i915_pm_freq_api (freq-reset) [316.639066] Subtest freq-reset: SKIP (0.000s) [316.768200] [063/133] (735s left) syncobj_wait (multi-wait-for-submit-signaled) [316.872295] Starting subtest: multi-wait-for-submit-signaled [316.875526] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [317.033888] [064/133] (734s left) prime_busy (hang-wait) [317.146257] Starting subtest: hang-wait [317.157368] Starting dynamic subtest: rcs0 [323.634072] Dynamic subtest rcs0: SUCCESS (6.479s) [323.656110] Starting dynamic subtest: bcs0 [330.672917] Dynamic subtest bcs0: SUCCESS (7.036s) [330.695599] Starting dynamic subtest: vcs0 [337.660603] Dynamic subtest vcs0: SUCCESS (6.969s) [337.704352] Starting dynamic subtest: vecs0 [344.628653] Dynamic subtest vecs0: SUCCESS (6.972s) [344.632434] Subtest hang-wait: SUCCESS (27.476s) [344.819888] [065/133] (707s left) gem_exec_parallel (userptr) [344.944405] Starting subtest: userptr [344.949145] Starting dynamic subtest: rcs0 [348.293616] Dynamic subtest rcs0: SUCCESS (3.346s) [348.316730] Starting dynamic subtest: bcs0 [352.664645] Dynamic subtest bcs0: SUCCESS (4.367s) [352.687247] Starting dynamic subtest: vcs0 [355.840042] Dynamic subtest vcs0: SUCCESS (3.167s) [355.862941] Starting dynamic subtest: vecs0 [359.005624] Dynamic subtest vecs0: SUCCESS (3.165s) [359.009951] Subtest userptr: SUCCESS (14.060s) [359.287522] [066/133] (692s left) i915_pm_rps (min-max-config-loaded) [359.409080] Starting subtest: min-max-config-loaded [359.778225] Subtest min-max-config-loaded: SUCCESS (0.369s) [359.934662] [067/133] (692s left) gem_readwrite (read-write) [360.038560] Starting subtest: read-write [360.054688] Subtest read-write: SUCCESS (0.001s) [360.217089] [068/133] (692s left) gem_ctx_exec (basic) [360.329285] Starting subtest: basic [360.332819] Subtest basic: SUCCESS (0.006s) [360.518147] [069/133] (691s left) sysfs_timeslice_duration (timeout) [360.634081] Starting subtest: timeout [360.637321] Starting dynamic subtest: vecs0 [361.463128] Dynamic subtest vecs0: SUCCESS (0.826s) [361.489518] Starting dynamic subtest: vcs0 [362.292172] Dynamic subtest vcs0: SUCCESS (0.826s) [362.316704] Starting dynamic subtest: bcs0 [363.151377] Dynamic subtest bcs0: SUCCESS (0.854s) [363.174635] Starting dynamic subtest: rcs0 [363.999095] Dynamic subtest rcs0: SUCCESS (0.847s) [364.002466] Subtest timeout: SUCCESS (3.369s) [364.169347] [070/133] (688s left) syncobj_wait (invalid-wait-bad-flags) [364.277265] Starting subtest: invalid-wait-bad-flags [364.280826] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [364.434827] [071/133] (688s left) gem_exec_reloc (basic-write-gtt-active) [364.559911] Starting subtest: basic-write-gtt-active [364.691307] Subtest basic-write-gtt-active: SUCCESS (0.137s) [364.953637] [072/133] (687s left) gem_eio (in-flight-10ms) [365.085093] Starting subtest: in-flight-10ms [366.161555] Subtest in-flight-10ms: SUCCESS (1.074s) [366.421733] [073/133] (686s left) kms_atomic (plane-invalid-params-fence) [366.603144] Starting subtest: plane-invalid-params-fence [366.610745] Starting dynamic subtest: pipe-A-HDMI-A-1 [367.092212] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.479s) [367.095549] Subtest plane-invalid-params-fence: SUCCESS (0.487s) [367.419318] [074/133] (685s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [367.540225] Starting subtest: invalid-single-wait-all-unsubmitted [367.543732] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [367.707080] [075/133] (685s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [367.901094] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [370.651349] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.754s) [370.931981] [076/133] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [371.130416] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [371.138660] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [371.314891] [077/133] (682s left) gem_pwrite (basic-exhaustion) [371.426174] Starting subtest: basic-exhaustion [396.739258] Subtest basic-exhaustion: SUCCESS (25.318s) [396.919936] [078/133] (656s left) gem_pxp (verify-pxp-stale-buf-execution) [399.562243] Starting subtest: verify-pxp-stale-buf-execution [399.569971] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s) [399.774736] [079/133] (653s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [399.954384] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [399.958819] Starting dynamic subtest: pipe-A-HDMI-A-1 [399.973950] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [400.050639] Starting dynamic subtest: pipe-A-HDMI-A-2 [400.087627] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [400.110214] Starting dynamic subtest: pipe-B-HDMI-A-1 [400.124224] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [400.147335] Starting dynamic subtest: pipe-B-HDMI-A-2 [400.160162] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [400.184353] Starting dynamic subtest: pipe-C-HDMI-A-1 [400.197245] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [400.220227] Starting dynamic subtest: pipe-C-HDMI-A-2 [400.232511] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [400.238689] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.035s) [400.982502] [080/133] (652s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [401.193138] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [402.664861] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.468s) [402.950740] [081/133] (650s left) kms_frontbuffer_tracking (pipe-fbc-rte) [403.150364] Starting subtest: pipe-fbc-rte [403.168748] Subtest pipe-fbc-rte: SKIP (0.001s) [403.345685] [082/133] (650s left) kms_content_protection (lic-type-1) [403.539032] Starting subtest: lic-type-1 [403.578971] Subtest lic-type-1: SKIP (0.028s) [403.745696] [083/133] (650s left) api_intel_bb (misplaced-blitter) [403.853167] Starting subtest: misplaced-blitter [403.868451] Subtest misplaced-blitter: SUCCESS (0.014s) [404.059479] [084/133] (650s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [404.250484] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [404.257189] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [404.458355] [085/133] (649s left) gem_render_tiled_blits (basic) [404.579491] Starting subtest: basic [404.679358] Subtest basic: SUCCESS (0.100s) [404.818378] [086/133] (649s left) kms_chamelium_color (ctm-0-25) [405.002200] Subtest ctm-0-25: SKIP (0.000s) [405.125529] [087/133] (649s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [405.329126] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [405.336244] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [405.513247] [088/133] (649s left) gem_mmap_gtt (big-bo) [405.618575] Starting subtest: big-bo [406.446403] Subtest big-bo: SUCCESS (0.828s) [406.670110] [089/133] (647s left) gem_ctx_persistence (heartbeat-hostile) [406.949987] Starting subtest: heartbeat-hostile [408.093778] Subtest heartbeat-hostile: SUCCESS (1.145s) [408.278976] [090/133] (646s left) syncobj_timeline (single-wait-signaled) [408.414141] Starting subtest: single-wait-signaled [408.417592] Subtest single-wait-signaled: SUCCESS (0.001s) [408.592726] [091/133] (646s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [408.813220] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [411.185054] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (2.371s) [411.477902] [092/133] (643s left) i915_drm_fdinfo (virtual-busy-all) [411.597420] Starting subtest: virtual-busy-all [411.601603] Subtest virtual-busy-all: SUCCESS (0.001s) [411.803152] [093/133] (643s left) gem_exec_schedule (u-submit-late-slice) [411.945265] Starting subtest: u-submit-late-slice [411.948608] Starting dynamic subtest: rcs0 [411.991053] Dynamic subtest rcs0: SUCCESS (0.048s) [412.022086] Starting dynamic subtest: bcs0 [412.042352] Dynamic subtest bcs0: SUCCESS (0.047s) [412.067649] Starting dynamic subtest: vcs0 [412.100092] Dynamic subtest vcs0: SUCCESS (0.054s) [412.124829] Starting dynamic subtest: vecs0 [412.154659] Dynamic subtest vecs0: SUCCESS (0.053s) [412.158073] Subtest u-submit-late-slice: SUCCESS (0.215s) [412.577584] [094/133] (642s left) fbdev (unaligned-read) [412.705322] Starting subtest: unaligned-read [412.728910] Subtest unaligned-read: SUCCESS (0.028s) [412.877181] [095/133] (642s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [413.084350] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [413.092552] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [413.280116] [096/133] (642s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [413.468475] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [413.472063] Starting dynamic subtest: pipe-A [414.545282] Dynamic subtest pipe-A: SUCCESS (1.077s) [414.571572] Starting dynamic subtest: pipe-B [415.674570] Dynamic subtest pipe-B: SUCCESS (1.125s) [415.701686] Starting dynamic subtest: pipe-C [416.104209] Dynamic subtest pipe-C: SUCCESS (0.426s) [416.109895] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (2.639s) [416.634918] [097/133] (638s left) gem_mmap_offset (partial-mmap) [416.747106] Starting subtest: partial-mmap [416.750465] Starting dynamic subtest: smem0 [416.755122] Dynamic subtest smem0: SUCCESS (0.008s) [416.758447] Subtest partial-mmap: SUCCESS (0.012s) [416.932419] [098/133] (638s left) kms_legacy_colorkey (basic) [417.112221] Starting subtest: basic [417.115493] Starting dynamic subtest: pipe-A [417.151235] Dynamic subtest pipe-A: SUCCESS (0.039s) [417.175381] Starting dynamic subtest: pipe-B [417.189463] Dynamic subtest pipe-B: SUCCESS (0.035s) [417.220251] Starting dynamic subtest: pipe-C [417.223413] Dynamic subtest pipe-C: SUCCESS (0.001s) [417.226545] Subtest basic: SUCCESS (0.105s) [417.383223] [099/133] (638s left) api_intel_allocator (fork-simple-stress) [417.489840] Starting subtest: fork-simple-stress [422.982148] Subtest fork-simple-stress: SUCCESS (5.492s) [423.151087] [100/133] (632s left) kms_big_fb (linear-16bpp-rotate-0) [423.363776] Starting subtest: linear-16bpp-rotate-0 [427.636788] Subtest linear-16bpp-rotate-0: SUCCESS (4.271s) [428.018273] [101/133] (627s left) kms_rotation_crc (cursor-rotation-180) [428.226423] Starting subtest: cursor-rotation-180 [430.062964] Subtest cursor-rotation-180: SUCCESS (1.862s) [430.348509] [102/133] (625s left) prime_self_import (basic-llseek-bad) [430.454542] Starting subtest: basic-llseek-bad [430.461961] Subtest basic-llseek-bad: SUCCESS (0.004s) [430.648198] [103/133] (625s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [430.754274] Starting subtest: multi-wait-for-submit-submitted-signaled [430.758178] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.002s) [430.929981] [104/133] (625s left) i915_suspend (basic-s2idle-without-i915) [431.031828] Starting subtest: basic-s2idle-without-i915 [451.959057] Subtest basic-s2idle-without-i915: SUCCESS (6.241s) [463.202023] [105/133] (604s left) kms_big_fb (y-tiled-64bpp-rotate-0) [463.408001] Starting subtest: y-tiled-64bpp-rotate-0 [468.538654] Subtest y-tiled-64bpp-rotate-0: SUCCESS (5.126s) [469.074569] [106/133] (598s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier) [469.263969] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier [469.491653] Starting dynamic subtest: pipe-A-plane-0 [469.500481] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [469.523788] Starting dynamic subtest: pipe-A-plane-1 [469.529965] Dynamic subtest pipe-A-plane-1: SKIP (0.000s) [469.594909] Starting dynamic subtest: pipe-A-plane-2 [469.624055] Dynamic subtest pipe-A-plane-2: SKIP (0.000s) [469.649264] Starting dynamic subtest: pipe-A-plane-3 [469.656038] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [469.681905] Starting dynamic subtest: pipe-A-plane-4 [469.688587] Dynamic subtest pipe-A-plane-4: SKIP (0.000s) [469.957122] Starting dynamic subtest: pipe-B-plane-0 [469.963225] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [470.013269] Starting dynamic subtest: pipe-B-plane-1 [470.020037] Dynamic subtest pipe-B-plane-1: SKIP (0.000s) [470.045473] Starting dynamic subtest: pipe-B-plane-2 [470.051822] Dynamic subtest pipe-B-plane-2: SKIP (0.000s) [470.077880] Starting dynamic subtest: pipe-B-plane-3 [470.084224] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [470.109216] Starting dynamic subtest: pipe-B-plane-4 [470.115455] Dynamic subtest pipe-B-plane-4: SKIP (0.000s) [470.247085] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.930s) [470.510748] [107/133] (597s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [470.716785] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [470.725297] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [470.908129] [108/133] (596s left) gem_exec_reloc (basic-wc-read-active) [471.036140] Starting subtest: basic-wc-read-active [471.177379] Subtest basic-wc-read-active: SUCCESS (0.142s) [471.447187] [109/133] (596s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [471.653073] Starting subtest: fbc-rgb565-draw-mmap-cpu [474.412990] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.759s) [474.716452] [110/133] (593s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [474.898141] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [474.905408] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s) [475.081822] [111/133] (592s left) gem_ctx_persistence (engines-hostile) [475.199018] Starting subtest: engines-hostile [475.203303] Starting dynamic subtest: rcs0 [475.312204] Dynamic subtest rcs0: SUCCESS (0.114s) [475.343571] Starting dynamic subtest: bcs0 [475.399417] Dynamic subtest bcs0: SUCCESS (0.083s) [475.430473] Starting dynamic subtest: vcs0 [475.480327] Dynamic subtest vcs0: SUCCESS (0.076s) [475.505624] Starting dynamic subtest: vecs0 [475.570450] Dynamic subtest vecs0: SUCCESS (0.086s) [475.573739] Subtest engines-hostile: SUCCESS (0.378s) [475.765614] [112/133] (592s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [475.963991] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [475.970371] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s) [476.131873] [113/133] (592s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [476.313760] Starting subtest: cursorB-vs-flipB-toggle [487.726487] Subtest cursorB-vs-flipB-toggle: SUCCESS (11.285s) [488.373082] [114/133] (580s left) kms_properties (colorop-properties-atomic) [488.850604] Starting subtest: colorop-properties-atomic [488.919331] Starting dynamic subtest: pipe-A-HDMI-A-1 [489.161840] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.428s) [489.217116] Starting dynamic subtest: pipe-A-HDMI-A-2 [489.486291] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.321s) [489.517701] Starting dynamic subtest: pipe-B-HDMI-A-1 [489.806082] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.310s) [489.838753] Starting dynamic subtest: pipe-B-HDMI-A-2 [490.143354] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.328s) [490.183705] Starting dynamic subtest: pipe-C-HDMI-A-1 [490.509072] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.358s) [490.599718] Starting dynamic subtest: pipe-C-HDMI-A-2 [490.839652] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.319s) [490.843320] Subtest colorop-properties-atomic: SUCCESS (2.113s) [491.155208] [115/133] (577s left) gem_spin_batch (resubmit-new) [491.292619] Starting subtest: resubmit-new [491.297536] Starting dynamic subtest: rcs0 [491.309007] Dynamic subtest rcs0: SUCCESS (0.013s) [491.335787] Starting dynamic subtest: bcs0 [491.340934] Dynamic subtest bcs0: SUCCESS (0.017s) [491.367062] Starting dynamic subtest: vcs0 [491.371336] Dynamic subtest vcs0: SUCCESS (0.016s) [491.397176] Starting dynamic subtest: vecs0 [491.400388] Dynamic subtest vecs0: SUCCESS (0.013s) [491.403735] Subtest resubmit-new: SUCCESS (0.079s) [491.670561] [116/133] (577s left) gem_eio (in-flight-suspend) [491.805640] Starting subtest: in-flight-suspend