[59.361860] Initializing watchdogs [59.361907] /dev/watchdog0 [59.374858] [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.378915] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.381053] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.384450] [001/131] (960s left) kms_addfb_basic (bad-pitch-0) [59.454618] Starting subtest: bad-pitch-0 [59.456929] Subtest bad-pitch-0: SUCCESS (0.000s) [59.630036] [002/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [59.733047] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [59.737241] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [59.869538] [003/131] (960s left) kms_big_fb (x-tiled-64bpp-rotate-90) [59.981419] Starting subtest: x-tiled-64bpp-rotate-90 [60.013456] Subtest x-tiled-64bpp-rotate-90: SKIP (0.031s) [60.158144] [004/131] (959s left) kms_vrr (negative-basic) [60.261975] Starting subtest: negative-basic [60.267480] Starting dynamic subtest: pipe-A-eDP-1 [66.183693] Dynamic subtest pipe-A-eDP-1: FAIL (5.437s) [66.185661] Subtest negative-basic: FAIL (5.734s) [66.824824] [005/131] (953s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [66.883385] Starting subtest: etime-multi-wait-available-unsubmitted [66.986205] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s) [67.190824] [006/131] (952s left) gem_exec_fence (syncobj-channel) [67.703927] Starting subtest: syncobj-channel [68.730580] Subtest syncobj-channel: SUCCESS (1.023s) [69.038047] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true [69.041177] [007/131] (951s left) perf_pmu (interrupts-sync) [69.076660] Starting subtest: interrupts-sync [70.178879] Subtest interrupts-sync: SUCCESS (1.100s) [70.331273] [008/131] (949s left) kms_plane_multiple (2x-tiling-x) [70.441136] Starting subtest: 2x-tiling-x [70.445325] Subtest 2x-tiling-x: SKIP (0.000s) [70.554983] [009/131] (949s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [70.664216] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [71.299362] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.636s) [71.495655] [010/131] (948s left) kms_big_fb (linear-64bpp-rotate-270) [71.600627] Starting subtest: linear-64bpp-rotate-270 [71.623279] Subtest linear-64bpp-rotate-270: SKIP (0.019s) [71.770423] [011/131] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [71.871230] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [76.551272] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.683s) [77.769861] [012/131] (942s left) gem_exec_whisper (basic-contexts-forked) [77.851425] Starting subtest: basic-contexts-forked [101.467657] Subtest basic-contexts-forked: SUCCESS (23.614s) [101.683871] [013/131] (918s left) sw_sync (alloc_fence) [101.722163] Starting subtest: alloc_fence [101.724250] Subtest alloc_fence: SUCCESS (0.000s) [101.809952] [014/131] (918s left) i915_query (query-garbage) [101.875967] Starting subtest: query-garbage [101.878114] Subtest query-garbage: SUCCESS (0.000s) [102.017620] [015/131] (918s left) gem_exec_reloc (basic-cpu-gtt-active) [102.069951] Subtest basic-cpu-gtt-active: SKIP (0.000s) [102.158590] [016/131] (918s left) gem_exec_endless (dispatch) [102.220662] Starting subtest: dispatch [102.223232] Starting dynamic subtest: rcs0 [102.230436] Dynamic subtest rcs0: SUCCESS (0.007s) [102.244459] Starting dynamic subtest: bcs0 [102.249132] Dynamic subtest bcs0: SUCCESS (0.004s) [102.258336] Starting dynamic subtest: vcs0 [102.262730] Dynamic subtest vcs0: SUCCESS (0.005s) [102.270122] Starting dynamic subtest: vcs1 [102.274488] Dynamic subtest vcs1: SUCCESS (0.005s) [102.281661] Starting dynamic subtest: vecs0 [102.286213] Dynamic subtest vecs0: SUCCESS (0.004s) [102.293390] Starting dynamic subtest: ccs0 [102.297808] Dynamic subtest ccs0: SUCCESS (0.004s) [102.300031] Subtest dispatch: SUCCESS (0.032s) [103.961588] [017/131] (916s left) kms_selftest (drm_dp_mst_helper) [104.001807] Starting subtest: drm_dp_mst_helper [104.067089] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [104.216793] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.148s) [104.224357] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [104.370128] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.155s) [104.378044] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [104.491315] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.119s) [104.493255] Subtest drm_dp_mst_helper: SUCCESS (0.487s) [104.726754] [018/131] (915s left) kms_big_fb (y-tiled-64bpp-rotate-0) [104.841504] Starting subtest: y-tiled-64bpp-rotate-0 [104.845596] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [104.960508] [019/131] (915s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [105.056703] Starting subtest: fbc-rgb565-draw-mmap-cpu [109.093827] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.041s) [110.250812] [020/131] (910s left) gem_mmap_wc (bad-size) [110.310062] Subtest bad-size: SKIP (0.000s) [110.368505] [021/131] (910s left) gem_mmap_gtt (basic-read-write) [110.426148] Subtest basic-read-write: SKIP (0.000s) [110.490944] [022/131] (910s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [110.601384] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [117.668074] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.069s) [117.851565] [023/131] (902s left) kms_psr (psr-cursor-plane-onoff) [117.943073] Starting subtest: psr-cursor-plane-onoff [117.945410] Starting dynamic subtest: eDP-1 [119.638722] Dynamic subtest eDP-1: SUCCESS (1.695s) [119.641228] Subtest psr-cursor-plane-onoff: SUCCESS (1.696s) [120.527207] [024/131] (900s left) dmabuf_sync_file (export-wait-after-attach) [120.577991] Starting subtest: export-wait-after-attach [120.580235] Subtest export-wait-after-attach: SUCCESS (0.001s) [120.655198] [025/131] (900s left) kms_pm_rpm (modeset-lpsp-stress) [122.168821] Starting subtest: modeset-lpsp-stress [137.643286] Subtest modeset-lpsp-stress: SUCCESS (15.476s) [137.756829] [026/131] (883s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [137.846155] Starting subtest: plane-upscale-20x20-with-rotation [137.848502] Starting dynamic subtest: pipe-A [138.081326] Dynamic subtest pipe-A: SUCCESS (0.237s) [138.089022] Starting dynamic subtest: pipe-B [139.374694] Dynamic subtest pipe-B: SUCCESS (1.293s) [139.385156] Starting dynamic subtest: pipe-C [140.706387] Dynamic subtest pipe-C: SUCCESS (1.331s) [140.716180] Starting dynamic subtest: pipe-D [142.030878] Dynamic subtest pipe-D: SUCCESS (1.324s) [142.033311] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.187s) [143.233478] [027/131] (877s left) prime_vgem (basic-fence-flip) [143.320798] Starting subtest: basic-fence-flip [143.609597] Subtest basic-fence-flip: SUCCESS (0.289s) [143.746361] [028/131] (877s left) gem_mmap_gtt (big-copy-xy) [143.813676] Subtest big-copy-XY: SKIP (0.000s) [143.884269] [029/131] (877s left) kms_cursor_crc (cursor-onscreen-512x512) [144.144855] Starting subtest: cursor-onscreen-512x512 [144.149215] Subtest cursor-onscreen-512x512: SKIP (0.001s) [144.369857] [030/131] (876s left) i915_pm_sseu (full-enable) [144.426607] Subtest full-enable: SKIP (0.000s) [144.545336] [031/131] (876s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [144.635032] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [144.637380] Starting dynamic subtest: pipe-A-eDP-1 [144.662799] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [144.672311] Starting dynamic subtest: pipe-B-eDP-1 [144.695138] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [144.702316] Starting dynamic subtest: pipe-C-eDP-1 [144.724784] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [144.731983] Starting dynamic subtest: pipe-D-eDP-1 [144.754868] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [144.759022] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [146.813072] [032/131] (874s left) kms_dp_link_training (non-uhbr-sst) [146.906215] Starting subtest: non-uhbr-sst [146.914800] Subtest non-uhbr-sst: SKIP (0.000s) [147.004708] [033/131] (874s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [147.091031] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [147.093232] Starting dynamic subtest: pipe-A-eDP-1 [147.117140] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [147.125832] Starting dynamic subtest: pipe-B-eDP-1 [147.148163] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [147.155997] Starting dynamic subtest: pipe-C-eDP-1 [147.178680] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [147.186775] Starting dynamic subtest: pipe-D-eDP-1 [147.210770] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [147.215162] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s) [149.304523] [034/131] (872s left) gem_pxp (regular-baseline-src-copy-readible) [149.422816] Starting subtest: regular-baseline-src-copy-readible [149.479800] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s) [149.652522] [035/131] (871s left) gem_exec_flush (basic-wb-rw-default) [149.728387] Starting subtest: basic-wb-rw-default [155.190221] Subtest basic-wb-rw-default: SUCCESS (5.462s) [155.402182] [036/131] (866s left) syncobj_timeline (signal-array) [155.456329] Starting subtest: signal-array [155.459032] Subtest signal-array: SUCCESS (0.000s) [155.574107] [037/131] (865s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [155.686269] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [156.668251] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.981s) [156.848841] [038/131] (864s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [156.952703] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [156.956142] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [157.089809] [039/131] (864s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [157.148393] Subtest writes-after-reads-uncached: SKIP (0.000s) [157.229914] [040/131] (864s left) gem_flink_basic (bad-open) [157.282317] Starting subtest: bad-open [157.283974] Subtest bad-open: SUCCESS (0.000s) [157.419459] [041/131] (864s left) gem_ctx_shared (q-promotion) [157.493079] Starting subtest: Q-promotion [157.494635] Starting dynamic subtest: rcs0 [157.591599] Dynamic subtest rcs0: SUCCESS (0.100s) [157.607355] Starting dynamic subtest: vcs0 [157.674668] Dynamic subtest vcs0: SUCCESS (0.082s) [157.690092] Starting dynamic subtest: vcs1 [157.752487] Dynamic subtest vcs1: SUCCESS (0.077s) [157.767799] Starting dynamic subtest: vecs0 [157.824398] Dynamic subtest vecs0: SUCCESS (0.071s) [157.839748] Starting dynamic subtest: ccs0 [157.896869] Dynamic subtest ccs0: SUCCESS (0.072s) [157.899096] Subtest Q-promotion: SUCCESS (0.405s) [159.074082] [042/131] (862s left) kms_cursor_legacy (forked-bo) [159.198847] Starting subtest: forked-bo [159.200942] Starting dynamic subtest: pipe-A [164.671445] Dynamic subtest pipe-A: SUCCESS (5.470s) [164.682981] Starting dynamic subtest: pipe-B [170.139408] Dynamic subtest pipe-B: SUCCESS (5.466s) [170.151109] Starting dynamic subtest: pipe-C [175.606662] Dynamic subtest pipe-C: SUCCESS (5.465s) [175.618492] Starting dynamic subtest: pipe-D [181.083082] Dynamic subtest pipe-D: SUCCESS (5.474s) [181.094075] Starting dynamic subtest: all-pipes [186.602883] Dynamic subtest all-pipes: SUCCESS (5.518s) [186.605521] Subtest forked-bo: SUCCESS (27.402s) [186.772893] [043/131] (834s left) gem_readwrite (new-obj) [186.850240] Subtest new-obj: SKIP (0.000s) [186.937356] [044/131] (834s left) kms_busy (extended-modeset-hang-newfb) [187.052106] Starting subtest: extended-modeset-hang-newfb [187.054456] Starting dynamic subtest: pipe-A [221.787766] Dynamic subtest pipe-A: SUCCESS (34.736s) [221.801573] Starting dynamic subtest: pipe-D [244.825067] Dynamic subtest pipe-D: SUCCESS (23.033s) [244.827404] Subtest extended-modeset-hang-newfb: SUCCESS (57.773s) [245.736114] [045/131] (776s left) kms_color (ctm-0-50) [245.832429] Starting subtest: ctm-0-50 [245.834844] Starting dynamic subtest: pipe-A-eDP-1 [249.318598] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s) [249.327995] Starting dynamic subtest: pipe-B-eDP-1 [253.602073] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.282s) [253.610251] Starting dynamic subtest: pipe-C-eDP-1 [257.627803] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.026s) [257.636888] Starting dynamic subtest: pipe-D-eDP-1 [261.585782] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.956s) [261.588691] Subtest ctm-0-50: SUCCESS (15.752s) [262.463337] [046/131] (759s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [262.561241] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [262.563194] Starting dynamic subtest: pipe-A-eDP-1 [264.628209] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.067s) [264.636242] Starting dynamic subtest: pipe-B-eDP-1 [266.933268] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.305s) [266.947011] Starting dynamic subtest: pipe-C-eDP-1 [269.035591] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.099s) [269.043288] Starting dynamic subtest: pipe-D-eDP-1 [271.175049] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.138s) [271.177070] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.615s) [272.410356] [047/131] (749s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [272.531972] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [272.536394] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [272.666394] [048/131] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [272.776809] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [272.780718] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [272.915822] [049/131] (749s left) i915_drm_fdinfo (busy) [272.952729] Starting subtest: busy [272.954647] Starting dynamic subtest: rcs0 [272.995339] Dynamic subtest rcs0: SKIP (0.041s) [273.005561] Starting dynamic subtest: bcs0 [273.009814] Dynamic subtest bcs0: SKIP (0.000s) [273.020191] Starting dynamic subtest: vcs0 [273.024525] Dynamic subtest vcs0: SKIP (0.000s) [273.031814] Starting dynamic subtest: vcs1 [273.035874] Dynamic subtest vcs1: SKIP (0.000s) [273.043019] Starting dynamic subtest: vecs0 [273.047103] Dynamic subtest vecs0: SKIP (0.000s) [273.054201] Starting dynamic subtest: ccs0 [273.058200] Dynamic subtest ccs0: SKIP (0.000s) [273.062177] Subtest busy: SKIP (0.047s) [273.096084] [050/131] (748s left) kms_addfb_basic (bad-pitch-32) [273.155430] Starting subtest: bad-pitch-32 [273.157794] Subtest bad-pitch-32: SUCCESS (0.000s) [273.315230] [051/131] (748s left) sysfs_heartbeat_interval (invalid) [273.383077] Starting subtest: invalid [273.385088] Starting dynamic subtest: vecs0 [273.387092] Dynamic subtest vecs0: SUCCESS (0.000s) [273.396788] Starting dynamic subtest: ccs0 [273.398747] Dynamic subtest ccs0: SUCCESS (0.000s) [273.408436] Starting dynamic subtest: vcs0 [273.410388] Dynamic subtest vcs0: SUCCESS (0.000s) [273.417544] Starting dynamic subtest: bcs0 [273.419235] Dynamic subtest bcs0: SUCCESS (0.000s) [273.427453] Starting dynamic subtest: rcs0 [273.429240] Dynamic subtest rcs0: SUCCESS (0.001s) [273.437061] Starting dynamic subtest: vcs1 [273.438915] Dynamic subtest vcs1: SUCCESS (0.000s) [273.440808] Subtest invalid: SUCCESS (0.010s) [273.493435] [052/131] (748s left) kms_atomic (test-only) [273.586399] Starting subtest: test-only [273.633538] Starting dynamic subtest: pipe-A-eDP-1 [276.103897] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.470s) [276.106103] Subtest test-only: SUCCESS (2.518s) [276.991025] [053/131] (745s left) kms_sequence (get-busy) [277.089269] Starting subtest: get-busy [277.091585] Starting dynamic subtest: pipe-A-eDP-1 [279.009240] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.921s) [279.019203] Starting dynamic subtest: pipe-B-eDP-1 [281.563101] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.552s) [281.572656] Starting dynamic subtest: pipe-C-eDP-1 [284.200290] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.636s) [284.209415] Starting dynamic subtest: pipe-D-eDP-1 [286.747637] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s) [286.750064] Subtest get-busy: SUCCESS (9.659s) [287.568205] [054/131] (734s left) kms_invalid_mode (zero-hdisplay) [287.677074] Starting subtest: zero-hdisplay [287.679210] Starting dynamic subtest: pipe-A-eDP-1 [287.968389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s) [287.977144] Starting dynamic subtest: pipe-B-eDP-1 [287.979032] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [287.986646] Starting dynamic subtest: pipe-C-eDP-1 [287.988524] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [287.996490] Starting dynamic subtest: pipe-D-eDP-1 [287.998673] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [288.000779] Subtest zero-hdisplay: SUCCESS (0.298s) [288.805710] [055/131] (733s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [288.910196] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [292.575987] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.669s) [293.792431] [056/131] (728s left) gem_softpin (allocator-evict) [293.851562] Starting subtest: allocator-evict [293.854040] Starting dynamic subtest: rcs0 [316.897307] Dynamic subtest rcs0: SUCCESS (23.044s) [316.906248] Starting dynamic subtest: bcs0 [340.427068] Dynamic subtest bcs0: SUCCESS (23.527s) [340.435686] Starting dynamic subtest: vcs0 [364.081749] Dynamic subtest vcs0: SUCCESS (23.652s) [364.093417] Starting dynamic subtest: vcs1 [387.548506] Dynamic subtest vcs1: SUCCESS (23.465s) [387.564396] Starting dynamic subtest: vecs0 [411.218453] Dynamic subtest vecs0: SUCCESS (23.667s) [411.228080] Starting dynamic subtest: ccs0 [435.309285] Dynamic subtest ccs0: SUCCESS (24.088s) [435.311685] Subtest allocator-evict: SUCCESS (141.454s) [435.414702] [057/131] (586s left) kms_cursor_crc (cursor-offscreen-256x85) [435.706715] Starting subtest: cursor-offscreen-256x85 [435.751435] Subtest cursor-offscreen-256x85: SKIP (0.040s) [435.957750] [058/131] (586s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [436.062260] Starting subtest: fbcpsr-rgb101010-draw-blt [442.828236] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.769s) [442.992895] [059/131] (579s left) kms_color (deep-color) [443.086183] Starting subtest: deep-color [444.138672] Starting dynamic subtest: pipe-A-eDP-1-gamma [444.844413] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.706s) [444.853519] Starting dynamic subtest: pipe-A-eDP-1-degamma [446.253048] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.406s) [446.268987] Starting dynamic subtest: pipe-A-eDP-1-ctm [447.698122] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.446s) [448.457294] Starting dynamic subtest: pipe-B-eDP-1-gamma [449.131970] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.682s) [449.141533] Starting dynamic subtest: pipe-B-eDP-1-degamma [450.541924] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.407s) [450.551381] Starting dynamic subtest: pipe-B-eDP-1-ctm [451.953066] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.411s) [452.737431] Starting dynamic subtest: pipe-C-eDP-1-gamma [453.377127] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.646s) [453.386959] Starting dynamic subtest: pipe-C-eDP-1-degamma [454.764135] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.386s) [454.773989] Starting dynamic subtest: pipe-C-eDP-1-ctm [456.101241] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.336s) [456.853910] Starting dynamic subtest: pipe-D-eDP-1-gamma [457.527660] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.680s) [457.537515] Starting dynamic subtest: pipe-D-eDP-1-degamma [458.900560] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.370s) [458.909997] Starting dynamic subtest: pipe-D-eDP-1-ctm [460.329897] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.429s) [460.332188] Subtest deep-color: SUCCESS (17.243s) [461.211243] [060/131] (561s left) gem_exec_create (forked) [461.285715] Starting subtest: forked [461.288068] Starting dynamic subtest: smem [481.942478] Dynamic subtest smem: SUCCESS (20.654s) [481.945555] Subtest forked: SUCCESS (20.657s) [482.155545] [061/131] (540s left) gem_exec_schedule (pi-common) [482.349855] Starting subtest: pi-common [482.352299] Starting dynamic subtest: rcs0 [482.384752] Dynamic subtest rcs0: SUCCESS (0.038s) [482.393811] Starting dynamic subtest: bcs0 [482.430254] Dynamic subtest bcs0: SUCCESS (0.045s) [482.438943] Starting dynamic subtest: vcs0 [482.473444] Dynamic subtest vcs0: SUCCESS (0.042s) [482.482469] Starting dynamic subtest: vcs1 [482.510463] Dynamic subtest vcs1: SUCCESS (0.036s) [482.519059] Starting dynamic subtest: vecs0 [482.544074] Dynamic subtest vecs0: SUCCESS (0.033s) [482.552596] Starting dynamic subtest: ccs0 [482.576053] Dynamic subtest ccs0: SUCCESS (0.031s) [482.578398] Subtest pi-common: SUCCESS (0.231s) [482.837957] [062/131] (539s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [482.900826] Starting subtest: invalid-multi-wait-unsubmitted-submitted [482.903227] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [483.038898] [063/131] (539s left) syncobj_timeline (single-wait-signaled) [483.098426] Starting subtest: single-wait-signaled [483.100655] Subtest single-wait-signaled: SUCCESS (0.000s) [483.238388] [064/131] (539s left) gem_ctx_persistence (saturated-hostile) [483.303475] Starting subtest: saturated-hostile [483.305860] Starting dynamic subtest: rcs0 [484.116404] Dynamic subtest rcs0: SUCCESS (0.812s) [484.129089] Starting dynamic subtest: bcs0 [484.922455] Dynamic subtest bcs0: SUCCESS (0.804s) [484.934021] Starting dynamic subtest: vcs0 [485.730173] Dynamic subtest vcs0: SUCCESS (0.806s) [485.741911] Starting dynamic subtest: vcs1 [486.542889] Dynamic subtest vcs1: SUCCESS (0.807s) [486.558746] Starting dynamic subtest: vecs0 [487.344562] Dynamic subtest vecs0: SUCCESS (0.803s) [487.356628] Starting dynamic subtest: ccs0 [488.190673] Dynamic subtest ccs0: SUCCESS (0.844s) [488.193444] Subtest saturated-hostile: SUCCESS (4.887s) [488.293273] [065/131] (534s left) gem_close_race (multigpu-basic-threads) [488.358435] Starting subtest: multigpu-basic-threads [488.362748] Subtest multigpu-basic-threads: SKIP (0.000s) [488.624369] [066/131] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [488.728641] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [488.732790] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [488.858550] [067/131] (533s left) kms_pm_rpm (i2c) [491.012765] Starting subtest: i2c [496.355652] Subtest i2c: SUCCESS (5.343s) [496.473087] [068/131] (526s left) kms_psr (fbc-pr-sprite-plane-move) [496.584168] Starting subtest: fbc-pr-sprite-plane-move [496.587910] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [496.677712] [069/131] (526s left) gem_mmap_offset (bad-extensions) [496.726416] Starting subtest: bad-extensions [496.728595] Subtest bad-extensions: SUCCESS (0.000s) [496.858051] [070/131] (525s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [496.959055] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [496.963086] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [497.100040] [071/131] (525s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [497.208603] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [497.212818] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [497.327839] [072/131] (525s left) perf_pmu (most-busy-idle-check-all) [497.366459] Starting subtest: most-busy-idle-check-all [497.368516] Starting dynamic subtest: rcs0 [498.902762] Dynamic subtest rcs0: SUCCESS (1.533s) [498.914810] Starting dynamic subtest: bcs0 [500.886653] Dynamic subtest bcs0: SUCCESS (1.981s) [500.898771] Starting dynamic subtest: vcs0 [502.934882] Dynamic subtest vcs0: SUCCESS (2.045s) [502.947329] Starting dynamic subtest: vcs1 [504.918604] Dynamic subtest vcs1: SUCCESS (1.979s) [504.930871] Starting dynamic subtest: vecs0 [506.917751] Dynamic subtest vecs0: SUCCESS (1.980s) [506.930198] Starting dynamic subtest: ccs0 [508.886515] Dynamic subtest ccs0: SUCCESS (1.982s) [508.889349] Subtest most-busy-idle-check-all: SUCCESS (11.519s) [509.037622] [073/131] (513s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [509.435103] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [510.246235] [074/131] (512s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [510.353604] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [510.358248] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [510.483406] [075/131] (512s left) gem_ctx_persistence (engines-cleanup) [510.551890] Starting subtest: engines-cleanup [510.554669] Starting dynamic subtest: rcs0 [510.601580] Dynamic subtest rcs0: SUCCESS (0.050s) [510.612416] Starting dynamic subtest: bcs0 [510.700097] Dynamic subtest bcs0: SUCCESS (0.097s) [510.711707] Starting dynamic subtest: vcs0 [510.725670] Dynamic subtest vcs0: SUCCESS (0.024s) [510.735533] Starting dynamic subtest: vcs1 [510.785207] Dynamic subtest vcs1: SUCCESS (0.059s) [510.794728] Starting dynamic subtest: vecs0 [510.885442] Dynamic subtest vecs0: SUCCESS (0.098s) [510.897233] Starting dynamic subtest: ccs0 [510.951445] Dynamic subtest ccs0: SUCCESS (0.064s) [510.954440] Subtest engines-cleanup: SUCCESS (0.400s) [511.053589] [076/131] (511s left) prime_mmap (test_map_unmap) [511.117018] Starting subtest: test_map_unmap [511.119326] Starting dynamic subtest: test_map_unmap-smem [511.144152] Dynamic subtest test_map_unmap-smem: SUCCESS (0.030s) [511.146532] Subtest test_map_unmap: SUCCESS (0.030s) [511.276935] [077/131] (511s left) gem_userptr_blits (set-cache-level) [511.343969] Starting subtest: set-cache-level [511.347972] Subtest set-cache-level: SKIP (0.000s) [511.515745] [078/131] (511s left) gem_busy (busy) [511.592826] Starting subtest: busy [511.594509] Starting dynamic subtest: all-engines [511.645104] Dynamic subtest all-engines: SUCCESS (0.055s) [511.653963] Starting dynamic subtest: rcs0 [512.860066] Dynamic subtest rcs0: SUCCESS (1.213s) [512.868343] Starting dynamic subtest: bcs0 [512.916968] Dynamic subtest bcs0: SUCCESS (0.055s) [512.925124] Starting dynamic subtest: vcs0 [512.958421] Dynamic subtest vcs0: SUCCESS (0.039s) [512.968616] Starting dynamic subtest: vcs1 [514.906287] Dynamic subtest vcs1: SUCCESS (1.946s) [514.917148] Starting dynamic subtest: vecs0 [516.891356] Dynamic subtest vecs0: SUCCESS (1.983s) [516.902811] Starting dynamic subtest: ccs0 [518.938706] Dynamic subtest ccs0: SUCCESS (2.047s) [518.940734] Subtest busy: SUCCESS (7.346s) [519.316563] [079/131] (503s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [519.419410] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [526.612137] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.196s) [526.772060] [080/131] (496s left) core_auth (basic-auth) [526.837628] Starting subtest: basic-auth [526.839957] Subtest basic-auth: SUCCESS (0.001s) [526.992182] [081/131] (496s left) prime_mmap_coherency (write) [527.058488] Starting subtest: write [532.437369] Subtest write: SUCCESS (5.376s) [532.625341] [082/131] (490s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [532.685514] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [532.689780] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [532.897155] [083/131] (490s left) perf (gen12-invalid-class-instance) [533.048687] Starting subtest: gen12-invalid-class-instance [533.059077] Subtest gen12-invalid-class-instance: SUCCESS (0.010s) [533.099349] [084/131] (490s left) kms_lease (lease-get) [533.208120] Starting subtest: lease-get [533.210466] Starting dynamic subtest: pipe-A-eDP-1 [533.212795] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [533.226768] Starting dynamic subtest: pipe-B-eDP-1 [533.229274] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [533.240182] Starting dynamic subtest: pipe-C-eDP-1 [533.242353] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [533.250619] Starting dynamic subtest: pipe-D-eDP-1 [533.252802] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [533.255019] Subtest lease-get: SUCCESS (0.008s) [533.345910] [085/131] (490s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [533.449786] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [533.453649] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [533.562079] [086/131] (489s left) i915_pm_rpm (system-suspend-devices) [535.079970] Starting subtest: system-suspend-devices [546.490579] Subtest system-suspend-devices: SUCCESS (11.414s) [546.883797] [087/131] (476s left) kms_cursor_edge_walk (128x128-right-edge) [546.993795] Starting subtest: 128x128-right-edge [546.996243] Starting dynamic subtest: pipe-A-eDP-1 [550.403718] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.411s) [550.413830] Starting dynamic subtest: pipe-D-eDP-1 [553.525079] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s) [553.527281] Subtest 128x128-right-edge: SUCCESS (6.533s) [554.358313] [088/131] (469s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [559.409281] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [559.411657] Starting dynamic subtest: pipe-A-eDP-1 [560.189463] Dynamic subtest pipe-A-eDP-1: SKIP (0.775s) [560.199550] Starting dynamic subtest: pipe-B-eDP-1 [561.318690] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s) [561.323051] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.907s) [562.625661] [089/131] (460s left) perf (i915-ref-count) [562.705380] Starting subtest: i915-ref-count [562.733846] Subtest i915-ref-count: SUCCESS (0.025s) [562.789409] [090/131] (460s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [562.895735] Starting subtest: fbc-2p-primscrn-spr-indfb-move [562.899841] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [563.040130] [091/131] (460s left) core_auth (getclient-simple) [563.085466] Starting subtest: getclient-simple [563.108244] Subtest getclient-simple: SUCCESS (0.021s) [563.244839] [092/131] (460s left) i915_pciid [563.419902] [093/131] (460s left) gem_exec_fence (syncobj-timeline-signal) [563.987296] Starting subtest: syncobj-timeline-signal [563.992141] Subtest syncobj-timeline-signal: SUCCESS (0.008s) [565.029320] [094/131] (458s left) kms_flip (bo-too-big) [565.119054] Starting subtest: bo-too-big [565.121290] Starting dynamic subtest: A-eDP1 [566.457789] Dynamic subtest A-eDP1: SUCCESS (1.338s) [566.469894] Starting dynamic subtest: B-eDP1 [567.786428] Dynamic subtest B-eDP1: SUCCESS (1.326s) [567.795612] Starting dynamic subtest: C-eDP1 [569.113449] Dynamic subtest C-eDP1: SUCCESS (1.326s) [569.125445] Starting dynamic subtest: D-eDP1 [570.437458] Dynamic subtest D-eDP1: SUCCESS (1.323s) [570.439715] Subtest bo-too-big: SUCCESS (5.321s) [571.661893] [095/131] (452s left) kms_psr (pr-basic) [571.763559] Starting subtest: pr-basic [571.767667] Subtest pr-basic: SKIP (0.000s) [571.862289] [096/131] (451s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [571.969577] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [571.973805] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [572.084601] [097/131] (451s left) kms_addfb_basic (tile-pitch-mismatch) [572.153099] Starting subtest: tile-pitch-mismatch [572.157478] Subtest tile-pitch-mismatch: SKIP (0.000s) [572.315694] [098/131] (451s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [572.401106] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [572.403359] Starting dynamic subtest: pipe-A-eDP-1 [572.412390] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [572.423592] Starting dynamic subtest: pipe-B-eDP-1 [572.432653] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [572.442248] Starting dynamic subtest: pipe-C-eDP-1 [572.451261] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [572.461203] Starting dynamic subtest: pipe-D-eDP-1 [572.469519] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [572.473612] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s) [574.643833] [099/131] (449s left) gem_exec_reloc (basic-write-cpu-active) [574.715810] Subtest basic-write-cpu-active: SKIP (0.000s) [574.806248] [100/131] (449s left) gem_exec_whisper (basic-queues-forked-all) [574.880309] Starting subtest: basic-queues-forked-all [593.188811] Subtest basic-queues-forked-all: SUCCESS (18.309s) [593.400107] [101/131] (430s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [593.510114] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [593.512341] Starting dynamic subtest: pipe-A-default-mode [594.669611] Dynamic subtest pipe-A-default-mode: SKIP (1.156s) [594.673583] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.158s) [594.860923] [102/131] (429s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [594.965828] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [594.968625] Starting dynamic subtest: pipe-A-default-mode [595.258242] Dynamic subtest pipe-A-default-mode: SKIP (0.292s) [595.262491] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.293s) [596.088038] [103/131] (428s left) prime_mmap (test_dup) [596.154344] Starting subtest: test_dup [596.156562] Starting dynamic subtest: test_dup-smem [596.185436] Dynamic subtest test_dup-smem: SUCCESS (0.031s) [596.187829] Subtest test_dup: SUCCESS (0.032s) [596.285380] [104/131] (427s left) kms_addfb_basic (legacy-format) [596.334475] Starting subtest: legacy-format [596.358182] Subtest legacy-format: SUCCESS (0.024s) [596.540557] [105/131] (427s left) gem_workarounds (suspend-resume-context) [596.610808] Starting subtest: suspend-resume-context [613.116792] Subtest suspend-resume-context: SUCCESS (1.230s) [613.294641] [106/131] (410s left) gem_fence_thrash (bo-write-verify-none) [613.338283] Starting subtest: bo-write-verify-none [613.367864] Subtest bo-write-verify-none: SKIP (0.026s) [613.443509] [107/131] (410s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [618.466207] Starting subtest: psr2-cursor-plane-move-continuous-sf [618.468374] Starting dynamic subtest: pipe-A-eDP-1 [629.579682] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.088s) [629.590250] Starting dynamic subtest: pipe-B-eDP-1 [640.605689] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.015s) [640.607554] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.108s) [641.423687] [108/131] (382s left) kms_rotation_crc (primary-rotation-270) [641.530502] Starting subtest: primary-rotation-270 [641.534936] Subtest primary-rotation-270: SKIP (0.001s) [641.632997] [109/131] (382s left) syncobj_wait (invalid-reset-illegal-handle) [641.688026] Starting subtest: invalid-reset-illegal-handle [641.689862] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [641.811441] [110/131] (382s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [641.869819] Starting subtest: y-tiled-ccs-to-y-tiled [641.874228] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [642.077197] [111/131] (382s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [642.179459] Starting subtest: primary-y-tiled-reflect-x-270 [642.183936] Subtest primary-y-tiled-reflect-x-270: SKIP (0.002s) [642.283135] [112/131] (382s left) gen9_exec_parse (bb-large) [642.358127] Subtest bb-large: SKIP (0.000s) [642.440992] [113/131] (382s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [642.500498] Starting subtest: multi-wait-all-for-submit-signaled [642.502845] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [642.619147] [114/131] (381s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [642.727635] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [642.729925] Starting dynamic subtest: pipe-A [642.848886] Dynamic subtest pipe-A: SKIP (0.118s) [642.859296] Starting dynamic subtest: pipe-B [644.002050] Dynamic subtest pipe-B: SKIP (1.152s) [644.012753] Starting dynamic subtest: pipe-C [645.224659] Dynamic subtest pipe-C: SUCCESS (1.226s) [645.235698] Starting dynamic subtest: pipe-D [646.444472] Dynamic subtest pipe-D: SUCCESS (1.218s) [646.446832] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.717s) [647.655733] [115/131] (376s left) kms_psr (psr2-cursor-render) [647.759828] Starting subtest: psr2-cursor-render [647.762251] Starting dynamic subtest: eDP-1 [649.417207] Dynamic subtest eDP-1: SUCCESS (1.656s) [649.419563] Subtest psr2-cursor-render: SUCCESS (1.657s) [650.272222] [116/131] (374s left) gem_userptr_blits (invalid-null-pointer) [650.343239] Starting subtest: invalid-null-pointer [650.345469] Subtest invalid-null-pointer: SUCCESS (0.001s) [650.502969] [117/131] (374s left) api_intel_allocator (simple-allocator) [650.548069] Starting subtest: simple-allocator [650.550148] Starting dynamic subtest: basic [650.552321] Dynamic subtest basic: SUCCESS (0.003s) [650.561223] Starting dynamic subtest: parallel-one [650.720498] Dynamic subtest parallel-one: SUCCESS (0.168s) [650.732186] Starting dynamic subtest: print [650.734324] Dynamic subtest print: SUCCESS (0.000s) [650.751661] Starting dynamic subtest: reuse [650.753855] Dynamic subtest reuse: SUCCESS (0.000s) [650.762937] Starting dynamic subtest: reserve [650.765153] Dynamic subtest reserve: SUCCESS (0.000s) [650.774062] Starting dynamic subtest: fork-reopen-allocator [650.776321] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s) [650.778602] Subtest simple-allocator: SUCCESS (0.188s) [650.887775] [118/131] (373s left) kms_pipe_stress (stress-xrgb8888-yftiled) [650.990983] Starting subtest: stress-xrgb8888-yftiled [650.995521] Subtest stress-xrgb8888-yftiled: SKIP (0.000s) [651.071541] [119/131] (373s left) kms_flip (wf_vblank-ts-check) [651.180046] Starting subtest: wf_vblank-ts-check [651.182159] Starting dynamic subtest: A-eDP1 [660.059930] Dynamic subtest A-eDP1: SUCCESS (8.876s) [660.071231] Starting dynamic subtest: B-eDP1 [668.993610] Dynamic subtest B-eDP1: SUCCESS (8.928s) [669.003750] Starting dynamic subtest: C-eDP1 [677.921099] Dynamic subtest C-eDP1: SUCCESS (8.921s) [677.932397] Starting dynamic subtest: D-eDP1 [686.882807] Dynamic subtest D-eDP1: SUCCESS (8.930s) [686.886886] Subtest wf_vblank-ts-check: SUCCESS (35.664s) [688.106808] [120/131] (336s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [688.213494] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [688.215942] Starting dynamic subtest: pipe-A-eDP-1 [688.238965] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [688.249119] Starting dynamic subtest: pipe-B-eDP-1 [688.269691] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [688.279498] Starting dynamic subtest: pipe-C-eDP-1 [688.301432] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [688.312496] Starting dynamic subtest: pipe-D-eDP-1 [688.334248] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [688.338308] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [690.394449] [121/131] (334s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [690.456709] Starting subtest: invalid-multi-wait-unsubmitted [690.459000] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [690.595512] [122/131] (334s left) prime_mmap (test_errors) [690.657825] Starting subtest: test_errors [690.659991] Starting dynamic subtest: test_errors-smem [690.750251] Dynamic subtest test_errors-smem: SUCCESS (0.094s) [690.752821] Subtest test_errors: SUCCESS (0.095s) [690.874765] [123/131] (334s left) gem_exec_async (forked-writes) [690.940030] Starting subtest: forked-writes [690.942446] Starting dynamic subtest: rcs0 [690.963667] Dynamic subtest rcs0: SUCCESS (0.023s) [690.973877] Starting dynamic subtest: bcs0 [690.989407] Dynamic subtest bcs0: SUCCESS (0.024s) [690.999878] Starting dynamic subtest: vcs0 [691.009900] Dynamic subtest vcs0: SUCCESS (0.020s) [691.020651] Starting dynamic subtest: vcs1 [691.034509] Dynamic subtest vcs1: SUCCESS (0.023s) [691.044522] Starting dynamic subtest: vecs0 [691.057052] Dynamic subtest vecs0: SUCCESS (0.022s) [691.066750] Starting dynamic subtest: ccs0 [691.078654] Dynamic subtest ccs0: SUCCESS (0.021s) [691.080905] Subtest forked-writes: SUCCESS (0.139s) [691.337816] [124/131] (333s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [691.436905] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [695.961480] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.525s) [697.116871] [125/131] (327s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [697.218424] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [697.220563] Starting dynamic subtest: pipe-A-default-mode [697.531350] Dynamic subtest pipe-A-default-mode: SKIP (0.311s) [697.535924] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.313s) [698.334473] [126/131] (326s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [698.445766] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [707.736952] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.288s) [707.896753] [127/131] (317s left) gem_mmap_gtt (cpuset-basic-small-copy) [707.961629] Subtest cpuset-basic-small-copy: SKIP (0.000s) [708.028863] [128/131] (317s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [713.035631] Starting subtest: psr2-primary-plane-update-sf-dmg-area [713.038039] Starting dynamic subtest: pipe-A-eDP-1 [719.705123] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.673s) [719.715733] Starting dynamic subtest: pipe-B-eDP-1 [726.362589] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.657s) [726.364963] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.335s) [727.233216] [129/131] (298s left) sriov_basic (enable-vfs-bind-unbind-each) [727.307830] Starting subtest: enable-vfs-bind-unbind-each [727.310423] Starting dynamic subtest: numvfs-1 [727.391660] Dynamic subtest numvfs-1: FAIL (0.029s) [727.403104] Starting dynamic subtest: numvfs-2 [727.476340] Dynamic subtest numvfs-2: FAIL (0.005s) [727.488854] Starting dynamic subtest: numvfs-3 [727.562732] Dynamic subtest numvfs-3: FAIL (0.003s) [727.573461] Starting dynamic subtest: numvfs-4 [727.645844] Dynamic subtest numvfs-4: FAIL (0.003s) [727.656741] Starting dynamic subtest: numvfs-5 [727.728880] Dynamic subtest numvfs-5: FAIL (0.003s) [727.739586] Starting dynamic subtest: numvfs-6 [727.811904] Dynamic subtest numvfs-6: FAIL (0.003s) [727.822633] Starting dynamic subtest: numvfs-7 [727.894910] Dynamic subtest numvfs-7: FAIL (0.003s) [727.905487] Starting dynamic subtest: numvfs-random [727.977175] Dynamic subtest numvfs-random: FAIL (0.003s) [727.979485] Subtest enable-vfs-bind-unbind-each: FAIL (0.062s) [728.017514] [130/131] (297s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [728.114468] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [734.924041] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.814s) [735.063803] [131/131] (290s left) gem_exec_schedule (u-fairslice) [735.136846] Starting subtest: u-fairslice [735.139235] Starting dynamic subtest: rcs0 [737.151770] Dynamic subtest rcs0: SUCCESS (2.019s) [737.160531] Starting dynamic subtest: bcs0 [739.167761] Dynamic subtest bcs0: SUCCESS (2.017s) [739.178921] Starting dynamic subtest: vcs0 [741.186864] Dynamic subtest vcs0: SUCCESS (2.017s) [741.197661] Starting dynamic subtest: vcs1 [743.205049] Dynamic subtest vcs1: SUCCESS (2.018s) [743.214428] Starting dynamic subtest: vecs0 [745.226112] Dynamic subtest vecs0: SUCCESS (2.021s) [745.236690] Starting dynamic subtest: ccs0 [747.243273] Dynamic subtest ccs0: SUCCESS (2.017s) [747.245669] Subtest u-fairslice: SUCCESS (12.114s) [747.564876] 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.