[58.046316] Initializing watchdogs [58.046361] /dev/watchdog0 [58.060865] [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] [58.065134] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.067310] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.070731] [001/131] (960s left) kms_addfb_basic (bad-pitch-0) [58.151998] Starting subtest: bad-pitch-0 [58.154279] Subtest bad-pitch-0: SUCCESS (0.000s) [58.333162] [002/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [58.428686] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [58.433096] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [58.565206] [003/131] (960s left) kms_big_fb (x-tiled-64bpp-rotate-90) [58.672302] Starting subtest: x-tiled-64bpp-rotate-90 [58.707238] Subtest x-tiled-64bpp-rotate-90: SKIP (0.032s) [58.869404] [004/131] (959s left) kms_vrr (negative-basic) [58.978556] Starting subtest: negative-basic [58.983946] Starting dynamic subtest: pipe-A-eDP-1 [64.405936] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.419s) [64.709229] Subtest negative-basic: SUCCESS (5.731s) [65.578485] [005/131] (953s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [65.635765] Starting subtest: etime-multi-wait-available-unsubmitted [65.740892] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s) [65.859216] [006/131] (952s left) gem_exec_fence (syncobj-channel) [66.306711] Starting subtest: syncobj-channel [67.329169] Subtest syncobj-channel: SUCCESS (1.020s) [68.032156] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true [68.035345] [007/131] (950s left) perf_pmu (interrupts-sync) [68.080723] Starting subtest: interrupts-sync [69.244072] Subtest interrupts-sync: SUCCESS (1.163s) [69.375697] [008/131] (949s left) kms_plane_multiple (2x-tiling-x) [69.467748] Starting subtest: 2x-tiling-x [69.471862] Subtest 2x-tiling-x: SKIP (0.000s) [69.561865] [009/131] (949s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [69.667603] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [70.314164] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s) [70.534041] [010/131] (948s left) kms_big_fb (linear-64bpp-rotate-270) [70.637751] Starting subtest: linear-64bpp-rotate-270 [70.657173] Subtest linear-64bpp-rotate-270: SKIP (0.019s) [70.828671] [011/131] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [70.934347] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [75.651603] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.723s) [76.804709] [012/131] (942s left) gem_exec_whisper (basic-contexts-forked) [76.863960] Starting subtest: basic-contexts-forked [100.464803] Subtest basic-contexts-forked: SUCCESS (23.595s) [100.669600] [013/131] (918s left) sw_sync (alloc_fence) [100.721218] Starting subtest: alloc_fence [100.723544] Subtest alloc_fence: SUCCESS (0.000s) [100.805713] [014/131] (918s left) i915_query (query-garbage) [100.862424] Starting subtest: query-garbage [100.864934] Subtest query-garbage: SUCCESS (0.000s) [101.007219] [015/131] (918s left) gem_exec_reloc (basic-cpu-gtt-active) [101.067201] Subtest basic-cpu-gtt-active: SKIP (0.000s) [101.152732] [016/131] (918s left) gem_exec_endless (dispatch) [101.227775] Starting subtest: dispatch [101.230049] Starting dynamic subtest: rcs0 [101.234878] Dynamic subtest rcs0: SUCCESS (0.005s) [101.245293] Starting dynamic subtest: bcs0 [101.249369] Dynamic subtest bcs0: SUCCESS (0.004s) [101.259054] Starting dynamic subtest: vcs0 [101.263647] Dynamic subtest vcs0: SUCCESS (0.005s) [101.271691] Starting dynamic subtest: vcs1 [101.275837] Dynamic subtest vcs1: SUCCESS (0.005s) [101.283728] Starting dynamic subtest: vecs0 [101.287899] Dynamic subtest vecs0: SUCCESS (0.007s) [101.295747] Starting dynamic subtest: ccs0 [101.299863] Dynamic subtest ccs0: SUCCESS (0.004s) [101.301779] Subtest dispatch: SUCCESS (0.031s) [103.004625] [017/131] (916s left) kms_selftest (drm_dp_mst_helper) [103.037765] Starting subtest: drm_dp_mst_helper [103.104202] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [103.252196] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.148s) [103.260178] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [103.435515] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.181s) [103.444548] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [103.586732] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.153s) [103.588951] Subtest drm_dp_mst_helper: SUCCESS (0.549s) [103.825465] [018/131] (915s left) kms_big_fb (y-tiled-64bpp-rotate-0) [103.936648] Starting subtest: y-tiled-64bpp-rotate-0 [103.940706] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [104.069076] [019/131] (915s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [104.158636] Starting subtest: fbc-rgb565-draw-mmap-cpu [108.264974] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.108s) [109.492376] [020/131] (909s left) gem_mmap_wc (bad-size) [109.557031] Subtest bad-size: SKIP (0.000s) [109.625989] [021/131] (909s left) gem_mmap_gtt (basic-read-write) [109.695454] Subtest basic-read-write: SKIP (0.000s) [109.762198] [022/131] (909s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [109.868618] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [117.028716] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.161s) [117.208455] [023/131] (902s left) kms_psr (psr-cursor-plane-onoff) [117.304842] Starting subtest: psr-cursor-plane-onoff [117.307124] Starting dynamic subtest: eDP-1 [119.006532] Dynamic subtest eDP-1: SUCCESS (1.700s) [119.008583] Subtest psr-cursor-plane-onoff: SUCCESS (1.701s) [119.895514] [024/131] (899s left) dmabuf_sync_file (export-wait-after-attach) [119.957578] Starting subtest: export-wait-after-attach [119.960110] Subtest export-wait-after-attach: SUCCESS (0.002s) [120.045116] [025/131] (899s left) kms_pm_rpm (modeset-lpsp-stress) [122.061273] Starting subtest: modeset-lpsp-stress [138.759611] Subtest modeset-lpsp-stress: SUCCESS (16.697s) [138.873035] [026/131] (880s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [138.966905] Starting subtest: plane-upscale-20x20-with-rotation [138.969301] Starting dynamic subtest: pipe-A [139.192064] Dynamic subtest pipe-A: SUCCESS (0.227s) [139.201711] Starting dynamic subtest: pipe-B [140.497824] Dynamic subtest pipe-B: SUCCESS (1.305s) [140.507667] Starting dynamic subtest: pipe-C [141.826546] Dynamic subtest pipe-C: SUCCESS (1.328s) [141.835768] Starting dynamic subtest: pipe-D [143.155062] Dynamic subtest pipe-D: SUCCESS (1.328s) [143.157274] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.190s) [144.348094] [027/131] (875s left) prime_vgem (basic-fence-flip) [144.435611] Starting subtest: basic-fence-flip [144.726188] Subtest basic-fence-flip: SUCCESS (0.290s) [144.879204] [028/131] (874s left) gem_mmap_gtt (big-copy-xy) [144.945444] Subtest big-copy-XY: SKIP (0.000s) [145.019310] [029/131] (874s left) kms_cursor_crc (cursor-onscreen-512x512) [145.281950] Starting subtest: cursor-onscreen-512x512 [145.286412] Subtest cursor-onscreen-512x512: SKIP (0.001s) [145.471123] [030/131] (874s left) i915_pm_sseu (full-enable) [145.538763] Subtest full-enable: SKIP (0.000s) [145.667297] [031/131] (874s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [145.771135] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [145.772894] Starting dynamic subtest: pipe-A-eDP-1 [145.792804] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [145.801931] Starting dynamic subtest: pipe-B-eDP-1 [145.821482] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [145.828999] Starting dynamic subtest: pipe-C-eDP-1 [145.848271] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [145.857066] Starting dynamic subtest: pipe-D-eDP-1 [145.876688] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [145.880237] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [148.017285] [032/131] (871s left) kms_dp_link_training (non-uhbr-sst) [148.117337] Starting subtest: non-uhbr-sst [148.126266] Subtest non-uhbr-sst: SKIP (0.000s) [148.214159] [033/131] (871s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [148.318802] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [148.320952] Starting dynamic subtest: pipe-A-eDP-1 [148.345287] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [148.355797] Starting dynamic subtest: pipe-B-eDP-1 [148.378649] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [148.386401] Starting dynamic subtest: pipe-C-eDP-1 [148.409305] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [148.417059] Starting dynamic subtest: pipe-D-eDP-1 [148.440763] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [148.445194] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s) [150.579414] [034/131] (869s left) gem_pxp (regular-baseline-src-copy-readible) [150.715897] Starting subtest: regular-baseline-src-copy-readible [150.792571] Subtest regular-baseline-src-copy-readible: SUCCESS (0.079s) [150.961409] [035/131] (869s left) gem_exec_flush (basic-wb-rw-default) [151.020435] Starting subtest: basic-wb-rw-default [156.492654] Subtest basic-wb-rw-default: SUCCESS (5.472s) [156.702516] [036/131] (863s left) syncobj_timeline (signal-array) [156.754956] Starting subtest: signal-array [156.757363] Subtest signal-array: SUCCESS (0.000s) [156.894406] [037/131] (863s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [156.993968] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [158.051604] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.057s) [158.195974] [038/131] (861s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [158.289171] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [158.292818] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [158.430389] [039/131] (861s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [158.496831] Subtest writes-after-reads-uncached: SKIP (0.000s) [158.580325] [040/131] (861s left) gem_flink_basic (bad-open) [158.628410] Starting subtest: bad-open [158.630315] Subtest bad-open: SUCCESS (0.000s) [158.756554] [041/131] (861s left) gem_ctx_shared (q-promotion) [158.818783] Starting subtest: Q-promotion [158.820908] Starting dynamic subtest: rcs0 [158.922984] Dynamic subtest rcs0: SUCCESS (0.103s) [158.939061] Starting dynamic subtest: vcs0 [159.002606] Dynamic subtest vcs0: SUCCESS (0.079s) [159.018706] Starting dynamic subtest: vcs1 [159.087085] Dynamic subtest vcs1: SUCCESS (0.084s) [159.102783] Starting dynamic subtest: vecs0 [159.160945] Dynamic subtest vecs0: SUCCESS (0.073s) [159.175951] Starting dynamic subtest: ccs0 [159.239068] Dynamic subtest ccs0: SUCCESS (0.078s) [159.241175] Subtest Q-promotion: SUCCESS (0.421s) [161.071132] [042/131] (859s left) kms_cursor_legacy (forked-bo) [161.202125] Starting subtest: forked-bo [161.203908] Starting dynamic subtest: pipe-A [166.655688] Dynamic subtest pipe-A: SUCCESS (5.451s) [166.668219] Starting dynamic subtest: pipe-B [172.126993] Dynamic subtest pipe-B: SUCCESS (5.469s) [172.139781] Starting dynamic subtest: pipe-C [177.604524] Dynamic subtest pipe-C: SUCCESS (5.475s) [177.623113] Starting dynamic subtest: pipe-D [183.076774] Dynamic subtest pipe-D: SUCCESS (5.470s) [183.087429] Starting dynamic subtest: all-pipes [188.575160] Dynamic subtest all-pipes: SUCCESS (5.495s) [188.577521] Subtest forked-bo: SUCCESS (27.368s) [188.744837] [043/131] (831s left) gem_readwrite (new-obj) [188.811363] Subtest new-obj: SKIP (0.000s) [188.903068] [044/131] (831s left) kms_busy (extended-modeset-hang-newfb) [189.023312] Starting subtest: extended-modeset-hang-newfb [189.025592] Starting dynamic subtest: pipe-A [223.772596] Dynamic subtest pipe-A: SUCCESS (34.748s) [223.782031] Starting dynamic subtest: pipe-D [246.855915] Dynamic subtest pipe-D: SUCCESS (23.079s) [246.858854] Subtest extended-modeset-hang-newfb: SUCCESS (57.830s) [247.671285] [045/131] (772s left) kms_color (ctm-0-50) [247.781118] Starting subtest: ctm-0-50 [247.783231] Starting dynamic subtest: pipe-A-eDP-1 [251.346022] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.564s) [251.355386] Starting dynamic subtest: pipe-B-eDP-1 [255.606527] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.259s) [255.615915] Starting dynamic subtest: pipe-C-eDP-1 [259.617520] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.010s) [259.626734] Starting dynamic subtest: pipe-D-eDP-1 [263.598987] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.983s) [263.601417] Subtest ctm-0-50: SUCCESS (15.820s) [264.457083] [046/131] (756s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [264.556244] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [264.558189] Starting dynamic subtest: pipe-A-eDP-1 [266.640842] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.085s) [266.649292] Starting dynamic subtest: pipe-B-eDP-1 [268.945351] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.303s) [268.953691] Starting dynamic subtest: pipe-C-eDP-1 [270.998176] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.051s) [271.007076] Starting dynamic subtest: pipe-D-eDP-1 [273.168474] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.170s) [273.170242] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.614s) [274.373520] [047/131] (746s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [274.480978] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [274.485085] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [274.609928] [048/131] (745s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [274.723325] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [274.727473] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [274.837335] [049/131] (745s left) i915_drm_fdinfo (busy) [274.881081] Starting subtest: busy [274.883288] Starting dynamic subtest: rcs0 [274.920549] Dynamic subtest rcs0: SKIP (0.040s) [274.931585] Starting dynamic subtest: bcs0 [274.935977] Dynamic subtest bcs0: SKIP (0.001s) [274.946700] Starting dynamic subtest: vcs0 [274.950828] Dynamic subtest vcs0: SKIP (0.000s) [274.959081] Starting dynamic subtest: vcs1 [274.963268] Dynamic subtest vcs1: SKIP (0.000s) [274.971454] Starting dynamic subtest: vecs0 [274.976079] Dynamic subtest vecs0: SKIP (0.000s) [274.987266] Starting dynamic subtest: ccs0 [274.991783] Dynamic subtest ccs0: SKIP (0.000s) [274.996256] Subtest busy: SKIP (0.047s) [275.034729] [050/131] (745s left) kms_addfb_basic (bad-pitch-32) [275.092258] Starting subtest: bad-pitch-32 [275.094135] Subtest bad-pitch-32: SUCCESS (0.000s) [275.247332] [051/131] (745s left) sysfs_heartbeat_interval (invalid) [275.317589] Starting subtest: invalid [275.319492] Starting dynamic subtest: vecs0 [275.321709] Dynamic subtest vecs0: SUCCESS (0.000s) [275.330543] Starting dynamic subtest: ccs0 [275.332142] Dynamic subtest ccs0: SUCCESS (0.000s) [275.339384] Starting dynamic subtest: vcs0 [275.341058] Dynamic subtest vcs0: SUCCESS (0.000s) [275.348781] Starting dynamic subtest: bcs0 [275.350543] Dynamic subtest bcs0: SUCCESS (0.000s) [275.359994] Starting dynamic subtest: rcs0 [275.361734] Dynamic subtest rcs0: SUCCESS (0.000s) [275.369356] Starting dynamic subtest: vcs1 [275.371104] Dynamic subtest vcs1: SUCCESS (0.000s) [275.372615] Subtest invalid: SUCCESS (0.005s) [275.439154] [052/131] (745s left) kms_atomic (test-only) [275.535625] Starting subtest: test-only [275.581857] Starting dynamic subtest: pipe-A-eDP-1 [278.173731] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.588s) [278.176112] Subtest test-only: SUCCESS (2.637s) [279.076970] [053/131] (741s left) kms_sequence (get-busy) [279.177645] Starting subtest: get-busy [279.180068] Starting dynamic subtest: pipe-A-eDP-1 [281.099483] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s) [281.108681] Starting dynamic subtest: pipe-B-eDP-1 [283.745068] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.644s) [283.754273] Starting dynamic subtest: pipe-C-eDP-1 [286.368753] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.621s) [286.380774] Starting dynamic subtest: pipe-D-eDP-1 [289.002636] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.633s) [289.004874] Subtest get-busy: SUCCESS (9.826s) [289.821445] [054/131] (730s left) kms_invalid_mode (zero-hdisplay) [289.911145] Starting subtest: zero-hdisplay [289.913276] Starting dynamic subtest: pipe-A-eDP-1 [290.198015] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [290.206821] Starting dynamic subtest: pipe-B-eDP-1 [290.209076] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [290.219127] Starting dynamic subtest: pipe-C-eDP-1 [290.220992] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [290.229275] Starting dynamic subtest: pipe-D-eDP-1 [290.231762] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [290.234356] Subtest zero-hdisplay: SUCCESS (0.294s) [291.058879] [055/131] (729s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [291.172341] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [294.879274] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.709s) [296.061576] [056/131] (724s left) gem_softpin (allocator-evict) [296.126619] Starting subtest: allocator-evict [296.129074] Starting dynamic subtest: rcs0 [319.366564] Dynamic subtest rcs0: SUCCESS (23.238s) [319.376665] Starting dynamic subtest: bcs0 [342.966421] Dynamic subtest bcs0: SUCCESS (23.598s) [342.977959] Starting dynamic subtest: vcs0 [366.615188] Dynamic subtest vcs0: SUCCESS (23.647s) [366.625799] Starting dynamic subtest: vcs1 [390.483956] Dynamic subtest vcs1: SUCCESS (23.867s) [390.495878] Starting dynamic subtest: vecs0 [414.143687] Dynamic subtest vecs0: SUCCESS (23.658s) [414.153146] Starting dynamic subtest: ccs0 [438.134222] Dynamic subtest ccs0: SUCCESS (23.988s) [438.136457] Subtest allocator-evict: SUCCESS (142.004s) [438.239466] [057/131] (582s left) kms_cursor_crc (cursor-offscreen-256x85) [438.545617] Starting subtest: cursor-offscreen-256x85 [438.593498] Subtest cursor-offscreen-256x85: SKIP (0.042s) [438.806582] [058/131] (582s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [438.902196] Starting subtest: fbcpsr-rgb101010-draw-blt [445.668740] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.767s) [445.805207] [059/131] (575s left) kms_color (deep-color) [445.906720] Starting subtest: deep-color [447.002257] Starting dynamic subtest: pipe-A-eDP-1-gamma [447.720834] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.714s) [447.731896] Starting dynamic subtest: pipe-A-eDP-1-degamma [449.198074] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.479s) [449.209455] Starting dynamic subtest: pipe-A-eDP-1-ctm [450.648966] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.451s) [451.401762] Starting dynamic subtest: pipe-B-eDP-1-gamma [452.114170] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.719s) [452.123801] Starting dynamic subtest: pipe-B-eDP-1-degamma [453.573706] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.460s) [453.584855] Starting dynamic subtest: pipe-B-eDP-1-ctm [455.023200] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.449s) [455.788949] Starting dynamic subtest: pipe-C-eDP-1-gamma [456.471241] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.688s) [456.480415] Starting dynamic subtest: pipe-C-eDP-1-degamma [457.844798] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.374s) [457.855055] Starting dynamic subtest: pipe-C-eDP-1-ctm [459.259798] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.415s) [460.085329] Starting dynamic subtest: pipe-D-eDP-1-gamma [460.767067] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.691s) [460.775944] Starting dynamic subtest: pipe-D-eDP-1-degamma [462.137825] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.366s) [462.147145] Starting dynamic subtest: pipe-D-eDP-1-ctm [463.568575] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.430s) [463.570993] Subtest deep-color: SUCCESS (17.671s) [464.447158] [060/131] (556s left) gem_exec_create (forked) [464.513762] Starting subtest: forked [464.516184] Starting dynamic subtest: smem [485.911614] Dynamic subtest smem: SUCCESS (21.395s) [485.914467] Subtest forked: SUCCESS (21.397s) [486.125318] [061/131] (534s left) gem_exec_schedule (pi-common) [486.324630] Starting subtest: pi-common [486.326804] Starting dynamic subtest: rcs0 [486.358993] Dynamic subtest rcs0: SUCCESS (0.038s) [486.371614] Starting dynamic subtest: bcs0 [486.406712] Dynamic subtest bcs0: SUCCESS (0.047s) [486.416129] Starting dynamic subtest: vcs0 [486.444210] Dynamic subtest vcs0: SUCCESS (0.037s) [486.453362] Starting dynamic subtest: vcs1 [486.479324] Dynamic subtest vcs1: SUCCESS (0.034s) [486.488557] Starting dynamic subtest: vecs0 [486.512971] Dynamic subtest vecs0: SUCCESS (0.033s) [486.522094] Starting dynamic subtest: ccs0 [486.547127] Dynamic subtest ccs0: SUCCESS (0.033s) [486.549406] Subtest pi-common: SUCCESS (0.228s) [486.803218] [062/131] (534s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [486.875738] Starting subtest: invalid-multi-wait-unsubmitted-submitted [486.878208] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [487.020671] [063/131] (534s left) syncobj_timeline (single-wait-signaled) [487.082200] Starting subtest: single-wait-signaled [487.084700] Subtest single-wait-signaled: SUCCESS (0.000s) [487.204425] [064/131] (533s left) gem_ctx_persistence (saturated-hostile) [487.275832] Starting subtest: saturated-hostile [487.278296] Starting dynamic subtest: rcs0 [488.140240] Dynamic subtest rcs0: SUCCESS (0.863s) [488.157614] Starting dynamic subtest: bcs0 [488.962191] Dynamic subtest bcs0: SUCCESS (0.820s) [488.973439] Starting dynamic subtest: vcs0 [489.773163] Dynamic subtest vcs0: SUCCESS (0.809s) [489.784955] Starting dynamic subtest: vcs1 [490.595697] Dynamic subtest vcs1: SUCCESS (0.820s) [490.605767] Starting dynamic subtest: vecs0 [491.391385] Dynamic subtest vecs0: SUCCESS (0.794s) [491.402632] Starting dynamic subtest: ccs0 [492.247332] Dynamic subtest ccs0: SUCCESS (0.854s) [492.249883] Subtest saturated-hostile: SUCCESS (4.972s) [492.352744] [065/131] (528s left) gem_close_race (multigpu-basic-threads) [492.437254] Starting subtest: multigpu-basic-threads [492.441835] Subtest multigpu-basic-threads: SKIP (0.000s) [492.694964] [066/131] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [492.796756] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [492.801316] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [492.907592] [067/131] (528s left) kms_pm_rpm (i2c) [495.063433] Starting subtest: i2c [500.065239] Subtest i2c: SUCCESS (5.000s) [500.177692] [068/131] (521s left) kms_psr (fbc-pr-sprite-plane-move) [500.284307] Starting subtest: fbc-pr-sprite-plane-move [500.288640] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [500.380844] [069/131] (521s left) gem_mmap_offset (bad-extensions) [500.444753] Starting subtest: bad-extensions [500.447093] Subtest bad-extensions: SUCCESS (0.000s) [500.580885] [070/131] (520s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [500.689749] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [500.693799] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [500.819107] [071/131] (520s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [500.933660] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [500.938111] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [501.071675] [072/131] (520s left) perf_pmu (most-busy-idle-check-all) [501.127181] Starting subtest: most-busy-idle-check-all [501.129069] Starting dynamic subtest: rcs0 [502.872901] Dynamic subtest rcs0: SUCCESS (1.744s) [502.884899] Starting dynamic subtest: bcs0 [504.920336] Dynamic subtest bcs0: SUCCESS (2.045s) [504.932305] Starting dynamic subtest: vcs0 [506.904526] Dynamic subtest vcs0: SUCCESS (1.981s) [506.915999] Starting dynamic subtest: vcs1 [508.888094] Dynamic subtest vcs1: SUCCESS (1.981s) [508.900476] Starting dynamic subtest: vecs0 [510.935334] Dynamic subtest vecs0: SUCCESS (2.044s) [510.947004] Starting dynamic subtest: ccs0 [512.931366] Dynamic subtest ccs0: SUCCESS (1.981s) [512.935603] Subtest most-busy-idle-check-all: SUCCESS (11.793s) [513.036090] [073/131] (508s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [513.431018] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [514.240421] [074/131] (507s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [514.358757] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [514.363320] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [514.509238] [075/131] (507s left) gem_ctx_persistence (engines-cleanup) [514.580556] Starting subtest: engines-cleanup [514.582945] Starting dynamic subtest: rcs0 [514.698741] Dynamic subtest rcs0: SUCCESS (0.118s) [514.711077] Starting dynamic subtest: bcs0 [514.769931] Dynamic subtest bcs0: SUCCESS (0.069s) [514.781303] Starting dynamic subtest: vcs0 [514.834908] Dynamic subtest vcs0: SUCCESS (0.063s) [514.845959] Starting dynamic subtest: vcs1 [514.891993] Dynamic subtest vcs1: SUCCESS (0.055s) [514.903027] Starting dynamic subtest: vecs0 [514.945876] Dynamic subtest vecs0: SUCCESS (0.052s) [514.956443] Starting dynamic subtest: ccs0 [515.002742] Dynamic subtest ccs0: SUCCESS (0.055s) [515.005174] Subtest engines-cleanup: SUCCESS (0.424s) [515.108049] [076/131] (506s left) prime_mmap (test_map_unmap) [515.172407] Starting subtest: test_map_unmap [515.174585] Starting dynamic subtest: test_map_unmap-smem [515.200891] Dynamic subtest test_map_unmap-smem: SUCCESS (0.030s) [515.202954] Subtest test_map_unmap: SUCCESS (0.031s) [515.335623] [077/131] (506s left) gem_userptr_blits (set-cache-level) [515.391845] Starting subtest: set-cache-level [515.395272] Subtest set-cache-level: SKIP (0.000s) [515.552973] [078/131] (506s left) gem_busy (busy) [515.622570] Starting subtest: busy [515.624497] Starting dynamic subtest: all-engines [515.658218] Dynamic subtest all-engines: SUCCESS (0.036s) [515.669774] Starting dynamic subtest: rcs0 [516.894694] Dynamic subtest rcs0: SUCCESS (1.234s) [516.905358] Starting dynamic subtest: bcs0 [516.981481] Dynamic subtest bcs0: SUCCESS (0.084s) [516.991403] Starting dynamic subtest: vcs0 [517.022842] Dynamic subtest vcs0: SUCCESS (0.041s) [517.032392] Starting dynamic subtest: vcs1 [518.940661] Dynamic subtest vcs1: SUCCESS (1.914s) [518.951201] Starting dynamic subtest: vecs0 [520.923998] Dynamic subtest vecs0: SUCCESS (1.982s) [520.934406] Starting dynamic subtest: ccs0 [522.907871] Dynamic subtest ccs0: SUCCESS (1.983s) [522.909864] Subtest busy: SUCCESS (7.283s) [523.310664] [079/131] (498s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [523.429078] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [530.786082] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.359s) [530.945793] [080/131] (490s left) core_auth (basic-auth) [531.014838] Starting subtest: basic-auth [531.017140] Subtest basic-auth: SUCCESS (0.001s) [531.158391] [081/131] (490s left) prime_mmap_coherency (write) [531.231054] Starting subtest: write [536.610416] Subtest write: SUCCESS (5.380s) [536.800807] [082/131] (485s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [536.866251] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [536.870812] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [537.082550] [083/131] (484s left) perf (gen12-invalid-class-instance) [537.239720] Starting subtest: gen12-invalid-class-instance [537.250745] Subtest gen12-invalid-class-instance: SUCCESS (0.010s) [537.291053] [084/131] (484s left) kms_lease (lease-get) [537.386784] Starting subtest: lease-get [537.389080] Starting dynamic subtest: pipe-A-eDP-1 [537.391306] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [537.400550] Starting dynamic subtest: pipe-B-eDP-1 [537.402719] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [537.411356] Starting dynamic subtest: pipe-C-eDP-1 [537.413513] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [537.422191] Starting dynamic subtest: pipe-D-eDP-1 [537.424341] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [537.426568] Subtest lease-get: SUCCESS (0.009s) [537.545304] [085/131] (484s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [537.661280] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [537.665208] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [537.803569] [086/131] (484s left) i915_pm_rpm (system-suspend-devices) [540.139845] Starting subtest: system-suspend-devices [551.685891] Subtest system-suspend-devices: SUCCESS (11.549s) [552.116126] [087/131] (470s left) kms_cursor_edge_walk (128x128-right-edge) [552.228102] Starting subtest: 128x128-right-edge [552.230658] Starting dynamic subtest: pipe-A-eDP-1 [555.729239] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.499s) [555.739803] Starting dynamic subtest: pipe-D-eDP-1 [558.864657] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s) [558.866585] Subtest 128x128-right-edge: SUCCESS (6.636s) [559.676811] [088/131] (462s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [564.727370] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [564.729347] Starting dynamic subtest: pipe-A-eDP-1 [565.526135] Dynamic subtest pipe-A-eDP-1: SKIP (0.795s) [565.538501] Starting dynamic subtest: pipe-B-eDP-1 [566.657862] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s) [566.662379] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.928s) [567.869407] [089/131] (454s left) perf (i915-ref-count) [567.955949] Starting subtest: i915-ref-count [567.982304] Subtest i915-ref-count: SUCCESS (0.025s) [568.043369] [090/131] (454s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [568.152605] Starting subtest: fbc-2p-primscrn-spr-indfb-move [568.156760] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [568.267994] [091/131] (454s left) core_auth (getclient-simple) [568.308614] Starting subtest: getclient-simple [568.330488] Subtest getclient-simple: SUCCESS (0.021s) [568.467921] [092/131] (453s left) i915_pciid [568.677900] [093/131] (453s left) gem_exec_fence (syncobj-timeline-signal) [569.247051] Starting subtest: syncobj-timeline-signal [569.254233] Subtest syncobj-timeline-signal: SUCCESS (0.007s) [571.033559] [094/131] (451s left) kms_flip (bo-too-big) [571.139070] Starting subtest: bo-too-big [571.143520] Starting dynamic subtest: A-eDP1 [572.495877] Dynamic subtest A-eDP1: SUCCESS (1.354s) [572.516022] Starting dynamic subtest: B-eDP1 [573.816379] Dynamic subtest B-eDP1: SUCCESS (1.317s) [573.827551] Starting dynamic subtest: C-eDP1 [575.159168] Dynamic subtest C-eDP1: SUCCESS (1.342s) [575.169857] Starting dynamic subtest: D-eDP1 [576.491776] Dynamic subtest D-eDP1: SUCCESS (1.331s) [576.494161] Subtest bo-too-big: SUCCESS (5.356s) [577.726507] [095/131] (444s left) kms_psr (pr-basic) [577.824350] Starting subtest: pr-basic [577.828633] Subtest pr-basic: SKIP (0.000s) [577.922817] [096/131] (444s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [578.027570] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [578.031627] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [578.167441] [097/131] (444s left) kms_addfb_basic (tile-pitch-mismatch) [578.242327] Starting subtest: tile-pitch-mismatch [578.246339] Subtest tile-pitch-mismatch: SKIP (0.000s) [578.426118] [098/131] (444s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [578.530116] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [578.532402] Starting dynamic subtest: pipe-A-eDP-1 [578.541069] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [578.556057] Starting dynamic subtest: pipe-B-eDP-1 [578.565340] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [578.576762] Starting dynamic subtest: pipe-C-eDP-1 [578.585171] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [578.594378] Starting dynamic subtest: pipe-D-eDP-1 [578.602744] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [578.606980] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s) [580.790416] [099/131] (441s left) gem_exec_reloc (basic-write-cpu-active) [580.860617] Subtest basic-write-cpu-active: SKIP (0.000s) [580.948890] [100/131] (441s left) gem_exec_whisper (basic-queues-forked-all) [581.014997] Starting subtest: basic-queues-forked-all [599.099566] Subtest basic-queues-forked-all: SUCCESS (18.080s) [599.307941] [101/131] (423s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [599.418538] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [599.420935] Starting dynamic subtest: pipe-A-default-mode [600.547310] Dynamic subtest pipe-A-default-mode: SKIP (1.128s) [600.551647] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.130s) [600.752094] [102/131] (422s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [600.853047] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [600.855398] Starting dynamic subtest: pipe-A-default-mode [601.141883] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [601.146326] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.287s) [601.972986] [103/131] (420s left) prime_mmap (test_dup) [602.035186] Starting subtest: test_dup [602.037501] Starting dynamic subtest: test_dup-smem [602.066590] Dynamic subtest test_dup-smem: SUCCESS (0.032s) [602.069044] Subtest test_dup: SUCCESS (0.033s) [602.163263] [104/131] (420s left) kms_addfb_basic (legacy-format) [602.219835] Starting subtest: legacy-format [602.261118] Subtest legacy-format: SUCCESS (0.037s) [602.440544] [105/131] (420s left) gem_workarounds (suspend-resume-context) [602.503402] Starting subtest: suspend-resume-context [618.481236] Subtest suspend-resume-context: SUCCESS (1.200s) [618.666904] [106/131] (404s left) gem_fence_thrash (bo-write-verify-none) [618.703569] Starting subtest: bo-write-verify-none [618.727024] Subtest bo-write-verify-none: SKIP (0.020s) [618.800996] [107/131] (404s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [623.835607] Starting subtest: psr2-cursor-plane-move-continuous-sf [623.838006] Starting dynamic subtest: pipe-A-eDP-1 [634.918088] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.075s) [634.929723] Starting dynamic subtest: pipe-B-eDP-1 [645.956273] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.030s) [645.958842] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.111s) [646.788435] [108/131] (376s left) kms_rotation_crc (primary-rotation-270) [646.903843] Starting subtest: primary-rotation-270 [646.908358] Subtest primary-rotation-270: SKIP (0.001s) [647.004016] [109/131] (376s left) syncobj_wait (invalid-reset-illegal-handle) [647.067658] Starting subtest: invalid-reset-illegal-handle [647.069982] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [647.213447] [110/131] (375s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [647.282266] Starting subtest: y-tiled-ccs-to-y-tiled [647.286832] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [647.494259] [111/131] (375s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [647.584741] Starting subtest: primary-y-tiled-reflect-x-270 [647.588758] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [647.679697] [112/131] (375s left) gen9_exec_parse (bb-large) [647.747727] Subtest bb-large: SKIP (0.000s) [647.818035] [113/131] (375s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [647.892626] Starting subtest: multi-wait-all-for-submit-signaled [647.894517] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [648.021280] [114/131] (375s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [648.124350] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [648.126630] Starting dynamic subtest: pipe-A [648.259307] Dynamic subtest pipe-A: SKIP (0.130s) [648.269525] Starting dynamic subtest: pipe-B [649.424735] Dynamic subtest pipe-B: SKIP (1.166s) [649.435295] Starting dynamic subtest: pipe-C [650.555616] Dynamic subtest pipe-C: SUCCESS (1.135s) [650.573061] Starting dynamic subtest: pipe-D [651.700667] Dynamic subtest pipe-D: SUCCESS (1.143s) [651.702922] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.578s) [652.926778] [115/131] (370s left) kms_psr (psr2-cursor-render) [653.032215] Starting subtest: psr2-cursor-render [653.034592] Starting dynamic subtest: eDP-1 [654.794085] Dynamic subtest eDP-1: SUCCESS (1.763s) [654.796468] Subtest psr2-cursor-render: SUCCESS (1.764s) [655.618966] [116/131] (367s left) gem_userptr_blits (invalid-null-pointer) [655.690314] Starting subtest: invalid-null-pointer [655.692264] Subtest invalid-null-pointer: SUCCESS (0.001s) [655.841792] [117/131] (367s left) api_intel_allocator (simple-allocator) [655.907026] Starting subtest: simple-allocator [655.909391] Starting dynamic subtest: basic [655.911447] Dynamic subtest basic: SUCCESS (0.003s) [655.925269] Starting dynamic subtest: parallel-one [656.109647] Dynamic subtest parallel-one: SUCCESS (0.200s) [656.119897] Starting dynamic subtest: print [656.122062] Dynamic subtest print: SUCCESS (0.000s) [656.131699] Starting dynamic subtest: reuse [656.133848] Dynamic subtest reuse: SUCCESS (0.000s) [656.143472] Starting dynamic subtest: reserve [656.145638] Dynamic subtest reserve: SUCCESS (0.000s) [656.155058] Starting dynamic subtest: fork-reopen-allocator [656.157178] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [656.159355] Subtest simple-allocator: SUCCESS (0.223s) [656.275836] [118/131] (367s left) kms_pipe_stress (stress-xrgb8888-yftiled) [656.381892] Starting subtest: stress-xrgb8888-yftiled [656.386031] Subtest stress-xrgb8888-yftiled: SKIP (0.000s) [656.497063] [119/131] (367s left) kms_flip (wf_vblank-ts-check) [656.614026] Starting subtest: wf_vblank-ts-check [656.619088] Starting dynamic subtest: A-eDP1 [665.542976] Dynamic subtest A-eDP1: SUCCESS (8.924s) [665.553061] Starting dynamic subtest: B-eDP1 [674.479293] Dynamic subtest B-eDP1: SUCCESS (8.931s) [674.491956] Starting dynamic subtest: C-eDP1 [683.410260] Dynamic subtest C-eDP1: SUCCESS (8.927s) [683.420209] Starting dynamic subtest: D-eDP1 [692.347934] Dynamic subtest D-eDP1: SUCCESS (8.934s) [692.350381] Subtest wf_vblank-ts-check: SUCCESS (35.730s) [693.603501] [120/131] (330s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [693.709433] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [693.711694] Starting dynamic subtest: pipe-A-eDP-1 [693.733740] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [693.745811] Starting dynamic subtest: pipe-B-eDP-1 [693.766171] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [693.775343] Starting dynamic subtest: pipe-C-eDP-1 [693.795908] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [693.805005] Starting dynamic subtest: pipe-D-eDP-1 [693.826350] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [693.831169] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s) [696.064555] [121/131] (327s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [696.129393] Starting subtest: invalid-multi-wait-unsubmitted [696.131552] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [696.261697] [122/131] (327s left) prime_mmap (test_errors) [696.322952] Starting subtest: test_errors [696.325141] Starting dynamic subtest: test_errors-smem [696.416792] Dynamic subtest test_errors-smem: SUCCESS (0.096s) [696.419356] Subtest test_errors: SUCCESS (0.096s) [696.563146] [123/131] (327s left) gem_exec_async (forked-writes) [696.631554] Starting subtest: forked-writes [696.633874] Starting dynamic subtest: rcs0 [696.657020] Dynamic subtest rcs0: SUCCESS (0.025s) [696.670465] Starting dynamic subtest: bcs0 [696.679452] Dynamic subtest bcs0: SUCCESS (0.022s) [696.689864] Starting dynamic subtest: vcs0 [696.701723] Dynamic subtest vcs0: SUCCESS (0.021s) [696.711800] Starting dynamic subtest: vcs1 [696.723833] Dynamic subtest vcs1: SUCCESS (0.021s) [696.734300] Starting dynamic subtest: vecs0 [696.747195] Dynamic subtest vecs0: SUCCESS (0.023s) [696.757144] Starting dynamic subtest: ccs0 [696.768171] Dynamic subtest ccs0: SUCCESS (0.020s) [696.770449] Subtest forked-writes: SUCCESS (0.138s) [697.036091] [124/131] (326s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [697.141154] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [701.650152] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.512s) [702.868311] [125/131] (320s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [702.958219] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [702.960467] Starting dynamic subtest: pipe-A-default-mode [703.300929] Dynamic subtest pipe-A-default-mode: SKIP (0.340s) [703.305276] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.342s) [704.090502] [126/131] (319s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [704.189995] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [713.668546] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.479s) [713.821259] [127/131] (310s left) gem_mmap_gtt (cpuset-basic-small-copy) [713.884872] Subtest cpuset-basic-small-copy: SKIP (0.000s) [713.963570] [128/131] (310s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [718.910428] Starting subtest: psr2-primary-plane-update-sf-dmg-area [718.912853] Starting dynamic subtest: pipe-A-eDP-1 [725.543891] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.636s) [725.554488] Starting dynamic subtest: pipe-B-eDP-1 [732.177760] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.631s) [732.180030] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.273s) [733.070853] [129/131] (290s left) sriov_basic (enable-vfs-bind-unbind-each) [733.133025] Starting subtest: enable-vfs-bind-unbind-each [733.135526] Starting dynamic subtest: numvfs-1 [733.216581] Dynamic subtest numvfs-1: FAIL (0.029s) [733.228257] Starting dynamic subtest: numvfs-2 [733.301016] Dynamic subtest numvfs-2: FAIL (0.004s) [733.312509] Starting dynamic subtest: numvfs-3 [733.386536] Dynamic subtest numvfs-3: FAIL (0.003s) [733.397455] Starting dynamic subtest: numvfs-4 [733.470691] Dynamic subtest numvfs-4: FAIL (0.004s) [733.481749] Starting dynamic subtest: numvfs-5 [733.554031] Dynamic subtest numvfs-5: FAIL (0.004s) [733.565275] Starting dynamic subtest: numvfs-6 [733.638138] Dynamic subtest numvfs-6: FAIL (0.004s) [733.648912] Starting dynamic subtest: numvfs-7 [733.721437] Dynamic subtest numvfs-7: FAIL (0.004s) [733.732301] Starting dynamic subtest: numvfs-random [733.804477] Dynamic subtest numvfs-random: FAIL (0.004s) [733.806820] Subtest enable-vfs-bind-unbind-each: FAIL (0.061s) [733.847384] [130/131] (290s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [733.955904] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [740.800977] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.847s) [740.925780] [131/131] (283s left) gem_exec_schedule (u-fairslice) [741.002835] Starting subtest: u-fairslice [741.005167] Starting dynamic subtest: rcs0 [743.023063] Dynamic subtest rcs0: SUCCESS (2.025s) [743.035002] Starting dynamic subtest: bcs0 [745.044510] Dynamic subtest bcs0: SUCCESS (2.019s) [745.055448] Starting dynamic subtest: vcs0 [747.063615] Dynamic subtest vcs0: SUCCESS (2.017s) [747.073796] Starting dynamic subtest: vcs1 [749.080031] Dynamic subtest vcs1: SUCCESS (2.018s) [749.091173] Starting dynamic subtest: vecs0 [751.100883] Dynamic subtest vecs0: SUCCESS (2.017s) [751.111889] Starting dynamic subtest: ccs0 [753.118361] Dynamic subtest ccs0: SUCCESS (2.021s) [753.120391] Subtest u-fairslice: SUCCESS (12.125s) [753.447311] 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.