[57.618500] Initializing watchdogs [57.618549] /dev/watchdog0 [57.632983] [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] [57.637444] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.639637] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.642983] [001/131] (960s left) kms_addfb_basic (bad-pitch-0) [57.731482] Starting subtest: bad-pitch-0 [57.733773] Subtest bad-pitch-0: SUCCESS (0.000s) [57.886930] [002/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [57.980667] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [57.984708] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [58.108166] [003/131] (960s left) kms_big_fb (x-tiled-64bpp-rotate-90) [58.208527] Starting subtest: x-tiled-64bpp-rotate-90 [58.241151] Subtest x-tiled-64bpp-rotate-90: SKIP (0.032s) [58.392951] [004/131] (959s left) kms_vrr (negative-basic) [58.484600] Starting subtest: negative-basic [58.491505] Starting dynamic subtest: pipe-A-eDP-1 [63.910751] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.432s) [64.215804] Subtest negative-basic: SUCCESS (5.744s) [65.027928] [005/131] (953s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [65.090058] Starting subtest: etime-multi-wait-available-unsubmitted [65.193877] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s) [65.284324] [006/131] (953s left) gem_exec_fence (syncobj-channel) [65.716979] Starting subtest: syncobj-channel [66.736902] Subtest syncobj-channel: SUCCESS (1.017s) [67.418297] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true [67.422080] [007/131] (950s left) perf_pmu (interrupts-sync) [67.487801] Starting subtest: interrupts-sync [68.751263] Subtest interrupts-sync: SUCCESS (1.263s) [68.882591] [008/131] (949s left) kms_plane_multiple (2x-tiling-x) [68.977685] Starting subtest: 2x-tiling-x [68.981810] Subtest 2x-tiling-x: SKIP (0.000s) [69.073049] [009/131] (949s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [69.171052] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [69.861051] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s) [70.089643] [010/131] (948s left) kms_big_fb (linear-64bpp-rotate-270) [70.190166] Starting subtest: linear-64bpp-rotate-270 [70.209497] Subtest linear-64bpp-rotate-270: SKIP (0.019s) [70.365849] [011/131] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [70.470331] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [75.205658] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.741s) [76.421592] [012/131] (942s left) gem_exec_whisper (basic-contexts-forked) [76.485403] Starting subtest: basic-contexts-forked [101.481922] Subtest basic-contexts-forked: SUCCESS (24.991s) [101.686870] [013/131] (916s left) sw_sync (alloc_fence) [101.728391] Starting subtest: alloc_fence [101.730635] Subtest alloc_fence: SUCCESS (0.000s) [101.820693] [014/131] (916s left) i915_query (query-garbage) [101.874843] Starting subtest: query-garbage [101.877132] Subtest query-garbage: SUCCESS (0.000s) [102.018296] [015/131] (916s left) gem_exec_reloc (basic-cpu-gtt-active) [102.083708] Subtest basic-cpu-gtt-active: SKIP (0.000s) [102.156541] [016/131] (916s left) gem_exec_endless (dispatch) [102.234422] Starting subtest: dispatch [102.236692] Starting dynamic subtest: rcs0 [102.243172] Dynamic subtest rcs0: SUCCESS (0.005s) [102.251587] Starting dynamic subtest: bcs0 [102.255803] Dynamic subtest bcs0: SUCCESS (0.004s) [102.268289] Starting dynamic subtest: vcs0 [102.272186] Dynamic subtest vcs0: SUCCESS (0.004s) [102.279586] Starting dynamic subtest: vcs1 [102.283577] Dynamic subtest vcs1: SUCCESS (0.005s) [102.291218] Starting dynamic subtest: vecs0 [102.295481] Dynamic subtest vecs0: SUCCESS (0.004s) [102.302790] Starting dynamic subtest: ccs0 [102.306845] Dynamic subtest ccs0: SUCCESS (0.005s) [102.308783] Subtest dispatch: SUCCESS (0.029s) [103.956987] [017/131] (914s left) kms_selftest (drm_dp_mst_helper) [103.998312] Starting subtest: drm_dp_mst_helper [104.059491] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [104.183714] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.125s) [104.191637] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [104.332079] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.148s) [104.341519] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [104.483922] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.153s) [104.486382] Subtest drm_dp_mst_helper: SUCCESS (0.486s) [104.710886] [018/131] (914s left) kms_big_fb (y-tiled-64bpp-rotate-0) [104.829968] Starting subtest: y-tiled-64bpp-rotate-0 [104.834281] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [104.966901] [019/131] (913s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [105.077277] Starting subtest: fbc-rgb565-draw-mmap-cpu [109.108703] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.035s) [110.311840] [020/131] (908s left) gem_mmap_wc (bad-size) [110.373364] Subtest bad-size: SKIP (0.000s) [110.437216] [021/131] (908s left) gem_mmap_gtt (basic-read-write) [110.499887] Subtest basic-read-write: SKIP (0.000s) [110.573499] [022/131] (908s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [110.687815] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [117.794041] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.111s) [117.993667] [023/131] (901s left) kms_psr (psr-cursor-plane-onoff) [118.092103] Starting subtest: psr-cursor-plane-onoff [118.094478] Starting dynamic subtest: eDP-1 [119.816339] Dynamic subtest eDP-1: SUCCESS (1.726s) [119.818760] Subtest psr-cursor-plane-onoff: SUCCESS (1.727s) [120.689869] [024/131] (898s left) dmabuf_sync_file (export-wait-after-attach) [120.740197] Starting subtest: export-wait-after-attach [120.742307] Subtest export-wait-after-attach: SUCCESS (0.001s) [120.820628] [025/131] (898s left) kms_pm_rpm (modeset-lpsp-stress) [123.049515] Starting subtest: modeset-lpsp-stress [138.950699] Subtest modeset-lpsp-stress: SUCCESS (15.900s) [139.062570] [026/131] (880s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [139.151913] Starting subtest: plane-upscale-20x20-with-rotation [139.154291] Starting dynamic subtest: pipe-A [139.376157] Dynamic subtest pipe-A: SUCCESS (0.226s) [139.384283] Starting dynamic subtest: pipe-B [140.680870] Dynamic subtest pipe-B: SUCCESS (1.304s) [140.689921] Starting dynamic subtest: pipe-C [142.012084] Dynamic subtest pipe-C: SUCCESS (1.331s) [142.020238] Starting dynamic subtest: pipe-D [143.357441] Dynamic subtest pipe-D: SUCCESS (1.345s) [143.359749] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.208s) [144.559370] [027/131] (874s left) prime_vgem (basic-fence-flip) [144.653455] Starting subtest: basic-fence-flip [144.945371] Subtest basic-fence-flip: SUCCESS (0.292s) [145.098261] [028/131] (874s left) gem_mmap_gtt (big-copy-xy) [145.161786] Subtest big-copy-XY: SKIP (0.000s) [145.243297] [029/131] (874s left) kms_cursor_crc (cursor-onscreen-512x512) [145.507051] Starting subtest: cursor-onscreen-512x512 [145.511596] Subtest cursor-onscreen-512x512: SKIP (0.001s) [145.686993] [030/131] (873s left) i915_pm_sseu (full-enable) [145.758657] Subtest full-enable: SKIP (0.000s) [145.874878] [031/131] (873s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [145.970945] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [145.972847] Starting dynamic subtest: pipe-A-eDP-1 [145.993984] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [146.003074] Starting dynamic subtest: pipe-B-eDP-1 [146.022468] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [146.029945] Starting dynamic subtest: pipe-C-eDP-1 [146.049334] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [146.057078] Starting dynamic subtest: pipe-D-eDP-1 [146.077974] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [146.081599] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [148.234997] [032/131] (871s left) kms_dp_link_training (non-uhbr-sst) [148.323743] Starting subtest: non-uhbr-sst [148.332305] Subtest non-uhbr-sst: SKIP (0.000s) [148.416459] [033/131] (871s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [148.511930] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [148.514273] Starting dynamic subtest: pipe-A-eDP-1 [148.539781] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [148.549746] Starting dynamic subtest: pipe-B-eDP-1 [148.574084] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [148.581551] Starting dynamic subtest: pipe-C-eDP-1 [148.605451] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [148.612983] Starting dynamic subtest: pipe-D-eDP-1 [148.637336] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [148.641722] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s) [150.796819] [034/131] (868s left) gem_pxp (regular-baseline-src-copy-readible) [150.911945] Starting subtest: regular-baseline-src-copy-readible [150.970545] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s) [151.122394] [035/131] (868s left) gem_exec_flush (basic-wb-rw-default) [151.194244] Starting subtest: basic-wb-rw-default [156.648784] Subtest basic-wb-rw-default: SUCCESS (5.457s) [156.862337] [036/131] (862s left) syncobj_timeline (signal-array) [156.919869] Starting subtest: signal-array [156.922180] Subtest signal-array: SUCCESS (0.000s) [157.058846] [037/131] (862s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [157.160200] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [158.228151] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.068s) [158.394137] [038/131] (861s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [158.494817] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [158.498341] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [158.630910] [039/131] (861s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [158.690067] Subtest writes-after-reads-uncached: SKIP (0.000s) [158.772745] [040/131] (860s left) gem_flink_basic (bad-open) [158.828262] Starting subtest: bad-open [158.830539] Subtest bad-open: SUCCESS (0.000s) [158.965720] [041/131] (860s left) gem_ctx_shared (q-promotion) [159.032102] Starting subtest: Q-promotion [159.034050] Starting dynamic subtest: rcs0 [159.130636] Dynamic subtest rcs0: SUCCESS (0.098s) [159.147763] Starting dynamic subtest: vcs0 [159.211943] Dynamic subtest vcs0: SUCCESS (0.081s) [159.226467] Starting dynamic subtest: vcs1 [159.293685] Dynamic subtest vcs1: SUCCESS (0.081s) [159.308970] Starting dynamic subtest: vecs0 [159.365498] Dynamic subtest vecs0: SUCCESS (0.072s) [159.380541] Starting dynamic subtest: ccs0 [159.441895] Dynamic subtest ccs0: SUCCESS (0.076s) [159.444343] Subtest Q-promotion: SUCCESS (0.410s) [161.048809] [042/131] (858s left) kms_cursor_legacy (forked-bo) [161.170971] Starting subtest: forked-bo [161.174068] Starting dynamic subtest: pipe-A [166.642673] Dynamic subtest pipe-A: SUCCESS (5.470s) [166.654174] Starting dynamic subtest: pipe-B [172.118047] Dynamic subtest pipe-B: SUCCESS (5.471s) [172.129834] Starting dynamic subtest: pipe-C [177.583217] Dynamic subtest pipe-C: SUCCESS (5.464s) [177.595484] Starting dynamic subtest: pipe-D [183.050259] Dynamic subtest pipe-D: SUCCESS (5.465s) [183.060871] Starting dynamic subtest: all-pipes [188.558625] Dynamic subtest all-pipes: SUCCESS (5.498s) [188.560949] Subtest forked-bo: SUCCESS (27.378s) [188.718547] [043/131] (831s left) gem_readwrite (new-obj) [188.784038] Subtest new-obj: SKIP (0.000s) [188.850705] [044/131] (831s left) kms_busy (extended-modeset-hang-newfb) [188.961787] Starting subtest: extended-modeset-hang-newfb [188.964110] Starting dynamic subtest: pipe-A [223.754056] Dynamic subtest pipe-A: SUCCESS (34.792s) [223.763493] Starting dynamic subtest: pipe-D [246.799382] Dynamic subtest pipe-D: SUCCESS (23.041s) [246.801679] Subtest extended-modeset-hang-newfb: SUCCESS (57.838s) [247.627064] [045/131] (772s left) kms_color (ctm-0-50) [247.741047] Starting subtest: ctm-0-50 [247.742941] Starting dynamic subtest: pipe-A-eDP-1 [251.222562] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s) [251.240768] Starting dynamic subtest: pipe-B-eDP-1 [255.340257] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.116s) [255.350736] Starting dynamic subtest: pipe-C-eDP-1 [259.283610] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.943s) [259.292529] Starting dynamic subtest: pipe-D-eDP-1 [263.308251] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.024s) [263.310503] Subtest ctm-0-50: SUCCESS (15.567s) [264.160742] [046/131] (755s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [264.255573] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [264.257769] Starting dynamic subtest: pipe-A-eDP-1 [266.424314] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.169s) [266.432184] Starting dynamic subtest: pipe-B-eDP-1 [268.594632] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.169s) [268.602684] Starting dynamic subtest: pipe-C-eDP-1 [270.783487] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.187s) [270.792217] Starting dynamic subtest: pipe-D-eDP-1 [272.886423] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.101s) [272.888427] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.632s) [274.112043] [047/131] (745s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [274.222716] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [274.227286] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [274.353548] [048/131] (745s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [274.461740] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [274.466123] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [274.595131] [049/131] (745s left) i915_drm_fdinfo (busy) [274.640237] Starting subtest: busy [274.642104] Starting dynamic subtest: rcs0 [274.669317] Dynamic subtest rcs0: SKIP (0.029s) [274.679662] Starting dynamic subtest: bcs0 [274.683620] Dynamic subtest bcs0: SKIP (0.000s) [274.692136] Starting dynamic subtest: vcs0 [274.696224] Dynamic subtest vcs0: SKIP (0.000s) [274.704232] Starting dynamic subtest: vcs1 [274.708148] Dynamic subtest vcs1: SKIP (0.000s) [274.715861] Starting dynamic subtest: vecs0 [274.719966] Dynamic subtest vecs0: SKIP (0.000s) [274.729261] Starting dynamic subtest: ccs0 [274.733177] Dynamic subtest ccs0: SKIP (0.000s) [274.737196] Subtest busy: SKIP (0.035s) [274.772088] [050/131] (745s left) kms_addfb_basic (bad-pitch-32) [274.826568] Starting subtest: bad-pitch-32 [274.828791] Subtest bad-pitch-32: SUCCESS (0.000s) [274.985250] [051/131] (745s left) sysfs_heartbeat_interval (invalid) [275.051606] Starting subtest: invalid [275.053619] Starting dynamic subtest: vecs0 [275.055608] Dynamic subtest vecs0: SUCCESS (0.000s) [275.065041] Starting dynamic subtest: ccs0 [275.066932] Dynamic subtest ccs0: SUCCESS (0.000s) [275.074549] Starting dynamic subtest: vcs0 [275.076303] Dynamic subtest vcs0: SUCCESS (0.000s) [275.083819] Starting dynamic subtest: bcs0 [275.085565] Dynamic subtest bcs0: SUCCESS (0.000s) [275.093786] Starting dynamic subtest: rcs0 [275.095682] Dynamic subtest rcs0: SUCCESS (0.000s) [275.105274] Starting dynamic subtest: vcs1 [275.107061] Dynamic subtest vcs1: SUCCESS (0.000s) [275.108867] Subtest invalid: SUCCESS (0.006s) [275.188768] [052/131] (745s left) kms_atomic (test-only) [275.293072] Starting subtest: test-only [275.342847] Starting dynamic subtest: pipe-A-eDP-1 [277.794832] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.451s) [277.797095] Subtest test-only: SUCCESS (2.501s) [278.613699] [053/131] (741s left) kms_sequence (get-busy) [278.714729] Starting subtest: get-busy [278.716968] Starting dynamic subtest: pipe-A-eDP-1 [280.657284] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s) [280.666949] Starting dynamic subtest: pipe-B-eDP-1 [283.295633] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.633s) [283.305272] Starting dynamic subtest: pipe-C-eDP-1 [285.903360] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.608s) [285.912227] Starting dynamic subtest: pipe-D-eDP-1 [288.444591] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.538s) [288.446507] Subtest get-busy: SUCCESS (9.728s) [289.359213] [054/131] (730s left) kms_invalid_mode (zero-hdisplay) [289.456350] Starting subtest: zero-hdisplay [289.458645] Starting dynamic subtest: pipe-A-eDP-1 [289.743386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [289.754046] Starting dynamic subtest: pipe-B-eDP-1 [289.756502] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [289.764807] Starting dynamic subtest: pipe-C-eDP-1 [289.766838] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [289.774575] Starting dynamic subtest: pipe-D-eDP-1 [289.776555] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [289.778516] Subtest zero-hdisplay: SUCCESS (0.291s) [290.582646] [055/131] (729s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [290.684625] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [294.381096] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.700s) [295.588927] [056/131] (724s left) gem_softpin (allocator-evict) [295.654385] Starting subtest: allocator-evict [295.656833] Starting dynamic subtest: rcs0 [319.010553] Dynamic subtest rcs0: SUCCESS (23.354s) [319.022666] Starting dynamic subtest: bcs0 [343.123774] Dynamic subtest bcs0: SUCCESS (24.110s) [343.135088] Starting dynamic subtest: vcs0 [366.813542] Dynamic subtest vcs0: SUCCESS (23.687s) [366.824985] Starting dynamic subtest: vcs1 [390.274726] Dynamic subtest vcs1: SUCCESS (23.459s) [390.284405] Starting dynamic subtest: vecs0 [413.675065] Dynamic subtest vecs0: SUCCESS (23.398s) [413.686952] Starting dynamic subtest: ccs0 [437.197603] Dynamic subtest ccs0: SUCCESS (23.520s) [437.200554] Subtest allocator-evict: SUCCESS (141.537s) [437.300557] [057/131] (583s left) kms_cursor_crc (cursor-offscreen-256x85) [437.660138] Starting subtest: cursor-offscreen-256x85 [437.727499] Subtest cursor-offscreen-256x85: SKIP (0.062s) [437.943427] [058/131] (582s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [438.041063] Starting subtest: fbcpsr-rgb101010-draw-blt [444.863345] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.824s) [445.013548] [059/131] (575s left) kms_color (deep-color) [445.119530] Starting subtest: deep-color [446.155206] Starting dynamic subtest: pipe-A-eDP-1-gamma [446.911308] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.757s) [446.925725] Starting dynamic subtest: pipe-A-eDP-1-degamma [448.352846] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.439s) [448.361854] Starting dynamic subtest: pipe-A-eDP-1-ctm [449.793508] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.442s) [450.559058] Starting dynamic subtest: pipe-B-eDP-1-gamma [451.269798] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.716s) [451.278928] Starting dynamic subtest: pipe-B-eDP-1-degamma [452.676047] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.405s) [452.685504] Starting dynamic subtest: pipe-B-eDP-1-ctm [454.069803] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.394s) [454.871892] Starting dynamic subtest: pipe-C-eDP-1-gamma [455.560686] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.694s) [455.570478] Starting dynamic subtest: pipe-C-eDP-1-degamma [456.927686] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.365s) [456.936570] Starting dynamic subtest: pipe-C-eDP-1-ctm [458.327638] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.399s) [459.148646] Starting dynamic subtest: pipe-D-eDP-1-gamma [459.845347] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.703s) [459.857071] Starting dynamic subtest: pipe-D-eDP-1-degamma [461.318776] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.475s) [461.327630] Starting dynamic subtest: pipe-D-eDP-1-ctm [462.741101] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.421s) [462.743651] Subtest deep-color: SUCCESS (17.626s) [463.631345] [060/131] (556s left) gem_exec_create (forked) [463.703031] Starting subtest: forked [463.705398] Starting dynamic subtest: smem [483.886884] Dynamic subtest smem: SUCCESS (20.183s) [483.889235] Subtest forked: SUCCESS (20.185s) [484.105233] [061/131] (536s left) gem_exec_schedule (pi-common) [484.311544] Starting subtest: pi-common [484.314097] Starting dynamic subtest: rcs0 [484.348772] Dynamic subtest rcs0: SUCCESS (0.042s) [484.358103] Starting dynamic subtest: bcs0 [484.394061] Dynamic subtest bcs0: SUCCESS (0.044s) [484.403310] Starting dynamic subtest: vcs0 [484.429108] Dynamic subtest vcs0: SUCCESS (0.034s) [484.438110] Starting dynamic subtest: vcs1 [484.466863] Dynamic subtest vcs1: SUCCESS (0.036s) [484.475846] Starting dynamic subtest: vecs0 [484.501741] Dynamic subtest vecs0: SUCCESS (0.034s) [484.510665] Starting dynamic subtest: ccs0 [484.533565] Dynamic subtest ccs0: SUCCESS (0.031s) [484.535927] Subtest pi-common: SUCCESS (0.228s) [484.793404] [062/131] (535s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [484.856343] Starting subtest: invalid-multi-wait-unsubmitted-submitted [484.858692] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [484.996376] [063/131] (535s left) syncobj_timeline (single-wait-signaled) [485.059271] Starting subtest: single-wait-signaled [485.061665] Subtest single-wait-signaled: SUCCESS (0.000s) [485.199466] [064/131] (535s left) gem_ctx_persistence (saturated-hostile) [485.266995] Starting subtest: saturated-hostile [485.269412] Starting dynamic subtest: rcs0 [486.137721] Dynamic subtest rcs0: SUCCESS (0.870s) [486.149373] Starting dynamic subtest: bcs0 [486.957191] Dynamic subtest bcs0: SUCCESS (0.818s) [486.968731] Starting dynamic subtest: vcs0 [487.773741] Dynamic subtest vcs0: SUCCESS (0.815s) [487.785476] Starting dynamic subtest: vcs1 [488.600389] Dynamic subtest vcs1: SUCCESS (0.825s) [488.612662] Starting dynamic subtest: vecs0 [489.418180] Dynamic subtest vecs0: SUCCESS (0.816s) [489.428961] Starting dynamic subtest: ccs0 [490.288287] Dynamic subtest ccs0: SUCCESS (0.864s) [490.290984] Subtest saturated-hostile: SUCCESS (5.019s) [490.392524] [065/131] (530s left) gem_close_race (multigpu-basic-threads) [490.485753] Starting subtest: multigpu-basic-threads [490.490566] Subtest multigpu-basic-threads: SKIP (0.000s) [490.751467] [066/131] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [490.863774] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [490.867755] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [490.995494] [067/131] (529s left) kms_pm_rpm (i2c) [493.052254] Starting subtest: i2c [498.333818] Subtest i2c: SUCCESS (5.280s) [498.446226] [068/131] (522s left) kms_psr (fbc-pr-sprite-plane-move) [498.539582] Starting subtest: fbc-pr-sprite-plane-move [498.543834] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [498.635572] [069/131] (522s left) gem_mmap_offset (bad-extensions) [498.697622] Starting subtest: bad-extensions [498.699581] Subtest bad-extensions: SUCCESS (0.000s) [498.804087] [070/131] (522s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [498.910786] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [498.915090] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [499.026024] [071/131] (521s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [499.132646] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [499.136754] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [499.269336] [072/131] (521s left) perf_pmu (most-busy-idle-check-all) [499.310775] Starting subtest: most-busy-idle-check-all [499.313147] Starting dynamic subtest: rcs0 [500.885086] Dynamic subtest rcs0: SUCCESS (1.573s) [500.897363] Starting dynamic subtest: bcs0 [502.933483] Dynamic subtest bcs0: SUCCESS (2.045s) [502.944740] Starting dynamic subtest: vcs0 [504.917396] Dynamic subtest vcs0: SUCCESS (1.980s) [504.929651] Starting dynamic subtest: vcs1 [506.901746] Dynamic subtest vcs1: SUCCESS (1.981s) [506.913839] Starting dynamic subtest: vecs0 [508.885460] Dynamic subtest vecs0: SUCCESS (1.981s) [508.897080] Starting dynamic subtest: ccs0 [510.933802] Dynamic subtest ccs0: SUCCESS (2.045s) [510.936906] Subtest most-busy-idle-check-all: SUCCESS (11.623s) [511.066355] [073/131] (510s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [511.474705] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [512.357656] [074/131] (508s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [512.468749] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [512.473404] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [512.602853] [075/131] (508s left) gem_ctx_persistence (engines-cleanup) [512.668355] Starting subtest: engines-cleanup [512.670818] Starting dynamic subtest: rcs0 [512.717412] Dynamic subtest rcs0: SUCCESS (0.049s) [512.728319] Starting dynamic subtest: bcs0 [512.819900] Dynamic subtest bcs0: SUCCESS (0.101s) [512.831880] Starting dynamic subtest: vcs0 [512.885984] Dynamic subtest vcs0: SUCCESS (0.064s) [512.897538] Starting dynamic subtest: vcs1 [512.933633] Dynamic subtest vcs1: SUCCESS (0.046s) [512.944618] Starting dynamic subtest: vecs0 [512.960635] Dynamic subtest vecs0: SUCCESS (0.025s) [512.969111] Starting dynamic subtest: ccs0 [513.037598] Dynamic subtest ccs0: SUCCESS (0.076s) [513.040136] Subtest engines-cleanup: SUCCESS (0.370s) [513.136738] [076/131] (508s left) prime_mmap (test_map_unmap) [513.199313] Starting subtest: test_map_unmap [513.201030] Starting dynamic subtest: test_map_unmap-smem [513.248150] Dynamic subtest test_map_unmap-smem: SUCCESS (0.051s) [513.250167] Subtest test_map_unmap: SUCCESS (0.052s) [513.394987] [077/131] (507s left) gem_userptr_blits (set-cache-level) [513.463933] Starting subtest: set-cache-level [513.468260] Subtest set-cache-level: SKIP (0.000s) [513.607779] [078/131] (507s left) gem_busy (busy) [513.675144] Starting subtest: busy [513.677362] Starting dynamic subtest: all-engines [513.749962] Dynamic subtest all-engines: SUCCESS (0.074s) [513.758453] Starting dynamic subtest: rcs0 [514.906727] Dynamic subtest rcs0: SUCCESS (1.154s) [514.916803] Starting dynamic subtest: bcs0 [514.946087] Dynamic subtest bcs0: SUCCESS (0.038s) [514.954403] Starting dynamic subtest: vcs0 [514.985235] Dynamic subtest vcs0: SUCCESS (0.038s) [514.994129] Starting dynamic subtest: vcs1 [516.891524] Dynamic subtest vcs1: SUCCESS (1.902s) [516.902367] Starting dynamic subtest: vecs0 [518.938097] Dynamic subtest vecs0: SUCCESS (2.045s) [518.948207] Starting dynamic subtest: ccs0 [520.922082] Dynamic subtest ccs0: SUCCESS (1.984s) [520.924814] Subtest busy: SUCCESS (7.244s) [521.322688] [079/131] (500s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [521.445179] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [528.802391] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.359s) [528.941315] [080/131] (492s left) core_auth (basic-auth) [528.988097] Starting subtest: basic-auth [528.990348] Subtest basic-auth: SUCCESS (0.001s) [529.124520] [081/131] (492s left) prime_mmap_coherency (write) [529.179715] Starting subtest: write [534.557510] Subtest write: SUCCESS (5.376s) [534.737192] [082/131] (486s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [534.796090] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [534.800631] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [535.006415] [083/131] (486s left) perf (gen12-invalid-class-instance) [535.145042] Starting subtest: gen12-invalid-class-instance [535.156251] Subtest gen12-invalid-class-instance: SUCCESS (0.011s) [535.203978] [084/131] (486s left) kms_lease (lease-get) [535.307621] Starting subtest: lease-get [535.309924] Starting dynamic subtest: pipe-A-eDP-1 [535.312146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [535.321998] Starting dynamic subtest: pipe-B-eDP-1 [535.324141] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [535.332707] Starting dynamic subtest: pipe-C-eDP-1 [535.334823] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [535.343164] Starting dynamic subtest: pipe-D-eDP-1 [535.345263] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [535.347351] Subtest lease-get: SUCCESS (0.012s) [535.463102] [085/131] (486s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [535.561465] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [535.565655] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [535.709402] [086/131] (485s left) i915_pm_rpm (system-suspend-devices) [537.234364] Starting subtest: system-suspend-devices [548.727338] Subtest system-suspend-devices: SUCCESS (11.496s) [549.133014] [087/131] (472s left) kms_cursor_edge_walk (128x128-right-edge) [549.231892] Starting subtest: 128x128-right-edge [549.234095] Starting dynamic subtest: pipe-A-eDP-1 [552.644684] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.411s) [552.655313] Starting dynamic subtest: pipe-D-eDP-1 [555.755957] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.110s) [555.758322] Subtest 128x128-right-edge: SUCCESS (6.524s) [556.588901] [088/131] (465s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [561.627733] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [561.630064] Starting dynamic subtest: pipe-A-eDP-1 [562.429552] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s) [562.439948] Starting dynamic subtest: pipe-B-eDP-1 [563.557467] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s) [563.561928] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.925s) [564.758089] [089/131] (457s left) perf (i915-ref-count) [564.873977] Starting subtest: i915-ref-count [564.899826] Subtest i915-ref-count: SUCCESS (0.024s) [564.955746] [090/131] (456s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [565.067711] Starting subtest: fbc-2p-primscrn-spr-indfb-move [565.071964] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [565.215669] [091/131] (456s left) core_auth (getclient-simple) [565.257299] Starting subtest: getclient-simple [565.281070] Subtest getclient-simple: SUCCESS (0.027s) [565.438312] [092/131] (456s left) i915_pciid [565.646722] [093/131] (456s left) gem_exec_fence (syncobj-timeline-signal) [566.213809] Starting subtest: syncobj-timeline-signal [566.216685] Subtest syncobj-timeline-signal: SUCCESS (0.007s) [568.014527] [094/131] (454s left) kms_flip (bo-too-big) [568.121313] Starting subtest: bo-too-big [568.123677] Starting dynamic subtest: A-eDP1 [569.382227] Dynamic subtest A-eDP1: SUCCESS (1.260s) [569.399602] Starting dynamic subtest: B-eDP1 [570.729454] Dynamic subtest B-eDP1: SUCCESS (1.345s) [570.743355] Starting dynamic subtest: C-eDP1 [572.062681] Dynamic subtest C-eDP1: SUCCESS (1.330s) [572.074904] Starting dynamic subtest: D-eDP1 [573.400568] Dynamic subtest D-eDP1: SUCCESS (1.337s) [573.402996] Subtest bo-too-big: SUCCESS (5.282s) [574.629838] [095/131] (447s left) kms_psr (pr-basic) [574.736138] Starting subtest: pr-basic [574.740846] Subtest pr-basic: SKIP (0.000s) [574.832082] [096/131] (447s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [574.933530] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [574.938078] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [575.057049] [097/131] (447s left) kms_addfb_basic (tile-pitch-mismatch) [575.122217] Starting subtest: tile-pitch-mismatch [575.126898] Subtest tile-pitch-mismatch: SKIP (0.000s) [575.276540] [098/131] (446s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [575.377776] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [575.380188] Starting dynamic subtest: pipe-A-eDP-1 [575.389409] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [575.400248] Starting dynamic subtest: pipe-B-eDP-1 [575.409598] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [575.419636] Starting dynamic subtest: pipe-C-eDP-1 [575.428543] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [575.439292] Starting dynamic subtest: pipe-D-eDP-1 [575.447840] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [575.452075] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s) [577.683915] [099/131] (444s left) gem_exec_reloc (basic-write-cpu-active) [577.748594] Subtest basic-write-cpu-active: SKIP (0.000s) [577.836476] [100/131] (444s left) gem_exec_whisper (basic-queues-forked-all) [577.906803] Starting subtest: basic-queues-forked-all [596.065863] Subtest basic-queues-forked-all: SUCCESS (18.155s) [596.275753] [101/131] (426s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [596.377849] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [596.380081] Starting dynamic subtest: pipe-A-default-mode [597.530266] Dynamic subtest pipe-A-default-mode: SKIP (1.149s) [597.533888] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.151s) [597.716720] [102/131] (424s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [597.821906] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [597.824111] Starting dynamic subtest: pipe-A-default-mode [598.111824] Dynamic subtest pipe-A-default-mode: SKIP (0.287s) [598.116632] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.288s) [598.939757] [103/131] (423s left) prime_mmap (test_dup) [599.001154] Starting subtest: test_dup [599.003779] Starting dynamic subtest: test_dup-smem [599.051758] Dynamic subtest test_dup-smem: SUCCESS (0.051s) [599.054866] Subtest test_dup: SUCCESS (0.052s) [599.152218] [104/131] (423s left) kms_addfb_basic (legacy-format) [599.207992] Starting subtest: legacy-format [599.252060] Subtest legacy-format: SUCCESS (0.044s) [599.452433] [105/131] (423s left) gem_workarounds (suspend-resume-context) [599.520140] Starting subtest: suspend-resume-context [615.917069] Subtest suspend-resume-context: SUCCESS (1.188s) [616.103840] [106/131] (406s left) gem_fence_thrash (bo-write-verify-none) [616.151498] Starting subtest: bo-write-verify-none [616.180569] Subtest bo-write-verify-none: SKIP (0.027s) [616.268111] [107/131] (406s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [621.213015] Starting subtest: psr2-cursor-plane-move-continuous-sf [621.215228] Starting dynamic subtest: pipe-A-eDP-1 [632.267192] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.108s) [632.278756] Starting dynamic subtest: pipe-B-eDP-1 [643.359144] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.106s) [643.361387] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.218s) [644.193239] [108/131] (378s left) kms_rotation_crc (primary-rotation-270) [644.285566] Starting subtest: primary-rotation-270 [644.289640] Subtest primary-rotation-270: SKIP (0.001s) [644.381662] [109/131] (378s left) syncobj_wait (invalid-reset-illegal-handle) [644.437305] Starting subtest: invalid-reset-illegal-handle [644.439665] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [644.546175] [110/131] (378s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [644.610091] Starting subtest: y-tiled-ccs-to-y-tiled [644.614687] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [644.817762] [111/131] (377s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [644.915857] Starting subtest: primary-y-tiled-reflect-x-270 [644.920528] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [645.012529] [112/131] (377s left) gen9_exec_parse (bb-large) [645.067082] Subtest bb-large: SKIP (0.000s) [645.141158] [113/131] (377s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [645.199826] Starting subtest: multi-wait-all-for-submit-signaled [645.202133] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [645.338964] [114/131] (377s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [645.435004] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [645.437288] Starting dynamic subtest: pipe-A [645.547683] Dynamic subtest pipe-A: SKIP (0.109s) [645.558518] Starting dynamic subtest: pipe-B [646.725803] Dynamic subtest pipe-B: SKIP (1.179s) [646.736621] Starting dynamic subtest: pipe-C [647.881165] Dynamic subtest pipe-C: SUCCESS (1.160s) [647.891649] Starting dynamic subtest: pipe-D [649.098422] Dynamic subtest pipe-D: SUCCESS (1.216s) [649.100711] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.669s) [650.315455] [115/131] (372s left) kms_psr (psr2-cursor-render) [650.419523] Starting subtest: psr2-cursor-render [650.421875] Starting dynamic subtest: eDP-1 [652.184993] Dynamic subtest eDP-1: SUCCESS (1.765s) [652.187304] Subtest psr2-cursor-render: SUCCESS (1.766s) [653.087440] [116/131] (369s left) gem_userptr_blits (invalid-null-pointer) [653.158461] Starting subtest: invalid-null-pointer [653.160681] Subtest invalid-null-pointer: SUCCESS (0.001s) [653.326850] [117/131] (369s left) api_intel_allocator (simple-allocator) [653.381013] Starting subtest: simple-allocator [653.383330] Starting dynamic subtest: basic [653.385290] Dynamic subtest basic: SUCCESS (0.004s) [653.401805] Starting dynamic subtest: parallel-one [653.571760] Dynamic subtest parallel-one: SUCCESS (0.184s) [653.584418] Starting dynamic subtest: print [653.586666] Dynamic subtest print: SUCCESS (0.000s) [653.596252] Starting dynamic subtest: reuse [653.598081] Dynamic subtest reuse: SUCCESS (0.000s) [653.607342] Starting dynamic subtest: reserve [653.609325] Dynamic subtest reserve: SUCCESS (0.000s) [653.618568] Starting dynamic subtest: fork-reopen-allocator [653.620823] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s) [653.622923] Subtest simple-allocator: SUCCESS (0.208s) [653.749673] [118/131] (369s left) kms_pipe_stress (stress-xrgb8888-yftiled) [653.855328] Starting subtest: stress-xrgb8888-yftiled [653.859674] Subtest stress-xrgb8888-yftiled: SKIP (0.000s) [653.928647] [119/131] (369s left) kms_flip (wf_vblank-ts-check) [654.025822] Starting subtest: wf_vblank-ts-check [654.028182] Starting dynamic subtest: A-eDP1 [662.917547] Dynamic subtest A-eDP1: SUCCESS (8.888s) [662.930384] Starting dynamic subtest: B-eDP1 [671.851498] Dynamic subtest B-eDP1: SUCCESS (8.932s) [671.861948] Starting dynamic subtest: C-eDP1 [680.759561] Dynamic subtest C-eDP1: SUCCESS (8.907s) [680.769501] Starting dynamic subtest: D-eDP1 [689.680624] Dynamic subtest D-eDP1: SUCCESS (8.924s) [689.686400] Subtest wf_vblank-ts-check: SUCCESS (35.660s) [690.919470] [120/131] (332s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [691.023015] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [691.025354] Starting dynamic subtest: pipe-A-eDP-1 [691.048783] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [691.064734] Starting dynamic subtest: pipe-B-eDP-1 [691.087139] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [691.096524] Starting dynamic subtest: pipe-C-eDP-1 [691.119047] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [691.129950] Starting dynamic subtest: pipe-D-eDP-1 [691.153108] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [691.157632] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [693.205440] [121/131] (329s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [693.268791] Starting subtest: invalid-multi-wait-unsubmitted [693.271183] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [693.406944] [122/131] (329s left) prime_mmap (test_errors) [693.471787] Starting subtest: test_errors [693.473845] Starting dynamic subtest: test_errors-smem [693.567502] Dynamic subtest test_errors-smem: SUCCESS (0.097s) [693.570541] Subtest test_errors: SUCCESS (0.098s) [693.698569] [123/131] (329s left) gem_exec_async (forked-writes) [693.763324] Starting subtest: forked-writes [693.765743] Starting dynamic subtest: rcs0 [693.790417] Dynamic subtest rcs0: SUCCESS (0.026s) [693.803310] Starting dynamic subtest: bcs0 [693.814472] Dynamic subtest bcs0: SUCCESS (0.024s) [693.825371] Starting dynamic subtest: vcs0 [693.838119] Dynamic subtest vcs0: SUCCESS (0.023s) [693.848885] Starting dynamic subtest: vcs1 [693.859260] Dynamic subtest vcs1: SUCCESS (0.021s) [693.870645] Starting dynamic subtest: vecs0 [693.881726] Dynamic subtest vecs0: SUCCESS (0.021s) [693.893083] Starting dynamic subtest: ccs0 [693.908141] Dynamic subtest ccs0: SUCCESS (0.026s) [693.910438] Subtest forked-writes: SUCCESS (0.145s) [694.174758] [124/131] (329s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [694.287159] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [698.778761] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.497s) [700.016080] [125/131] (323s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [700.111804] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [700.114233] Starting dynamic subtest: pipe-A-default-mode [700.424561] Dynamic subtest pipe-A-default-mode: SKIP (0.312s) [700.429349] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.313s) [701.241113] [126/131] (322s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [701.338964] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [710.798378] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.465s) [710.958599] [127/131] (312s left) gem_mmap_gtt (cpuset-basic-small-copy) [711.032866] Subtest cpuset-basic-small-copy: SKIP (0.000s) [711.105110] [128/131] (312s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [716.174134] Starting subtest: psr2-primary-plane-update-sf-dmg-area [716.176486] Starting dynamic subtest: pipe-A-eDP-1 [722.718112] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.537s) [722.729473] Starting dynamic subtest: pipe-B-eDP-1 [729.355532] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.635s) [729.357996] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.176s) [730.257097] [129/131] (293s left) sriov_basic (enable-vfs-bind-unbind-each) [730.333715] Starting subtest: enable-vfs-bind-unbind-each [730.336381] Starting dynamic subtest: numvfs-1 [730.415046] Dynamic subtest numvfs-1: FAIL (0.029s) [730.424814] Starting dynamic subtest: numvfs-2 [730.495353] Dynamic subtest numvfs-2: FAIL (0.004s) [730.506529] Starting dynamic subtest: numvfs-3 [730.580215] Dynamic subtest numvfs-3: FAIL (0.004s) [730.592073] Starting dynamic subtest: numvfs-4 [730.665453] Dynamic subtest numvfs-4: FAIL (0.005s) [730.676428] Starting dynamic subtest: numvfs-5 [730.750000] Dynamic subtest numvfs-5: FAIL (0.004s) [730.761769] Starting dynamic subtest: numvfs-6 [730.835234] Dynamic subtest numvfs-6: FAIL (0.003s) [730.846335] Starting dynamic subtest: numvfs-7 [730.919492] Dynamic subtest numvfs-7: FAIL (0.003s) [730.931082] Starting dynamic subtest: numvfs-random [731.003329] Dynamic subtest numvfs-random: FAIL (0.003s) [731.005777] Subtest enable-vfs-bind-unbind-each: FAIL (0.061s) [731.044628] [130/131] (292s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [731.146425] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [737.956300] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.812s) [738.087384] [131/131] (285s left) gem_exec_schedule (u-fairslice) [738.162117] Starting subtest: u-fairslice [738.164125] Starting dynamic subtest: rcs0 [740.175589] Dynamic subtest rcs0: SUCCESS (2.018s) [740.186119] Starting dynamic subtest: bcs0 [742.193234] Dynamic subtest bcs0: SUCCESS (2.018s) [742.205814] Starting dynamic subtest: vcs0 [744.213055] Dynamic subtest vcs0: SUCCESS (2.018s) [744.223639] Starting dynamic subtest: vcs1 [746.231124] Dynamic subtest vcs1: SUCCESS (2.015s) [746.242665] Starting dynamic subtest: vecs0 [748.248416] Dynamic subtest vecs0: SUCCESS (2.016s) [748.259782] Starting dynamic subtest: ccs0 [750.266733] Dynamic subtest ccs0: SUCCESS (2.019s) [750.269085] Subtest u-fairslice: SUCCESS (12.110s) [750.586531] 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.