[59.056890] Initializing watchdogs [59.056940] /dev/watchdog0 [59.071152] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.075386] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.077379] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.079244] [001/131] (960s left) kms_addfb_basic (bad-pitch-0) [59.136915] Starting subtest: bad-pitch-0 [59.137992] Subtest bad-pitch-0: SUCCESS (0.000s) [59.306374] [002/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [59.396481] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [59.398175] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [59.511974] [003/131] (960s left) kms_big_fb (x-tiled-64bpp-rotate-90) [59.613166] Starting subtest: x-tiled-64bpp-rotate-90 [59.645402] Subtest x-tiled-64bpp-rotate-90: SKIP (0.032s) [59.792570] [004/131] (959s left) kms_vrr (negative-basic) [59.885499] Starting subtest: negative-basic [59.888311] Starting dynamic subtest: pipe-A-eDP-1 [65.313823] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s) [65.614184] Subtest negative-basic: SUCCESS (5.718s) [66.448664] [005/131] (953s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [66.511664] Starting subtest: etime-multi-wait-available-unsubmitted [66.619742] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.105s) [66.708512] [006/131] (953s left) gem_exec_fence (syncobj-channel) [67.293780] Starting subtest: syncobj-channel [68.321696] Subtest syncobj-channel: SUCCESS (1.024s) [68.961383] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true [68.963168] [007/131] (950s left) perf_pmu (interrupts-sync) [69.000465] Starting subtest: interrupts-sync [70.112405] Subtest interrupts-sync: SUCCESS (1.108s) [70.258228] [008/131] (949s left) kms_plane_multiple (2x-tiling-x) [70.360080] Starting subtest: 2x-tiling-x [70.361874] Subtest 2x-tiling-x: SKIP (0.000s) [70.451396] [009/131] (949s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [70.539775] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [71.176146] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.636s) [71.387954] [010/131] (948s left) kms_big_fb (linear-64bpp-rotate-270) [71.489476] Starting subtest: linear-64bpp-rotate-270 [71.508390] Subtest linear-64bpp-rotate-270: SKIP (0.019s) [71.666222] [011/131] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [71.756899] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [76.479870] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.722s) [77.866918] [012/131] (942s left) gem_exec_whisper (basic-contexts-forked) [77.932616] Starting subtest: basic-contexts-forked [101.453312] Subtest basic-contexts-forked: SUCCESS (23.511s) [101.651595] [013/131] (918s left) sw_sync (alloc_fence) [101.688389] Starting subtest: alloc_fence [101.689423] Subtest alloc_fence: SUCCESS (0.000s) [101.763815] [014/131] (918s left) i915_query (query-garbage) [101.825991] Starting subtest: query-garbage [101.827175] Subtest query-garbage: SUCCESS (0.000s) [101.948149] [015/131] (918s left) gem_exec_reloc (basic-cpu-gtt-active) [102.015218] Subtest basic-cpu-gtt-active: SKIP (0.000s) [102.091382] [016/131] (917s left) gem_exec_endless (dispatch) [102.155632] Starting subtest: dispatch [102.156921] Starting dynamic subtest: rcs0 [102.161414] Dynamic subtest rcs0: SUCCESS (0.005s) [102.174718] Starting dynamic subtest: bcs0 [102.176405] Dynamic subtest bcs0: SUCCESS (0.004s) [102.184587] Starting dynamic subtest: vcs0 [102.186505] Dynamic subtest vcs0: SUCCESS (0.004s) [102.195470] Starting dynamic subtest: vcs1 [102.197224] Dynamic subtest vcs1: SUCCESS (0.005s) [102.203218] Starting dynamic subtest: vecs0 [102.204866] Dynamic subtest vecs0: SUCCESS (0.005s) [102.212251] Starting dynamic subtest: ccs0 [102.214726] Dynamic subtest ccs0: SUCCESS (0.006s) [102.215593] Subtest dispatch: SUCCESS (0.031s) [103.957717] [017/131] (916s left) kms_selftest (drm_dp_mst_helper) [103.996093] Starting subtest: drm_dp_mst_helper [104.049146] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [104.155929] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.107s) [104.162298] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [104.302686] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.148s) [104.309107] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [104.448211] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.145s) [104.449116] Subtest drm_dp_mst_helper: SUCCESS (0.451s) [104.611269] [018/131] (915s left) kms_big_fb (y-tiled-64bpp-rotate-0) [104.724048] Starting subtest: y-tiled-64bpp-rotate-0 [104.725999] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [104.841468] [019/131] (915s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [104.933232] Starting subtest: fbc-rgb565-draw-mmap-cpu [108.956748] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.024s) [110.155369] [020/131] (910s left) gem_mmap_wc (bad-size) [110.215230] Subtest bad-size: SKIP (0.000s) [110.281791] [021/131] (909s left) gem_mmap_gtt (basic-read-write) [110.334802] Subtest basic-read-write: SKIP (0.000s) [110.402602] [022/131] (909s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [110.497668] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [117.501184] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.004s) [117.664381] [023/131] (902s left) kms_psr (psr-cursor-plane-onoff) [117.767464] Starting subtest: psr-cursor-plane-onoff [117.768424] Starting dynamic subtest: eDP-1 [119.532068] Dynamic subtest eDP-1: SUCCESS (1.765s) [119.532989] Subtest psr-cursor-plane-onoff: SUCCESS (1.766s) [120.416669] [024/131] (899s left) dmabuf_sync_file (export-wait-after-attach) [120.460997] Starting subtest: export-wait-after-attach [120.462057] Subtest export-wait-after-attach: SUCCESS (0.000s) [120.536405] [025/131] (899s left) kms_pm_rpm (modeset-lpsp-stress) [122.154481] Starting subtest: modeset-lpsp-stress [138.828664] Subtest modeset-lpsp-stress: SUCCESS (16.676s) [138.934281] [026/131] (881s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [139.028157] Starting subtest: plane-upscale-20x20-with-rotation [139.029056] Starting dynamic subtest: pipe-A [139.254150] Dynamic subtest pipe-A: SUCCESS (0.227s) [139.262790] Starting dynamic subtest: pipe-B [140.570069] Dynamic subtest pipe-B: SUCCESS (1.315s) [140.577347] Starting dynamic subtest: pipe-C [141.900185] Dynamic subtest pipe-C: SUCCESS (1.330s) [141.908294] Starting dynamic subtest: pipe-D [143.225655] Dynamic subtest pipe-D: SUCCESS (1.325s) [143.226611] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.199s) [144.424720] [027/131] (876s left) prime_vgem (basic-fence-flip) [144.504994] Starting subtest: basic-fence-flip [144.799846] Subtest basic-fence-flip: SUCCESS (0.295s) [144.920240] [028/131] (875s left) gem_mmap_gtt (big-copy-xy) [144.981337] Subtest big-copy-XY: SKIP (0.000s) [145.046470] [029/131] (875s left) kms_cursor_crc (cursor-onscreen-512x512) [145.309102] Starting subtest: cursor-onscreen-512x512 [145.310882] Subtest cursor-onscreen-512x512: SKIP (0.001s) [145.502891] [030/131] (875s left) i915_pm_sseu (full-enable) [145.571749] Subtest full-enable: SKIP (0.000s) [145.700203] [031/131] (874s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [145.790221] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [145.791084] Starting dynamic subtest: pipe-A-eDP-1 [145.800226] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [145.809070] Starting dynamic subtest: pipe-B-eDP-1 [145.820520] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [145.832959] Starting dynamic subtest: pipe-C-eDP-1 [145.842940] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [145.851036] Starting dynamic subtest: pipe-D-eDP-1 [145.860069] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [145.861684] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [148.008826] [032/131] (872s left) kms_dp_link_training (non-uhbr-sst) [148.107243] Starting subtest: non-uhbr-sst [148.110516] Subtest non-uhbr-sst: SKIP (0.000s) [148.197279] [033/131] (872s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [148.287554] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [148.288510] Starting dynamic subtest: pipe-A-eDP-1 [148.298106] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [148.309218] Starting dynamic subtest: pipe-B-eDP-1 [148.318674] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [148.330141] Starting dynamic subtest: pipe-C-eDP-1 [148.339505] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [148.345882] Starting dynamic subtest: pipe-D-eDP-1 [148.355067] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [148.356718] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s) [150.476727] [034/131] (870s left) gem_pxp (regular-baseline-src-copy-readible) [150.598336] Starting subtest: regular-baseline-src-copy-readible [150.658718] Subtest regular-baseline-src-copy-readible: SUCCESS (0.062s) [150.815366] [035/131] (869s left) gem_exec_flush (basic-wb-rw-default) [150.877481] Starting subtest: basic-wb-rw-default [156.344118] Subtest basic-wb-rw-default: SUCCESS (5.466s) [156.542011] [036/131] (864s left) syncobj_timeline (signal-array) [156.596404] Starting subtest: signal-array [156.597378] Subtest signal-array: SUCCESS (0.000s) [156.730529] [037/131] (864s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [156.831077] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [157.809696] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.979s) [157.926755] [038/131] (862s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [158.027402] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [158.029059] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [158.137789] [039/131] (862s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [158.194107] Subtest writes-after-reads-uncached: SKIP (0.000s) [158.275703] [040/131] (862s left) gem_flink_basic (bad-open) [158.327212] Starting subtest: bad-open [158.328129] Subtest bad-open: SUCCESS (0.000s) [158.443645] [041/131] (862s left) gem_ctx_shared (q-promotion) [158.513302] Starting subtest: Q-promotion [158.514370] Starting dynamic subtest: rcs0 [158.617054] Dynamic subtest rcs0: SUCCESS (0.103s) [158.631580] Starting dynamic subtest: vcs0 [158.700606] Dynamic subtest vcs0: SUCCESS (0.083s) [158.714848] Starting dynamic subtest: vcs1 [158.782495] Dynamic subtest vcs1: SUCCESS (0.081s) [158.797201] Starting dynamic subtest: vecs0 [158.853782] Dynamic subtest vecs0: SUCCESS (0.071s) [158.867942] Starting dynamic subtest: ccs0 [158.935646] Dynamic subtest ccs0: SUCCESS (0.080s) [158.937030] Subtest Q-promotion: SUCCESS (0.422s) [160.028442] [042/131] (860s left) kms_cursor_legacy (forked-bo) [160.150852] Starting subtest: forked-bo [160.151822] Starting dynamic subtest: pipe-A [165.612976] Dynamic subtest pipe-A: SUCCESS (5.459s) [165.624471] Starting dynamic subtest: pipe-B [171.087460] Dynamic subtest pipe-B: SUCCESS (5.474s) [171.097788] Starting dynamic subtest: pipe-C [176.553863] Dynamic subtest pipe-C: SUCCESS (5.465s) [176.564323] Starting dynamic subtest: pipe-D [182.041621] Dynamic subtest pipe-D: SUCCESS (5.484s) [182.051546] Starting dynamic subtest: all-pipes [187.554117] Dynamic subtest all-pipes: SUCCESS (5.513s) [187.555223] Subtest forked-bo: SUCCESS (27.402s) [187.712451] [043/131] (833s left) gem_readwrite (new-obj) [187.768079] Subtest new-obj: SKIP (0.000s) [187.844366] [044/131] (833s left) kms_busy (extended-modeset-hang-newfb) [187.929721] Starting subtest: extended-modeset-hang-newfb [187.932863] Starting dynamic subtest: pipe-A [222.906146] Dynamic subtest pipe-A: SUCCESS (34.973s) [222.913553] Starting dynamic subtest: pipe-D [245.833198] Dynamic subtest pipe-D: SUCCESS (22.924s) [245.834175] Subtest extended-modeset-hang-newfb: SUCCESS (57.901s) [246.645796] [045/131] (774s left) kms_color (ctm-0-50) [246.745478] Starting subtest: ctm-0-50 [246.746407] Starting dynamic subtest: pipe-A-eDP-1 [250.133928] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.389s) [250.141050] Starting dynamic subtest: pipe-B-eDP-1 [254.225077] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.091s) [254.231926] Starting dynamic subtest: pipe-C-eDP-1 [258.165733] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.940s) [258.172698] Starting dynamic subtest: pipe-D-eDP-1 [262.202297] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.034s) [262.203216] Subtest ctm-0-50: SUCCESS (15.456s) [263.040875] [046/131] (758s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [263.141989] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [263.142806] Starting dynamic subtest: pipe-A-eDP-1 [265.212105] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.070s) [265.220115] Starting dynamic subtest: pipe-B-eDP-1 [267.283888] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.070s) [267.291942] Starting dynamic subtest: pipe-C-eDP-1 [269.296794] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.011s) [269.305252] Starting dynamic subtest: pipe-D-eDP-1 [271.326563] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.028s) [271.327506] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.186s) [272.515139] [047/131] (748s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [272.608952] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [272.610833] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [272.714516] [048/131] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [272.812720] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [272.814750] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [272.926009] [049/131] (748s left) i915_drm_fdinfo (busy) [272.964179] Starting subtest: busy [272.965044] Starting dynamic subtest: rcs0 [272.995636] Dynamic subtest rcs0: SKIP (0.031s) [273.004906] Starting dynamic subtest: bcs0 [273.006974] Dynamic subtest bcs0: SKIP (0.000s) [273.013640] Starting dynamic subtest: vcs0 [273.015581] Dynamic subtest vcs0: SKIP (0.000s) [273.022210] Starting dynamic subtest: vcs1 [273.023885] Dynamic subtest vcs1: SKIP (0.000s) [273.030558] Starting dynamic subtest: vecs0 [273.032282] Dynamic subtest vecs0: SKIP (0.000s) [273.038956] Starting dynamic subtest: ccs0 [273.040692] Dynamic subtest ccs0: SKIP (0.000s) [273.042359] Subtest busy: SKIP (0.036s) [273.087021] [050/131] (748s left) kms_addfb_basic (bad-pitch-32) [273.140651] Starting subtest: bad-pitch-32 [273.141663] Subtest bad-pitch-32: SUCCESS (0.000s) [273.290058] [051/131] (747s left) sysfs_heartbeat_interval (invalid) [273.345584] Starting subtest: invalid [273.346797] Starting dynamic subtest: vecs0 [273.347901] Dynamic subtest vecs0: SUCCESS (0.000s) [273.356158] Starting dynamic subtest: ccs0 [273.356995] Dynamic subtest ccs0: SUCCESS (0.000s) [273.363478] Starting dynamic subtest: vcs0 [273.364424] Dynamic subtest vcs0: SUCCESS (0.000s) [273.370795] Starting dynamic subtest: bcs0 [273.371708] Dynamic subtest bcs0: SUCCESS (0.000s) [273.378128] Starting dynamic subtest: rcs0 [273.379027] Dynamic subtest rcs0: SUCCESS (0.000s) [273.385505] Starting dynamic subtest: vcs1 [273.386410] Dynamic subtest vcs1: SUCCESS (0.000s) [273.387316] Subtest invalid: SUCCESS (0.005s) [273.490215] [052/131] (747s left) kms_atomic (test-only) [273.583516] Starting subtest: test-only [273.634042] Starting dynamic subtest: pipe-A-eDP-1 [276.210543] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.577s) [276.211506] Subtest test-only: SUCCESS (2.628s) [277.100828] [053/131] (744s left) kms_sequence (get-busy) [277.196281] Starting subtest: get-busy [277.197380] Starting dynamic subtest: pipe-A-eDP-1 [279.130205] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s) [279.137681] Starting dynamic subtest: pipe-B-eDP-1 [281.700334] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.570s) [281.708310] Starting dynamic subtest: pipe-C-eDP-1 [284.301232] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.599s) [284.309138] Starting dynamic subtest: pipe-D-eDP-1 [286.850492] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s) [286.851372] Subtest get-busy: SUCCESS (9.654s) [287.657389] [054/131] (733s left) kms_invalid_mode (zero-hdisplay) [287.752147] Starting subtest: zero-hdisplay [287.753085] Starting dynamic subtest: pipe-A-eDP-1 [288.038976] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [288.045932] Starting dynamic subtest: pipe-B-eDP-1 [288.046951] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [288.053543] Starting dynamic subtest: pipe-C-eDP-1 [288.054616] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [288.061259] Starting dynamic subtest: pipe-D-eDP-1 [288.062102] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [288.062989] Subtest zero-hdisplay: SUCCESS (0.294s) [288.882320] [055/131] (732s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [289.002460] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [292.686903] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.684s) [293.887944] [056/131] (727s left) gem_softpin (allocator-evict) [293.953623] Starting subtest: allocator-evict [293.954724] Starting dynamic subtest: rcs0 [317.320618] Dynamic subtest rcs0: SUCCESS (23.365s) [317.340428] Starting dynamic subtest: bcs0 [340.984072] Dynamic subtest bcs0: SUCCESS (23.659s) [340.993264] Starting dynamic subtest: vcs0 [364.912247] Dynamic subtest vcs0: SUCCESS (23.924s) [364.923035] Starting dynamic subtest: vcs1 [388.908807] Dynamic subtest vcs1: SUCCESS (23.993s) [388.918931] Starting dynamic subtest: vecs0 [412.710459] Dynamic subtest vecs0: SUCCESS (23.800s) [412.717962] Starting dynamic subtest: ccs0 [436.872942] Dynamic subtest ccs0: SUCCESS (24.160s) [436.876206] Subtest allocator-evict: SUCCESS (142.915s) [436.984224] [057/131] (584s left) kms_cursor_crc (cursor-offscreen-256x85) [437.255519] Starting subtest: cursor-offscreen-256x85 [437.295103] Subtest cursor-offscreen-256x85: SKIP (0.037s) [437.512142] [058/131] (583s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [437.619583] Starting subtest: fbcpsr-rgb101010-draw-blt [444.408622] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.789s) [444.540354] [059/131] (576s left) kms_color (deep-color) [444.627664] Starting subtest: deep-color [445.661937] Starting dynamic subtest: pipe-A-eDP-1-gamma [446.372417] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.711s) [446.379599] Starting dynamic subtest: pipe-A-eDP-1-degamma [447.848871] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.474s) [447.856252] Starting dynamic subtest: pipe-A-eDP-1-ctm [449.285408] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.437s) [450.076176] Starting dynamic subtest: pipe-B-eDP-1-gamma [450.767254] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.696s) [450.774660] Starting dynamic subtest: pipe-B-eDP-1-degamma [452.156261] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.389s) [452.163719] Starting dynamic subtest: pipe-B-eDP-1-ctm [453.590306] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.433s) [454.381630] Starting dynamic subtest: pipe-C-eDP-1-gamma [455.042833] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.672s) [455.050514] Starting dynamic subtest: pipe-C-eDP-1-degamma [456.403959] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.360s) [456.411870] Starting dynamic subtest: pipe-C-eDP-1-ctm [457.844090] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.441s) [458.674263] Starting dynamic subtest: pipe-D-eDP-1-gamma [459.335251] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.667s) [459.342847] Starting dynamic subtest: pipe-D-eDP-1-degamma [460.742283] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.406s) [460.749313] Starting dynamic subtest: pipe-D-eDP-1-ctm [462.106884] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.363s) [462.107779] Subtest deep-color: SUCCESS (17.479s) [462.935329] [060/131] (558s left) gem_exec_create (forked) [463.008889] Starting subtest: forked [463.010054] Starting dynamic subtest: smem [484.885236] Dynamic subtest smem: SUCCESS (21.874s) [484.886781] Subtest forked: SUCCESS (21.876s) [485.094281] [061/131] (536s left) gem_exec_schedule (pi-common) [485.276681] Starting subtest: pi-common [485.277713] Starting dynamic subtest: rcs0 [485.317579] Dynamic subtest rcs0: SUCCESS (0.043s) [485.325260] Starting dynamic subtest: bcs0 [485.367566] Dynamic subtest bcs0: SUCCESS (0.049s) [485.376364] Starting dynamic subtest: vcs0 [485.408029] Dynamic subtest vcs0: SUCCESS (0.039s) [485.417289] Starting dynamic subtest: vcs1 [485.443657] Dynamic subtest vcs1: SUCCESS (0.034s) [485.450959] Starting dynamic subtest: vecs0 [485.477228] Dynamic subtest vecs0: SUCCESS (0.033s) [485.484410] Starting dynamic subtest: ccs0 [485.509523] Dynamic subtest ccs0: SUCCESS (0.031s) [485.510381] Subtest pi-common: SUCCESS (0.236s) [485.755231] [062/131] (535s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [485.807500] Starting subtest: invalid-multi-wait-unsubmitted-submitted [485.808447] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [485.932641] [063/131] (535s left) syncobj_timeline (single-wait-signaled) [485.978975] Starting subtest: single-wait-signaled [485.979982] Subtest single-wait-signaled: SUCCESS (0.001s) [486.121460] [064/131] (535s left) gem_ctx_persistence (saturated-hostile) [486.186643] Starting subtest: saturated-hostile [486.187495] Starting dynamic subtest: rcs0 [487.013884] Dynamic subtest rcs0: SUCCESS (0.828s) [487.025039] Starting dynamic subtest: bcs0 [487.825745] Dynamic subtest bcs0: SUCCESS (0.807s) [487.834839] Starting dynamic subtest: vcs0 [488.626083] Dynamic subtest vcs0: SUCCESS (0.801s) [488.637572] Starting dynamic subtest: vcs1 [489.455777] Dynamic subtest vcs1: SUCCESS (0.828s) [489.467025] Starting dynamic subtest: vecs0 [490.285246] Dynamic subtest vecs0: SUCCESS (0.828s) [490.295952] Starting dynamic subtest: ccs0 [491.151864] Dynamic subtest ccs0: SUCCESS (0.865s) [491.155062] Subtest saturated-hostile: SUCCESS (4.968s) [491.251783] [065/131] (530s left) gem_close_race (multigpu-basic-threads) [491.322797] Starting subtest: multigpu-basic-threads [491.324982] Subtest multigpu-basic-threads: SKIP (0.000s) [491.592501] [066/131] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [491.675893] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [491.677693] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [491.809429] [067/131] (529s left) kms_pm_rpm (i2c) [494.057709] Starting subtest: i2c [499.360074] Subtest i2c: SUCCESS (5.303s) [499.471433] [068/131] (522s left) kms_psr (fbc-pr-sprite-plane-move) [499.572516] Starting subtest: fbc-pr-sprite-plane-move [499.574230] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [499.664052] [069/131] (522s left) gem_mmap_offset (bad-extensions) [499.714282] Starting subtest: bad-extensions [499.715240] Subtest bad-extensions: SUCCESS (0.000s) [499.856312] [070/131] (521s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [499.934024] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [499.935852] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [500.055345] [071/131] (521s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [500.148834] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [500.150633] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [500.267853] [072/131] (521s left) perf_pmu (most-busy-idle-check-all) [500.308496] Starting subtest: most-busy-idle-check-all [500.309819] Starting dynamic subtest: rcs0 [501.909427] Dynamic subtest rcs0: SUCCESS (1.599s) [501.921305] Starting dynamic subtest: bcs0 [503.894767] Dynamic subtest bcs0: SUCCESS (1.981s) [503.905307] Starting dynamic subtest: vcs0 [505.878871] Dynamic subtest vcs0: SUCCESS (1.981s) [505.888812] Starting dynamic subtest: vcs1 [507.927278] Dynamic subtest vcs1: SUCCESS (2.045s) [507.938539] Starting dynamic subtest: vecs0 [509.910876] Dynamic subtest vecs0: SUCCESS (1.980s) [509.921515] Starting dynamic subtest: ccs0 [511.894858] Dynamic subtest ccs0: SUCCESS (1.981s) [511.896420] Subtest most-busy-idle-check-all: SUCCESS (11.585s) [512.013634] [073/131] (509s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [512.399645] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [513.237721] [074/131] (508s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [513.330401] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [513.332056] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [513.452957] [075/131] (508s left) gem_ctx_persistence (engines-cleanup) [513.503922] Starting subtest: engines-cleanup [513.504897] Starting dynamic subtest: rcs0 [513.613539] Dynamic subtest rcs0: SUCCESS (0.111s) [513.624468] Starting dynamic subtest: bcs0 [513.664270] Dynamic subtest bcs0: SUCCESS (0.049s) [513.674823] Starting dynamic subtest: vcs0 [513.692031] Dynamic subtest vcs0: SUCCESS (0.026s) [513.700136] Starting dynamic subtest: vcs1 [513.795701] Dynamic subtest vcs1: SUCCESS (0.102s) [513.807035] Starting dynamic subtest: vecs0 [513.867740] Dynamic subtest vecs0: SUCCESS (0.070s) [513.878667] Starting dynamic subtest: ccs0 [513.932871] Dynamic subtest ccs0: SUCCESS (0.063s) [513.934438] Subtest engines-cleanup: SUCCESS (0.431s) [514.031097] [076/131] (508s left) prime_mmap (test_map_unmap) [514.081531] Starting subtest: test_map_unmap [514.082778] Starting dynamic subtest: test_map_unmap-smem [514.111861] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s) [514.112951] Subtest test_map_unmap: SUCCESS (0.032s) [514.241066] [077/131] (507s left) gem_userptr_blits (set-cache-level) [514.293978] Starting subtest: set-cache-level [514.295925] Subtest set-cache-level: SKIP (0.000s) [514.451608] [078/131] (507s left) gem_busy (busy) [514.519548] Starting subtest: busy [514.520636] Starting dynamic subtest: all-engines [514.597251] Dynamic subtest all-engines: SUCCESS (0.078s) [514.613531] Starting dynamic subtest: rcs0 [515.872190] Dynamic subtest rcs0: SUCCESS (1.273s) [515.886283] Starting dynamic subtest: bcs0 [515.950553] Dynamic subtest bcs0: SUCCESS (0.076s) [515.962929] Starting dynamic subtest: vcs0 [515.991295] Dynamic subtest vcs0: SUCCESS (0.040s) [516.000474] Starting dynamic subtest: vcs1 [517.914579] Dynamic subtest vcs1: SUCCESS (1.919s) [517.924051] Starting dynamic subtest: vecs0 [519.898463] Dynamic subtest vecs0: SUCCESS (1.982s) [519.907711] Starting dynamic subtest: ccs0 [521.882482] Dynamic subtest ccs0: SUCCESS (1.983s) [521.883558] Subtest busy: SUCCESS (7.363s) [522.270803] [079/131] (499s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [522.371069] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [529.720380] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.350s) [529.861316] [080/131] (492s left) core_auth (basic-auth) [529.921341] Starting subtest: basic-auth [529.922253] Subtest basic-auth: SUCCESS (0.001s) [530.058193] [081/131] (492s left) prime_mmap_coherency (write) [530.114063] Starting subtest: write [535.493319] Subtest write: SUCCESS (5.376s) [535.637116] [082/131] (486s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [535.705615] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [535.707246] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [535.940500] [083/131] (486s left) perf (gen12-invalid-class-instance) [536.096626] Starting subtest: gen12-invalid-class-instance [536.107277] Subtest gen12-invalid-class-instance: SUCCESS (0.010s) [536.148548] [084/131] (486s left) kms_lease (lease-get) [536.257088] Starting subtest: lease-get [536.257963] Starting dynamic subtest: pipe-A-eDP-1 [536.258860] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [536.266527] Starting dynamic subtest: pipe-B-eDP-1 [536.267533] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [536.274866] Starting dynamic subtest: pipe-C-eDP-1 [536.275828] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [536.282963] Starting dynamic subtest: pipe-D-eDP-1 [536.283861] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [536.284743] Subtest lease-get: SUCCESS (0.009s) [536.400659] [085/131] (485s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [536.516120] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [536.517885] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [536.626455] [086/131] (485s left) i915_pm_rpm (system-suspend-devices) [538.141654] Starting subtest: system-suspend-devices [549.694948] Subtest system-suspend-devices: SUCCESS (11.554s) [557.094862] [087/131] (472s left) kms_cursor_edge_walk (128x128-right-edge) [557.193423] Starting subtest: 128x128-right-edge [557.194390] Starting dynamic subtest: pipe-A-eDP-1 [560.600371] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.406s) [560.608380] Starting dynamic subtest: pipe-D-eDP-1 [563.732925] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s) [563.733942] Subtest 128x128-right-edge: SUCCESS (6.540s) [564.554059] [088/131] (464s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [569.614607] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [569.615608] Starting dynamic subtest: pipe-A-eDP-1 [570.400944] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s) [570.410728] Starting dynamic subtest: pipe-B-eDP-1 [571.536201] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s) [571.538321] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.923s) [572.838874] [089/131] (456s left) perf (i915-ref-count) [572.928668] Starting subtest: i915-ref-count [572.960801] Subtest i915-ref-count: SUCCESS (0.031s) [573.013456] [090/131] (456s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [573.107134] Starting subtest: fbc-2p-primscrn-spr-indfb-move [573.108864] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [573.236184] [091/131] (456s left) core_auth (getclient-simple) [573.267075] Starting subtest: getclient-simple [573.294086] Subtest getclient-simple: SUCCESS (0.028s) [573.427925] [092/131] (456s left) i915_pciid [573.591591] [093/131] (456s left) gem_exec_fence (syncobj-timeline-signal) [574.159906] Starting subtest: syncobj-timeline-signal [574.168200] Subtest syncobj-timeline-signal: SUCCESS (0.008s) [576.018010] [094/131] (453s left) kms_flip (bo-too-big) [576.131964] Starting subtest: bo-too-big [576.134199] Starting dynamic subtest: A-eDP1 [577.487812] Dynamic subtest A-eDP1: SUCCESS (1.354s) [577.497910] Starting dynamic subtest: B-eDP1 [578.794454] Dynamic subtest B-eDP1: SUCCESS (1.306s) [578.806068] Starting dynamic subtest: C-eDP1 [580.111590] Dynamic subtest C-eDP1: SUCCESS (1.315s) [580.119823] Starting dynamic subtest: D-eDP1 [581.448105] Dynamic subtest D-eDP1: SUCCESS (1.335s) [581.452551] Subtest bo-too-big: SUCCESS (5.321s) [582.668229] [095/131] (447s left) kms_psr (pr-basic) [582.763426] Starting subtest: pr-basic [582.765302] Subtest pr-basic: SKIP (0.000s) [582.855193] [096/131] (446s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [582.942279] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [582.944173] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [583.070837] [097/131] (446s left) kms_addfb_basic (tile-pitch-mismatch) [583.134113] Starting subtest: tile-pitch-mismatch [583.135819] Subtest tile-pitch-mismatch: SKIP (0.000s) [583.306606] [098/131] (446s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [583.403880] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [583.404919] Starting dynamic subtest: pipe-A-eDP-1 [583.408634] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [583.416976] Starting dynamic subtest: pipe-B-eDP-1 [583.420615] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [583.428418] Starting dynamic subtest: pipe-C-eDP-1 [583.431864] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [583.439534] Starting dynamic subtest: pipe-D-eDP-1 [583.442777] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [583.444444] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s) [585.640478] [099/131] (444s left) gem_exec_reloc (basic-write-cpu-active) [585.701113] Subtest basic-write-cpu-active: SKIP (0.000s) [585.765664] [100/131] (444s left) gem_exec_whisper (basic-queues-forked-all) [585.831462] Starting subtest: basic-queues-forked-all [604.163855] Subtest basic-queues-forked-all: SUCCESS (18.327s) [604.362735] [101/131] (425s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [604.467781] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [604.468757] Starting dynamic subtest: pipe-A-default-mode [605.581854] Dynamic subtest pipe-A-default-mode: SKIP (1.113s) [605.583509] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.114s) [605.778622] [102/131] (424s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [605.879239] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [605.880159] Starting dynamic subtest: pipe-A-default-mode [606.171766] Dynamic subtest pipe-A-default-mode: SKIP (0.292s) [606.173572] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.293s) [607.000407] [103/131] (422s left) prime_mmap (test_dup) [607.055470] Starting subtest: test_dup [607.056416] Starting dynamic subtest: test_dup-smem [607.087040] Dynamic subtest test_dup-smem: SUCCESS (0.032s) [607.088279] Subtest test_dup: SUCCESS (0.034s) [607.164784] [104/131] (422s left) kms_addfb_basic (legacy-format) [607.220503] Starting subtest: legacy-format [607.253645] Subtest legacy-format: SUCCESS (0.029s) [607.419398] [105/131] (422s left) gem_workarounds (suspend-resume-context) [607.495977] Starting subtest: suspend-resume-context [623.774127] Subtest suspend-resume-context: SUCCESS (2.341s) [631.864233] [106/131] (406s left) gem_fence_thrash (bo-write-verify-none) [631.896995] Starting subtest: bo-write-verify-none [631.929628] Subtest bo-write-verify-none: SKIP (0.030s) [631.995075] [107/131] (406s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [637.100671] Starting subtest: psr2-cursor-plane-move-continuous-sf [637.101575] Starting dynamic subtest: pipe-A-eDP-1 [648.259801] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.092s) [648.268157] Starting dynamic subtest: pipe-B-eDP-1 [659.301741] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.022s) [659.302630] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.118s) [660.121478] [108/131] (378s left) kms_rotation_crc (primary-rotation-270) [660.214170] Starting subtest: primary-rotation-270 [660.216054] Subtest primary-rotation-270: SKIP (0.001s) [660.307263] [109/131] (377s left) syncobj_wait (invalid-reset-illegal-handle) [660.361802] Starting subtest: invalid-reset-illegal-handle [660.362939] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [660.490438] [110/131] (377s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [660.553565] Starting subtest: y-tiled-ccs-to-y-tiled [660.555651] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [660.756714] [111/131] (377s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [660.848786] Starting subtest: primary-y-tiled-reflect-x-270 [660.850550] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [660.943957] [112/131] (377s left) gen9_exec_parse (bb-large) [661.000743] Subtest bb-large: SKIP (0.000s) [661.063596] [113/131] (377s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [661.126530] Starting subtest: multi-wait-all-for-submit-signaled [661.127658] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [661.267718] [114/131] (377s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [661.364002] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [661.364880] Starting dynamic subtest: pipe-A [661.471569] Dynamic subtest pipe-A: SKIP (0.106s) [661.481921] Starting dynamic subtest: pipe-B [662.667339] Dynamic subtest pipe-B: SKIP (1.195s) [662.675563] Starting dynamic subtest: pipe-C [663.816815] Dynamic subtest pipe-C: SUCCESS (1.149s) [663.825505] Starting dynamic subtest: pipe-D [664.958204] Dynamic subtest pipe-D: SUCCESS (1.141s) [664.959145] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.594s) [666.177953] [115/131] (372s left) kms_psr (psr2-cursor-render) [666.261876] Starting subtest: psr2-cursor-render [666.262798] Starting dynamic subtest: eDP-1 [667.938722] Dynamic subtest eDP-1: SUCCESS (1.677s) [667.939597] Subtest psr2-cursor-render: SUCCESS (1.679s) [668.750308] [116/131] (369s left) gem_userptr_blits (invalid-null-pointer) [668.814541] Starting subtest: invalid-null-pointer [668.815624] Subtest invalid-null-pointer: SUCCESS (0.002s) [668.982535] [117/131] (369s left) api_intel_allocator (simple-allocator) [669.039755] Starting subtest: simple-allocator [669.040756] Starting dynamic subtest: basic [669.042395] Dynamic subtest basic: SUCCESS (0.004s) [669.057416] Starting dynamic subtest: parallel-one [669.232309] Dynamic subtest parallel-one: SUCCESS (0.187s) [669.241371] Starting dynamic subtest: print [669.242189] Dynamic subtest print: SUCCESS (0.000s) [669.250594] Starting dynamic subtest: reuse [669.251501] Dynamic subtest reuse: SUCCESS (0.000s) [669.259559] Starting dynamic subtest: reserve [669.260491] Dynamic subtest reserve: SUCCESS (0.000s) [669.268293] Starting dynamic subtest: fork-reopen-allocator [669.269197] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [669.270093] Subtest simple-allocator: SUCCESS (0.211s) [669.391716] [118/131] (369s left) kms_pipe_stress (stress-xrgb8888-yftiled) [669.493679] Starting subtest: stress-xrgb8888-yftiled [669.495331] Subtest stress-xrgb8888-yftiled: SKIP (0.000s) [669.574133] [119/131] (368s left) kms_flip (wf_vblank-ts-check) [669.656566] Starting subtest: wf_vblank-ts-check [669.657540] Starting dynamic subtest: A-eDP1 [678.587033] Dynamic subtest A-eDP1: SUCCESS (8.929s) [678.602309] Starting dynamic subtest: B-eDP1 [687.509530] Dynamic subtest B-eDP1: SUCCESS (8.919s) [687.524136] Starting dynamic subtest: C-eDP1 [696.436874] Dynamic subtest C-eDP1: SUCCESS (8.922s) [696.453237] Starting dynamic subtest: D-eDP1 [705.370208] Dynamic subtest D-eDP1: SUCCESS (8.928s) [705.375104] Subtest wf_vblank-ts-check: SUCCESS (35.712s) [706.618727] [120/131] (331s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [706.703002] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [706.703862] Starting dynamic subtest: pipe-A-eDP-1 [706.712075] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [706.720346] Starting dynamic subtest: pipe-B-eDP-1 [706.728980] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [706.737850] Starting dynamic subtest: pipe-C-eDP-1 [706.746211] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [706.754286] Starting dynamic subtest: pipe-D-eDP-1 [706.762827] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [706.764496] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s) [708.893811] [121/131] (329s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [708.954609] Starting subtest: invalid-multi-wait-unsubmitted [708.955662] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [709.080130] [122/131] (329s left) prime_mmap (test_errors) [709.142642] Starting subtest: test_errors [709.143637] Starting dynamic subtest: test_errors-smem [709.237305] Dynamic subtest test_errors-smem: SUCCESS (0.095s) [709.238572] Subtest test_errors: SUCCESS (0.096s) [709.374536] [123/131] (329s left) gem_exec_async (forked-writes) [709.436067] Starting subtest: forked-writes [709.437052] Starting dynamic subtest: rcs0 [709.463911] Dynamic subtest rcs0: SUCCESS (0.028s) [709.475161] Starting dynamic subtest: bcs0 [709.490525] Dynamic subtest bcs0: SUCCESS (0.026s) [709.499197] Starting dynamic subtest: vcs0 [709.513233] Dynamic subtest vcs0: SUCCESS (0.022s) [709.521985] Starting dynamic subtest: vcs1 [709.539448] Dynamic subtest vcs1: SUCCESS (0.025s) [709.549417] Starting dynamic subtest: vecs0 [709.563046] Dynamic subtest vecs0: SUCCESS (0.022s) [709.571547] Starting dynamic subtest: ccs0 [709.585375] Dynamic subtest ccs0: SUCCESS (0.021s) [709.586225] Subtest forked-writes: SUCCESS (0.150s) [709.858212] [124/131] (328s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [709.960851] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [714.464548] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.502s) [715.708873] [125/131] (323s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [715.798029] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [715.799009] Starting dynamic subtest: pipe-A-default-mode [716.129670] Dynamic subtest pipe-A-default-mode: SKIP (0.331s) [716.131542] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.332s) [716.918358] [126/131] (321s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [717.015652] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [726.389501] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.369s) [726.532086] [127/131] (312s left) gem_mmap_gtt (cpuset-basic-small-copy) [726.587967] Subtest cpuset-basic-small-copy: SKIP (0.000s) [726.650906] [128/131] (312s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [731.691842] Starting subtest: psr2-primary-plane-update-sf-dmg-area [731.692709] Starting dynamic subtest: pipe-A-eDP-1 [738.326435] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.635s) [738.334813] Starting dynamic subtest: pipe-B-eDP-1 [745.004823] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.679s) [745.005679] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.318s) [745.891467] [129/131] (293s left) sriov_basic (enable-vfs-bind-unbind-each) [745.952530] Starting subtest: enable-vfs-bind-unbind-each [745.954002] Starting dynamic subtest: numvfs-1 [745.987042] Dynamic subtest numvfs-1: FAIL (0.015s) [745.995521] Starting dynamic subtest: numvfs-2 [746.026346] Dynamic subtest numvfs-2: FAIL (0.004s) [746.035592] Starting dynamic subtest: numvfs-3 [746.063537] Dynamic subtest numvfs-3: FAIL (0.004s) [746.072955] Starting dynamic subtest: numvfs-4 [746.100853] Dynamic subtest numvfs-4: FAIL (0.004s) [746.108695] Starting dynamic subtest: numvfs-5 [746.139346] Dynamic subtest numvfs-5: FAIL (0.004s) [746.157674] Starting dynamic subtest: numvfs-6 [746.186444] Dynamic subtest numvfs-6: FAIL (0.004s) [746.195315] Starting dynamic subtest: numvfs-7 [746.222411] Dynamic subtest numvfs-7: FAIL (0.004s) [746.230244] Starting dynamic subtest: numvfs-random [746.258200] Dynamic subtest numvfs-random: FAIL (0.003s) [746.259101] Subtest enable-vfs-bind-unbind-each: FAIL (0.047s) [746.289721] [130/131] (292s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [746.397481] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [753.115297] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.720s) [753.235294] [131/131] (285s left) gem_exec_schedule (u-fairslice) [753.304525] Starting subtest: u-fairslice [753.305496] Starting dynamic subtest: rcs0 [755.323848] Dynamic subtest rcs0: SUCCESS (2.018s) [755.333230] Starting dynamic subtest: bcs0 [757.343550] Dynamic subtest bcs0: SUCCESS (2.019s) [757.351761] Starting dynamic subtest: vcs0 [759.365998] Dynamic subtest vcs0: SUCCESS (2.019s) [759.374676] Starting dynamic subtest: vcs1 [761.382759] Dynamic subtest vcs1: SUCCESS (2.018s) [761.390930] Starting dynamic subtest: vecs0 [763.401573] Dynamic subtest vecs0: SUCCESS (2.017s) [763.410097] Starting dynamic subtest: ccs0 [765.420626] Dynamic subtest ccs0: SUCCESS (2.019s) [765.421525] Subtest u-fairslice: SUCCESS (12.116s) [765.738325] 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.