[62.013940] Initializing watchdogs [62.013986] /dev/watchdog0 [62.027590] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [62.031703] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.034056] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.037380] [001/131] (960s left) kms_addfb_basic (bad-pitch-0) [62.123151] Starting subtest: bad-pitch-0 [62.125440] Subtest bad-pitch-0: SUCCESS (0.000s) [62.289674] [002/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [62.399761] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [62.404232] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [62.501255] [003/131] (960s left) kms_big_fb (x-tiled-64bpp-rotate-90) [62.609795] Starting subtest: x-tiled-64bpp-rotate-90 [62.641844] Subtest x-tiled-64bpp-rotate-90: SKIP (0.031s) [62.779850] [004/131] (959s left) kms_vrr (negative-basic) [62.867280] Starting subtest: negative-basic [62.872978] Starting dynamic subtest: pipe-A-eDP-1 [68.291885] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.417s) [68.584484] Subtest negative-basic: SUCCESS (5.717s) [69.397152] [005/131] (953s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [69.455766] Starting subtest: etime-multi-wait-available-unsubmitted [69.561064] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.104s) [69.653727] [006/131] (953s left) gem_exec_fence (syncobj-channel) [70.080484] Starting subtest: syncobj-channel [71.097517] Subtest syncobj-channel: SUCCESS (1.016s) [72.023289] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true [72.026205] [007/131] (950s left) perf_pmu (interrupts-sync) [72.065536] Starting subtest: interrupts-sync [73.145974] Subtest interrupts-sync: SUCCESS (1.080s) [73.301662] [008/131] (949s left) kms_plane_multiple (2x-tiling-x) [73.401791] Starting subtest: 2x-tiling-x [73.406224] Subtest 2x-tiling-x: SKIP (0.000s) [73.491621] [009/131] (949s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [73.592666] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [74.227618] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s) [74.433209] [010/131] (948s left) kms_big_fb (linear-64bpp-rotate-270) [74.537444] Starting subtest: linear-64bpp-rotate-270 [74.557040] Subtest linear-64bpp-rotate-270: SKIP (0.019s) [74.694355] [011/131] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [74.798274] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [79.469718] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.675s) [80.613913] [012/131] (942s left) gem_exec_whisper (basic-contexts-forked) [80.686799] Starting subtest: basic-contexts-forked [105.361608] Subtest basic-contexts-forked: SUCCESS (24.673s) [105.564619] [013/131] (917s left) sw_sync (alloc_fence) [105.613616] Starting subtest: alloc_fence [105.615791] Subtest alloc_fence: SUCCESS (0.000s) [105.703762] [014/131] (917s left) i915_query (query-garbage) [105.756606] Starting subtest: query-garbage [105.758779] Subtest query-garbage: SUCCESS (0.000s) [105.904781] [015/131] (917s left) gem_exec_reloc (basic-cpu-gtt-active) [105.976326] Subtest basic-cpu-gtt-active: SKIP (0.000s) [106.052972] [016/131] (917s left) gem_exec_endless (dispatch) [106.132048] Starting subtest: dispatch [106.134433] Starting dynamic subtest: rcs0 [106.139035] Dynamic subtest rcs0: SUCCESS (0.005s) [106.148206] Starting dynamic subtest: bcs0 [106.152324] Dynamic subtest bcs0: SUCCESS (0.005s) [106.160286] Starting dynamic subtest: vcs0 [106.164895] Dynamic subtest vcs0: SUCCESS (0.005s) [106.173527] Starting dynamic subtest: vcs1 [106.177582] Dynamic subtest vcs1: SUCCESS (0.007s) [106.185271] Starting dynamic subtest: vecs0 [106.189123] Dynamic subtest vecs0: SUCCESS (0.006s) [106.196763] Starting dynamic subtest: ccs0 [106.200963] Dynamic subtest ccs0: SUCCESS (0.006s) [106.202943] Subtest dispatch: SUCCESS (0.036s) [107.995054] [017/131] (915s left) kms_selftest (drm_dp_mst_helper) [108.041786] Starting subtest: drm_dp_mst_helper [108.105369] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [108.257729] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.152s) [108.267161] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [108.373303] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.118s) [108.381349] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [108.514065] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.140s) [108.516305] Subtest drm_dp_mst_helper: SUCCESS (0.474s) [108.720278] [018/131] (914s left) kms_big_fb (y-tiled-64bpp-rotate-0) [108.833809] Starting subtest: y-tiled-64bpp-rotate-0 [108.837854] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [108.951054] [019/131] (914s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [109.044687] Starting subtest: fbc-rgb565-draw-mmap-cpu [113.169675] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.129s) [114.315687] [020/131] (908s left) gem_mmap_wc (bad-size) [114.378783] Subtest bad-size: SKIP (0.000s) [114.438118] [021/131] (908s left) gem_mmap_gtt (basic-read-write) [114.508480] Subtest basic-read-write: SKIP (0.000s) [114.573383] [022/131] (908s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [114.671942] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [121.725746] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.057s) [121.913919] [023/131] (901s left) kms_psr (psr-cursor-plane-onoff) [122.005460] Starting subtest: psr-cursor-plane-onoff [122.007716] Starting dynamic subtest: eDP-1 [123.721859] Dynamic subtest eDP-1: SUCCESS (1.717s) [123.724228] Subtest psr-cursor-plane-onoff: SUCCESS (1.718s) [124.611090] [024/131] (898s left) dmabuf_sync_file (export-wait-after-attach) [124.653415] Starting subtest: export-wait-after-attach [124.655584] Subtest export-wait-after-attach: SUCCESS (0.001s) [124.731924] [025/131] (898s left) kms_pm_rpm (modeset-lpsp-stress) [126.271203] Starting subtest: modeset-lpsp-stress [142.338685] Subtest modeset-lpsp-stress: SUCCESS (16.068s) [142.448988] [026/131] (881s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [142.571755] Starting subtest: plane-upscale-20x20-with-rotation [142.574070] Starting dynamic subtest: pipe-A [142.796534] Dynamic subtest pipe-A: SUCCESS (0.226s) [142.806103] Starting dynamic subtest: pipe-B [144.071866] Dynamic subtest pipe-B: SUCCESS (1.275s) [144.080668] Starting dynamic subtest: pipe-C [145.401805] Dynamic subtest pipe-C: SUCCESS (1.329s) [145.414967] Starting dynamic subtest: pipe-D [146.718250] Dynamic subtest pipe-D: SUCCESS (1.315s) [146.720568] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.149s) [147.915904] [027/131] (875s left) prime_vgem (basic-fence-flip) [147.997060] Starting subtest: basic-fence-flip [148.285718] Subtest basic-fence-flip: SUCCESS (0.289s) [148.425960] [028/131] (875s left) gem_mmap_gtt (big-copy-xy) [148.487706] Subtest big-copy-XY: SKIP (0.000s) [148.555635] [029/131] (875s left) kms_cursor_crc (cursor-onscreen-512x512) [148.816725] Starting subtest: cursor-onscreen-512x512 [148.821288] Subtest cursor-onscreen-512x512: SKIP (0.001s) [148.980543] [030/131] (874s left) i915_pm_sseu (full-enable) [149.036970] Subtest full-enable: SKIP (0.000s) [149.152303] [031/131] (874s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [149.264163] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [149.266374] Starting dynamic subtest: pipe-A-eDP-1 [149.289266] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [149.298490] Starting dynamic subtest: pipe-B-eDP-1 [149.316967] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [149.323894] Starting dynamic subtest: pipe-C-eDP-1 [149.342644] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [149.349314] Starting dynamic subtest: pipe-D-eDP-1 [149.369228] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [149.372802] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [151.580629] [032/131] (872s left) kms_dp_link_training (non-uhbr-sst) [151.680502] Starting subtest: non-uhbr-sst [151.689585] Subtest non-uhbr-sst: SKIP (0.000s) [151.776677] [033/131] (872s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [151.875348] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [151.877659] Starting dynamic subtest: pipe-A-eDP-1 [151.903042] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [151.911696] Starting dynamic subtest: pipe-B-eDP-1 [151.935303] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [151.942553] Starting dynamic subtest: pipe-C-eDP-1 [151.965564] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [151.972776] Starting dynamic subtest: pipe-D-eDP-1 [151.996632] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [152.001031] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s) [154.062273] [034/131] (869s left) gem_pxp (regular-baseline-src-copy-readible) [154.199153] Starting subtest: regular-baseline-src-copy-readible [154.255896] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s) [154.421895] [035/131] (869s left) gem_exec_flush (basic-wb-rw-default) [154.487633] Starting subtest: basic-wb-rw-default [159.938202] Subtest basic-wb-rw-default: SUCCESS (5.450s) [160.155354] [036/131] (863s left) syncobj_timeline (signal-array) [160.213413] Starting subtest: signal-array [160.215816] Subtest signal-array: SUCCESS (0.000s) [160.350974] [037/131] (863s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [160.452115] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [161.462877] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.013s) [161.642296] [038/131] (862s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [161.738809] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [161.742570] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [161.864601] [039/131] (862s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [161.933354] Subtest writes-after-reads-uncached: SKIP (0.000s) [162.016821] [040/131] (862s left) gem_flink_basic (bad-open) [162.063123] Starting subtest: bad-open [162.064728] Subtest bad-open: SUCCESS (0.000s) [162.196815] [041/131] (861s left) gem_ctx_shared (q-promotion) [162.262890] Starting subtest: Q-promotion [162.264920] Starting dynamic subtest: rcs0 [162.360814] Dynamic subtest rcs0: SUCCESS (0.096s) [162.376739] Starting dynamic subtest: vcs0 [162.442012] Dynamic subtest vcs0: SUCCESS (0.081s) [162.455732] Starting dynamic subtest: vcs1 [162.524846] Dynamic subtest vcs1: SUCCESS (0.082s) [162.540337] Starting dynamic subtest: vecs0 [162.593593] Dynamic subtest vecs0: SUCCESS (0.069s) [162.608823] Starting dynamic subtest: ccs0 [162.670870] Dynamic subtest ccs0: SUCCESS (0.076s) [162.673077] Subtest Q-promotion: SUCCESS (0.408s) [164.047864] [042/131] (860s left) kms_cursor_legacy (forked-bo) [164.172051] Starting subtest: forked-bo [164.173868] Starting dynamic subtest: pipe-A [169.629091] Dynamic subtest pipe-A: SUCCESS (5.455s) [169.640710] Starting dynamic subtest: pipe-B [175.103031] Dynamic subtest pipe-B: SUCCESS (5.471s) [175.113723] Starting dynamic subtest: pipe-C [180.565059] Dynamic subtest pipe-C: SUCCESS (5.461s) [180.576256] Starting dynamic subtest: pipe-D [186.034874] Dynamic subtest pipe-D: SUCCESS (5.468s) [186.045574] Starting dynamic subtest: all-pipes [191.528551] Dynamic subtest all-pipes: SUCCESS (5.491s) [191.531713] Subtest forked-bo: SUCCESS (27.354s) [191.690059] [043/131] (832s left) gem_readwrite (new-obj) [191.763291] Subtest new-obj: SKIP (0.000s) [191.834165] [044/131] (832s left) kms_busy (extended-modeset-hang-newfb) [191.948247] Starting subtest: extended-modeset-hang-newfb [191.950211] Starting dynamic subtest: pipe-A [226.863544] Dynamic subtest pipe-A: SUCCESS (34.913s) [226.873786] Starting dynamic subtest: pipe-D [249.818381] Dynamic subtest pipe-D: SUCCESS (22.953s) [249.820924] Subtest extended-modeset-hang-newfb: SUCCESS (57.870s) [250.640570] [045/131] (773s left) kms_color (ctm-0-50) [250.740012] Starting subtest: ctm-0-50 [250.742358] Starting dynamic subtest: pipe-A-eDP-1 [254.171202] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s) [254.180592] Starting dynamic subtest: pipe-B-eDP-1 [258.429419] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.257s) [258.438552] Starting dynamic subtest: pipe-C-eDP-1 [262.475433] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.046s) [262.484123] Starting dynamic subtest: pipe-D-eDP-1 [266.476270] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.992s) [266.481235] Subtest ctm-0-50: SUCCESS (15.729s) [267.312405] [046/131] (757s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [267.417381] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [267.419636] Starting dynamic subtest: pipe-A-eDP-1 [269.443434] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.024s) [269.451509] Starting dynamic subtest: pipe-B-eDP-1 [271.560142] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.115s) [271.569825] Starting dynamic subtest: pipe-C-eDP-1 [273.630998] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.071s) [273.639472] Starting dynamic subtest: pipe-D-eDP-1 [275.663408] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.031s) [275.665866] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.246s) [276.847966] [047/131] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [276.951547] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [276.955688] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [277.075637] [048/131] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [277.176164] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [277.181337] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [277.312806] [049/131] (747s left) i915_drm_fdinfo (busy) [277.348817] Starting subtest: busy [277.350811] Starting dynamic subtest: rcs0 [277.395564] Dynamic subtest rcs0: SKIP (0.045s) [277.405952] Starting dynamic subtest: bcs0 [277.409820] Dynamic subtest bcs0: SKIP (0.000s) [277.417516] Starting dynamic subtest: vcs0 [277.421650] Dynamic subtest vcs0: SKIP (0.000s) [277.429404] Starting dynamic subtest: vcs1 [277.433255] Dynamic subtest vcs1: SKIP (0.000s) [277.440500] Starting dynamic subtest: vecs0 [277.444390] Dynamic subtest vecs0: SKIP (0.000s) [277.451714] Starting dynamic subtest: ccs0 [277.455612] Dynamic subtest ccs0: SKIP (0.000s) [277.459545] Subtest busy: SKIP (0.052s) [277.493999] [050/131] (746s left) kms_addfb_basic (bad-pitch-32) [277.547526] Starting subtest: bad-pitch-32 [277.549835] Subtest bad-pitch-32: SUCCESS (0.000s) [277.717940] [051/131] (746s left) sysfs_heartbeat_interval (invalid) [277.782432] Starting subtest: invalid [277.784427] Starting dynamic subtest: vecs0 [277.786265] Dynamic subtest vecs0: SUCCESS (0.000s) [277.794222] Starting dynamic subtest: ccs0 [277.796023] Dynamic subtest ccs0: SUCCESS (0.000s) [277.803520] Starting dynamic subtest: vcs0 [277.805359] Dynamic subtest vcs0: SUCCESS (0.000s) [277.812547] Starting dynamic subtest: bcs0 [277.814354] Dynamic subtest bcs0: SUCCESS (0.000s) [277.821552] Starting dynamic subtest: rcs0 [277.823381] Dynamic subtest rcs0: SUCCESS (0.000s) [277.830493] Starting dynamic subtest: vcs1 [277.832297] Dynamic subtest vcs1: SUCCESS (0.000s) [277.834131] Subtest invalid: SUCCESS (0.005s) [277.914392] [052/131] (746s left) kms_atomic (test-only) [278.010375] Starting subtest: test-only [278.059612] Starting dynamic subtest: pipe-A-eDP-1 [280.572063] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.511s) [280.573930] Subtest test-only: SUCCESS (2.561s) [281.452555] [053/131] (743s left) kms_sequence (get-busy) [281.554536] Starting subtest: get-busy [281.556893] Starting dynamic subtest: pipe-A-eDP-1 [283.491227] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s) [283.500310] Starting dynamic subtest: pipe-B-eDP-1 [286.113387] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.621s) [286.122978] Starting dynamic subtest: pipe-C-eDP-1 [288.750324] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.634s) [288.759934] Starting dynamic subtest: pipe-D-eDP-1 [291.368314] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.618s) [291.370661] Subtest get-busy: SUCCESS (9.816s) [292.189433] [054/131] (732s left) kms_invalid_mode (zero-hdisplay) [292.299392] Starting subtest: zero-hdisplay [292.301692] Starting dynamic subtest: pipe-A-eDP-1 [292.582829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [292.596455] Starting dynamic subtest: pipe-B-eDP-1 [292.598455] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [292.606439] Starting dynamic subtest: pipe-C-eDP-1 [292.608709] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [292.616334] Starting dynamic subtest: pipe-D-eDP-1 [292.618565] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [292.620693] Subtest zero-hdisplay: SUCCESS (0.291s) [293.420094] [055/131] (731s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [293.522817] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [297.217236] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.698s) [298.429633] [056/131] (726s left) gem_softpin (allocator-evict) [298.492811] Starting subtest: allocator-evict [298.495179] Starting dynamic subtest: rcs0 [321.536195] Dynamic subtest rcs0: SUCCESS (23.041s) [321.551846] Starting dynamic subtest: bcs0 [345.181038] Dynamic subtest bcs0: SUCCESS (23.642s) [345.192824] Starting dynamic subtest: vcs0 [368.630100] Dynamic subtest vcs0: SUCCESS (23.446s) [368.640802] Starting dynamic subtest: vcs1 [392.198723] Dynamic subtest vcs1: SUCCESS (23.566s) [392.210644] Starting dynamic subtest: vecs0 [416.001521] Dynamic subtest vecs0: SUCCESS (23.801s) [416.012775] Starting dynamic subtest: ccs0 [439.771985] Dynamic subtest ccs0: SUCCESS (23.767s) [439.774576] Subtest allocator-evict: SUCCESS (141.274s) [439.876488] [057/131] (584s left) kms_cursor_crc (cursor-offscreen-256x85) [440.169905] Starting subtest: cursor-offscreen-256x85 [440.211984] Subtest cursor-offscreen-256x85: SKIP (0.040s) [440.416205] [058/131] (584s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [440.515061] Starting subtest: fbcpsr-rgb101010-draw-blt [447.231711] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.719s) [447.389878] [059/131] (577s left) kms_color (deep-color) [447.487960] Starting subtest: deep-color [448.572298] Starting dynamic subtest: pipe-A-eDP-1-gamma [449.277086] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.702s) [449.286095] Starting dynamic subtest: pipe-A-eDP-1-degamma [450.769656] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.492s) [450.779063] Starting dynamic subtest: pipe-A-eDP-1-ctm [452.205909] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.438s) [452.974944] Starting dynamic subtest: pipe-B-eDP-1-gamma [453.685048] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.715s) [453.694760] Starting dynamic subtest: pipe-B-eDP-1-degamma [455.125346] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.439s) [455.134264] Starting dynamic subtest: pipe-B-eDP-1-ctm [456.614878] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.488s) [457.362563] Starting dynamic subtest: pipe-C-eDP-1-gamma [458.037301] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.681s) [458.047055] Starting dynamic subtest: pipe-C-eDP-1-degamma [459.423098] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.382s) [459.432734] Starting dynamic subtest: pipe-C-eDP-1-ctm [460.819413] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.392s) [461.564246] Starting dynamic subtest: pipe-D-eDP-1-gamma [462.237170] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.678s) [462.246116] Starting dynamic subtest: pipe-D-eDP-1-degamma [463.627032] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.391s) [463.636483] Starting dynamic subtest: pipe-D-eDP-1-ctm [465.040711] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.413s) [465.043100] Subtest deep-color: SUCCESS (17.555s) [465.938382] [060/131] (558s left) gem_exec_create (forked) [466.010333] Starting subtest: forked [466.012645] Starting dynamic subtest: smem [487.894426] Dynamic subtest smem: SUCCESS (21.881s) [487.897352] Subtest forked: SUCCESS (21.883s) [488.107323] [061/131] (536s left) gem_exec_schedule (pi-common) [488.302178] Starting subtest: pi-common [488.304456] Starting dynamic subtest: rcs0 [488.338640] Dynamic subtest rcs0: SUCCESS (0.039s) [488.348419] Starting dynamic subtest: bcs0 [488.380517] Dynamic subtest bcs0: SUCCESS (0.040s) [488.389065] Starting dynamic subtest: vcs0 [488.421062] Dynamic subtest vcs0: SUCCESS (0.039s) [488.429803] Starting dynamic subtest: vcs1 [488.455085] Dynamic subtest vcs1: SUCCESS (0.033s) [488.463550] Starting dynamic subtest: vecs0 [488.491371] Dynamic subtest vecs0: SUCCESS (0.035s) [488.499994] Starting dynamic subtest: ccs0 [488.523846] Dynamic subtest ccs0: SUCCESS (0.032s) [488.526219] Subtest pi-common: SUCCESS (0.226s) [488.783681] [062/131] (536s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [488.845944] Starting subtest: invalid-multi-wait-unsubmitted-submitted [488.848424] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [488.986866] [063/131] (536s left) syncobj_timeline (single-wait-signaled) [489.044017] Starting subtest: single-wait-signaled [489.046284] Subtest single-wait-signaled: SUCCESS (0.000s) [489.184583] [064/131] (535s left) gem_ctx_persistence (saturated-hostile) [489.248440] Starting subtest: saturated-hostile [489.250753] Starting dynamic subtest: rcs0 [490.053880] Dynamic subtest rcs0: SUCCESS (0.805s) [490.063446] Starting dynamic subtest: bcs0 [490.878975] Dynamic subtest bcs0: SUCCESS (0.824s) [490.887952] Starting dynamic subtest: vcs0 [491.697218] Dynamic subtest vcs0: SUCCESS (0.816s) [491.706867] Starting dynamic subtest: vcs1 [492.512632] Dynamic subtest vcs1: SUCCESS (0.813s) [492.523370] Starting dynamic subtest: vecs0 [493.316860] Dynamic subtest vecs0: SUCCESS (0.802s) [493.328363] Starting dynamic subtest: ccs0 [494.184884] Dynamic subtest ccs0: SUCCESS (0.865s) [494.187671] Subtest saturated-hostile: SUCCESS (4.937s) [494.351483] [065/131] (530s left) gem_close_race (multigpu-basic-threads) [494.423490] Starting subtest: multigpu-basic-threads [494.427625] Subtest multigpu-basic-threads: SKIP (0.000s) [494.698065] [066/131] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [494.795378] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [494.799908] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [494.924790] [067/131] (530s left) kms_pm_rpm (i2c) [497.083459] Starting subtest: i2c [502.356339] Subtest i2c: SUCCESS (5.274s) [502.500361] [068/131] (522s left) kms_psr (fbc-pr-sprite-plane-move) [502.599473] Starting subtest: fbc-pr-sprite-plane-move [502.603893] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [502.694388] [069/131] (522s left) gem_mmap_offset (bad-extensions) [502.750844] Starting subtest: bad-extensions [502.752764] Subtest bad-extensions: SUCCESS (0.000s) [502.890894] [070/131] (522s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [503.004275] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [503.008501] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [503.141107] [071/131] (522s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [503.241578] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [503.245742] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [503.371819] [072/131] (521s left) perf_pmu (most-busy-idle-check-all) [503.416358] Starting subtest: most-busy-idle-check-all [503.417951] Starting dynamic subtest: rcs0 [504.917572] Dynamic subtest rcs0: SUCCESS (1.501s) [504.929648] Starting dynamic subtest: bcs0 [506.903950] Dynamic subtest bcs0: SUCCESS (1.984s) [506.913993] Starting dynamic subtest: vcs0 [508.885175] Dynamic subtest vcs0: SUCCESS (1.979s) [508.897637] Starting dynamic subtest: vcs1 [510.933106] Dynamic subtest vcs1: SUCCESS (2.045s) [510.945547] Starting dynamic subtest: vecs0 [512.917277] Dynamic subtest vecs0: SUCCESS (1.981s) [512.928966] Starting dynamic subtest: ccs0 [514.901641] Dynamic subtest ccs0: SUCCESS (1.981s) [514.904594] Subtest most-busy-idle-check-all: SUCCESS (11.486s) [515.052280] [073/131] (510s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [515.458780] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [516.253120] [074/131] (509s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [516.361484] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [516.365577] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [516.493325] [075/131] (508s left) gem_ctx_persistence (engines-cleanup) [516.556538] Starting subtest: engines-cleanup [516.558745] Starting dynamic subtest: rcs0 [516.613218] Dynamic subtest rcs0: SUCCESS (0.057s) [516.623013] Starting dynamic subtest: bcs0 [516.676615] Dynamic subtest bcs0: SUCCESS (0.062s) [516.684899] Starting dynamic subtest: vcs0 [516.756240] Dynamic subtest vcs0: SUCCESS (0.079s) [516.766604] Starting dynamic subtest: vcs1 [516.824884] Dynamic subtest vcs1: SUCCESS (0.066s) [516.835659] Starting dynamic subtest: vecs0 [516.890913] Dynamic subtest vecs0: SUCCESS (0.064s) [516.901886] Starting dynamic subtest: ccs0 [516.956885] Dynamic subtest ccs0: SUCCESS (0.064s) [516.959592] Subtest engines-cleanup: SUCCESS (0.401s) [517.057798] [076/131] (508s left) prime_mmap (test_map_unmap) [517.125813] Starting subtest: test_map_unmap [517.127814] Starting dynamic subtest: test_map_unmap-smem [517.170408] Dynamic subtest test_map_unmap-smem: SUCCESS (0.046s) [517.173079] Subtest test_map_unmap: SUCCESS (0.047s) [517.308056] [077/131] (508s left) gem_userptr_blits (set-cache-level) [517.363532] Starting subtest: set-cache-level [517.367259] Subtest set-cache-level: SKIP (0.000s) [517.534583] [078/131] (508s left) gem_busy (busy) [517.604054] Starting subtest: busy [517.606101] Starting dynamic subtest: all-engines [517.673245] Dynamic subtest all-engines: SUCCESS (0.069s) [517.685476] Starting dynamic subtest: rcs0 [518.874491] Dynamic subtest rcs0: SUCCESS (1.198s) [518.885554] Starting dynamic subtest: bcs0 [518.916963] Dynamic subtest bcs0: SUCCESS (0.041s) [518.925970] Starting dynamic subtest: vcs0 [518.958295] Dynamic subtest vcs0: SUCCESS (0.039s) [518.967385] Starting dynamic subtest: vcs1 [520.921924] Dynamic subtest vcs1: SUCCESS (1.961s) [520.932734] Starting dynamic subtest: vecs0 [522.907517] Dynamic subtest vecs0: SUCCESS (1.983s) [522.917780] Starting dynamic subtest: ccs0 [524.890194] Dynamic subtest ccs0: SUCCESS (1.982s) [524.892377] Subtest busy: SUCCESS (7.284s) [525.285617] [079/131] (500s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [525.389379] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [532.594467] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.207s) [532.764286] [080/131] (492s left) core_auth (basic-auth) [532.831426] Starting subtest: basic-auth [532.833732] Subtest basic-auth: SUCCESS (0.001s) [532.973139] [081/131] (492s left) prime_mmap_coherency (write) [533.038676] Starting subtest: write [538.413713] Subtest write: SUCCESS (5.373s) [538.605471] [082/131] (487s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [538.681464] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [538.686064] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [538.889925] [083/131] (486s left) perf (gen12-invalid-class-instance) [539.049019] Starting subtest: gen12-invalid-class-instance [539.058834] Subtest gen12-invalid-class-instance: SUCCESS (0.009s) [539.102505] [084/131] (486s left) kms_lease (lease-get) [539.202925] Starting subtest: lease-get [539.205213] Starting dynamic subtest: pipe-A-eDP-1 [539.207454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [539.221654] Starting dynamic subtest: pipe-B-eDP-1 [539.223851] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [539.234322] Starting dynamic subtest: pipe-C-eDP-1 [539.236431] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [539.244435] Starting dynamic subtest: pipe-D-eDP-1 [539.246535] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [539.248937] Subtest lease-get: SUCCESS (0.012s) [539.343457] [085/131] (486s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [539.457531] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [539.460948] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [539.591479] [086/131] (486s left) i915_pm_rpm (system-suspend-devices) [541.109908] Starting subtest: system-suspend-devices [552.575831] Subtest system-suspend-devices: SUCCESS (11.467s) [552.961843] [087/131] (472s left) kms_cursor_edge_walk (128x128-right-edge) [553.078327] Starting subtest: 128x128-right-edge [553.080593] Starting dynamic subtest: pipe-A-eDP-1 [556.490324] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.413s) [556.500528] Starting dynamic subtest: pipe-D-eDP-1 [559.621256] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s) [559.623568] Subtest 128x128-right-edge: SUCCESS (6.545s) [560.444414] [088/131] (465s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [565.394263] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [565.396568] Starting dynamic subtest: pipe-A-eDP-1 [566.183793] Dynamic subtest pipe-A-eDP-1: SKIP (0.787s) [566.194102] Starting dynamic subtest: pipe-B-eDP-1 [567.312569] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s) [567.317324] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.918s) [568.519427] [089/131] (457s left) perf (i915-ref-count) [568.622527] Starting subtest: i915-ref-count [568.648466] Subtest i915-ref-count: SUCCESS (0.024s) [568.704483] [090/131] (457s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [568.800695] Starting subtest: fbc-2p-primscrn-spr-indfb-move [568.805155] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [568.950318] [091/131] (457s left) core_auth (getclient-simple) [568.991850] Starting subtest: getclient-simple [569.017765] Subtest getclient-simple: SUCCESS (0.027s) [569.159903] [092/131] (456s left) i915_pciid [569.325158] [093/131] (456s left) gem_exec_fence (syncobj-timeline-signal) [569.904078] Starting subtest: syncobj-timeline-signal [569.911125] Subtest syncobj-timeline-signal: SUCCESS (0.007s) [571.027919] [094/131] (455s left) kms_flip (bo-too-big) [571.132053] Starting subtest: bo-too-big [571.133863] Starting dynamic subtest: A-eDP1 [572.449774] Dynamic subtest A-eDP1: SUCCESS (1.318s) [572.461851] Starting dynamic subtest: B-eDP1 [573.784209] Dynamic subtest B-eDP1: SUCCESS (1.334s) [573.794581] Starting dynamic subtest: C-eDP1 [575.112437] Dynamic subtest C-eDP1: SUCCESS (1.327s) [575.123295] Starting dynamic subtest: D-eDP1 [576.444760] Dynamic subtest D-eDP1: SUCCESS (1.331s) [576.447188] Subtest bo-too-big: SUCCESS (5.318s) [577.687091] [095/131] (448s left) kms_psr (pr-basic) [577.785998] Starting subtest: pr-basic [577.790428] Subtest pr-basic: SKIP (0.000s) [577.886239] [096/131] (448s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [577.996908] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [578.001093] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [578.137250] [097/131] (448s left) kms_addfb_basic (tile-pitch-mismatch) [578.197615] Starting subtest: tile-pitch-mismatch [578.201731] Subtest tile-pitch-mismatch: SKIP (0.000s) [578.371626] [098/131] (448s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [578.475091] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [578.477296] Starting dynamic subtest: pipe-A-eDP-1 [578.485859] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [578.500989] Starting dynamic subtest: pipe-B-eDP-1 [578.509481] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [578.520237] Starting dynamic subtest: pipe-C-eDP-1 [578.528240] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [578.536435] Starting dynamic subtest: pipe-D-eDP-1 [578.544525] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [578.548398] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s) [580.741404] [099/131] (445s left) gem_exec_reloc (basic-write-cpu-active) [580.811087] Subtest basic-write-cpu-active: SKIP (0.000s) [580.894648] [100/131] (445s left) gem_exec_whisper (basic-queues-forked-all) [580.968984] Starting subtest: basic-queues-forked-all [599.137958] Subtest basic-queues-forked-all: SUCCESS (18.166s) [599.342613] [101/131] (427s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [599.444067] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [599.446352] Starting dynamic subtest: pipe-A-default-mode [600.578973] Dynamic subtest pipe-A-default-mode: SKIP (1.133s) [600.583320] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.135s) [600.761883] [102/131] (425s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [600.856040] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [600.858186] Starting dynamic subtest: pipe-A-default-mode [601.143536] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [601.148200] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.286s) [602.004811] [103/131] (424s left) prime_mmap (test_dup) [602.055980] Starting subtest: test_dup [602.057819] Starting dynamic subtest: test_dup-smem [602.088104] Dynamic subtest test_dup-smem: SUCCESS (0.034s) [602.090460] Subtest test_dup: SUCCESS (0.035s) [602.186888] [104/131] (424s left) kms_addfb_basic (legacy-format) [602.235757] Starting subtest: legacy-format [602.261166] Subtest legacy-format: SUCCESS (0.024s) [602.428849] [105/131] (424s left) gem_workarounds (suspend-resume-context) [602.500885] Starting subtest: suspend-resume-context [618.842562] Subtest suspend-resume-context: SUCCESS (1.234s) [619.024606] [106/131] (407s left) gem_fence_thrash (bo-write-verify-none) [619.076213] Starting subtest: bo-write-verify-none [619.105714] Subtest bo-write-verify-none: SKIP (0.028s) [619.181425] [107/131] (407s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [624.278595] Starting subtest: psr2-cursor-plane-move-continuous-sf [624.280983] Starting dynamic subtest: pipe-A-eDP-1 [635.355616] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.069s) [635.365521] Starting dynamic subtest: pipe-B-eDP-1 [646.396950] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.035s) [646.399221] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.108s) [647.220977] [108/131] (379s left) kms_rotation_crc (primary-rotation-270) [647.337467] Starting subtest: primary-rotation-270 [647.341701] Subtest primary-rotation-270: SKIP (0.001s) [647.440533] [109/131] (379s left) syncobj_wait (invalid-reset-illegal-handle) [647.515748] Starting subtest: invalid-reset-illegal-handle [647.517983] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [647.631285] [110/131] (379s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [647.702320] Starting subtest: y-tiled-ccs-to-y-tiled [647.706152] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [647.905472] [111/131] (379s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [647.993609] Starting subtest: primary-y-tiled-reflect-x-270 [647.997879] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [648.090898] [112/131] (378s left) gen9_exec_parse (bb-large) [648.162236] Subtest bb-large: SKIP (0.000s) [648.248373] [113/131] (378s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [648.303907] Starting subtest: multi-wait-all-for-submit-signaled [648.306064] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [648.438695] [114/131] (378s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [648.539600] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [648.541870] Starting dynamic subtest: pipe-A [648.662831] Dynamic subtest pipe-A: SKIP (0.118s) [648.678642] Starting dynamic subtest: pipe-B [649.879620] Dynamic subtest pipe-B: SKIP (1.217s) [649.889521] Starting dynamic subtest: pipe-C [651.099242] Dynamic subtest pipe-C: SUCCESS (1.224s) [651.109598] Starting dynamic subtest: pipe-D [652.321280] Dynamic subtest pipe-D: SUCCESS (1.221s) [652.323876] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.784s) [653.537006] [115/131] (373s left) kms_psr (psr2-cursor-render) [653.644521] Starting subtest: psr2-cursor-render [653.646684] Starting dynamic subtest: eDP-1 [655.378903] Dynamic subtest eDP-1: SUCCESS (1.734s) [655.381118] Subtest psr2-cursor-render: SUCCESS (1.735s) [656.288434] [116/131] (370s left) gem_userptr_blits (invalid-null-pointer) [656.364968] Starting subtest: invalid-null-pointer [656.366943] Subtest invalid-null-pointer: SUCCESS (0.001s) [656.547104] [117/131] (370s left) api_intel_allocator (simple-allocator) [656.601886] Starting subtest: simple-allocator [656.604269] Starting dynamic subtest: basic [656.606581] Dynamic subtest basic: SUCCESS (0.003s) [656.621678] Starting dynamic subtest: parallel-one [656.780533] Dynamic subtest parallel-one: SUCCESS (0.176s) [656.791360] Starting dynamic subtest: print [656.793299] Dynamic subtest print: SUCCESS (0.000s) [656.802534] Starting dynamic subtest: reuse [656.804707] Dynamic subtest reuse: SUCCESS (0.000s) [656.813519] Starting dynamic subtest: reserve [656.815575] Dynamic subtest reserve: SUCCESS (0.000s) [656.824693] Starting dynamic subtest: fork-reopen-allocator [656.826866] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s) [656.829021] Subtest simple-allocator: SUCCESS (0.198s) [656.967242] [118/131] (370s left) kms_pipe_stress (stress-xrgb8888-yftiled) [657.071288] Starting subtest: stress-xrgb8888-yftiled [657.075563] Subtest stress-xrgb8888-yftiled: SKIP (0.000s) [657.159866] [119/131] (370s left) kms_flip (wf_vblank-ts-check) [657.259565] Starting subtest: wf_vblank-ts-check [657.261808] Starting dynamic subtest: A-eDP1 [666.207644] Dynamic subtest A-eDP1: SUCCESS (8.949s) [666.220487] Starting dynamic subtest: B-eDP1 [675.143420] Dynamic subtest B-eDP1: SUCCESS (8.934s) [675.154225] Starting dynamic subtest: C-eDP1 [684.067354] Dynamic subtest C-eDP1: SUCCESS (8.922s) [684.078267] Starting dynamic subtest: D-eDP1 [692.998374] Dynamic subtest D-eDP1: SUCCESS (8.926s) [693.000769] Subtest wf_vblank-ts-check: SUCCESS (35.740s) [694.253283] [120/131] (333s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [694.351577] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [694.353751] Starting dynamic subtest: pipe-A-eDP-1 [694.376595] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [694.388544] Starting dynamic subtest: pipe-B-eDP-1 [694.409589] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [694.418520] Starting dynamic subtest: pipe-C-eDP-1 [694.438766] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [694.447534] Starting dynamic subtest: pipe-D-eDP-1 [694.469556] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [694.473842] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [696.609212] [121/131] (330s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [696.665998] Starting subtest: invalid-multi-wait-unsubmitted [696.668368] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [696.804210] [122/131] (330s left) prime_mmap (test_errors) [696.869086] Starting subtest: test_errors [696.871037] Starting dynamic subtest: test_errors-smem [696.961280] Dynamic subtest test_errors-smem: SUCCESS (0.093s) [696.964041] Subtest test_errors: SUCCESS (0.095s) [697.091496] [123/131] (330s left) gem_exec_async (forked-writes) [697.155061] Starting subtest: forked-writes [697.157312] Starting dynamic subtest: rcs0 [697.180750] Dynamic subtest rcs0: SUCCESS (0.025s) [697.191118] Starting dynamic subtest: bcs0 [697.205373] Dynamic subtest bcs0: SUCCESS (0.023s) [697.215215] Starting dynamic subtest: vcs0 [697.228938] Dynamic subtest vcs0: SUCCESS (0.023s) [697.238676] Starting dynamic subtest: vcs1 [697.252541] Dynamic subtest vcs1: SUCCESS (0.022s) [697.264607] Starting dynamic subtest: vecs0 [697.273850] Dynamic subtest vecs0: SUCCESS (0.020s) [697.283741] Starting dynamic subtest: ccs0 [697.295410] Dynamic subtest ccs0: SUCCESS (0.021s) [697.297691] Subtest forked-writes: SUCCESS (0.141s) [697.569910] [124/131] (329s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [697.659335] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [702.183237] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.527s) [703.418261] [125/131] (324s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [703.532567] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [703.534909] Starting dynamic subtest: pipe-A-default-mode [703.851314] Dynamic subtest pipe-A-default-mode: SKIP (0.317s) [703.855749] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.319s) [704.647130] [126/131] (322s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [704.752537] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [714.206530] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.455s) [714.379940] [127/131] (313s left) gem_mmap_gtt (cpuset-basic-small-copy) [714.450120] Subtest cpuset-basic-small-copy: SKIP (0.000s) [714.514311] [128/131] (313s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [719.514082] Starting subtest: psr2-primary-plane-update-sf-dmg-area [719.516337] Starting dynamic subtest: pipe-A-eDP-1 [726.126595] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.612s) [726.135978] Starting dynamic subtest: pipe-B-eDP-1 [732.713488] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.587s) [732.716151] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.203s) [733.619419] [129/131] (294s left) sriov_basic (enable-vfs-bind-unbind-each) [733.682140] Starting subtest: enable-vfs-bind-unbind-each [733.684166] Starting dynamic subtest: numvfs-1 [733.765093] Dynamic subtest numvfs-1: FAIL (0.029s) [733.776533] Starting dynamic subtest: numvfs-2 [733.849771] Dynamic subtest numvfs-2: FAIL (0.003s) [733.860593] Starting dynamic subtest: numvfs-3 [733.933505] Dynamic subtest numvfs-3: FAIL (0.003s) [733.944262] Starting dynamic subtest: numvfs-4 [734.017030] Dynamic subtest numvfs-4: FAIL (0.003s) [734.026620] Starting dynamic subtest: numvfs-5 [734.100233] Dynamic subtest numvfs-5: FAIL (0.003s) [734.111039] Starting dynamic subtest: numvfs-6 [734.184901] Dynamic subtest numvfs-6: FAIL (0.004s) [734.195870] Starting dynamic subtest: numvfs-7 [734.268081] Dynamic subtest numvfs-7: FAIL (0.003s) [734.279096] Starting dynamic subtest: numvfs-random [734.351375] Dynamic subtest numvfs-random: FAIL (0.003s) [734.353475] Subtest enable-vfs-bind-unbind-each: FAIL (0.058s) [734.393843] [130/131] (293s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [734.504136] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [741.300191] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.799s) [741.464736] [131/131] (286s left) gem_exec_schedule (u-fairslice) [741.546512] Starting subtest: u-fairslice [741.548770] Starting dynamic subtest: rcs0 [743.557506] Dynamic subtest rcs0: SUCCESS (2.019s) [743.567226] Starting dynamic subtest: bcs0 [745.576988] Dynamic subtest bcs0: SUCCESS (2.017s) [745.586620] Starting dynamic subtest: vcs0 [747.593312] Dynamic subtest vcs0: SUCCESS (2.016s) [747.615619] Starting dynamic subtest: vcs1 [749.611399] Dynamic subtest vcs1: SUCCESS (2.018s) [749.620576] Starting dynamic subtest: vecs0 [751.631988] Dynamic subtest vecs0: SUCCESS (2.019s) [751.641968] Starting dynamic subtest: ccs0 [753.651987] Dynamic subtest ccs0: SUCCESS (2.019s) [753.653896] Subtest u-fairslice: SUCCESS (12.112s) [753.971021] 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.