[55.758438] Initializing watchdogs [55.758484] /dev/watchdog0 [55.773701] [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] [55.778020] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.780207] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.783704] [001/156] (960s left) gem_mmap (basic) [55.866724] Subtest basic: SKIP (0.000s) [55.922502] [002/156] (960s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [56.028894] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt [56.033295] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [56.130108] [003/156] (960s left) kms_frontbuffer_tracking (psrhdr-modesetfrombusy) [56.239198] Starting subtest: psrhdr-modesetfrombusy [56.243107] Subtest psrhdr-modesetfrombusy: SKIP (0.000s) [56.327328] [004/156] (960s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [56.413671] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [56.416143] Starting dynamic subtest: pipe-A-default-mode [57.575917] Dynamic subtest pipe-A-default-mode: SKIP (1.145s) [57.580479] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.146s) [57.754202] [005/156] (958s left) gem_exec_fence (syncobj-timeline-signal) [58.313069] Starting subtest: syncobj-timeline-signal [58.319274] Subtest syncobj-timeline-signal: SUCCESS (0.007s) [59.379976] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true [59.384121] [006/156] (957s left) syncobj_timeline (etime-single-wait-all-submitted) [59.436240] Starting subtest: etime-single-wait-all-submitted [59.543670] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s) [59.617255] [007/156] (956s left) gem_ctx_persistence (processes) [59.676840] Starting subtest: processes [61.329049] Subtest processes: SUCCESS (1.639s) [61.420857] [008/156] (955s left) kms_flip (flip-vs-dpms-off-vs-modeset) [61.521328] Starting subtest: flip-vs-dpms-off-vs-modeset [61.523814] Starting dynamic subtest: A-eDP1 [65.878687] Dynamic subtest A-eDP1: SUCCESS (4.328s) [65.888276] Starting dynamic subtest: B-eDP1 [68.687674] Dynamic subtest B-eDP1: SUCCESS (2.800s) [68.696815] Starting dynamic subtest: C-eDP1 [71.921855] Dynamic subtest C-eDP1: SUCCESS (3.219s) [71.933603] Starting dynamic subtest: D-eDP1 [75.128633] Dynamic subtest D-eDP1: SUCCESS (3.206s) [75.130916] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.559s) [75.933603] [009/156] (940s left) gem_exec_params (secure-non-root) [75.994618] Starting subtest: secure-non-root [75.999263] Subtest secure-non-root: SKIP (0.000s) [76.103738] [010/156] (940s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-pwrite) [76.209762] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-pwrite [76.214675] Subtest hdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [76.304109] [011/156] (940s left) gem_busy (busy) [76.360902] Starting subtest: busy [76.363366] Starting dynamic subtest: all-engines [76.424968] Dynamic subtest all-engines: SUCCESS (0.064s) [76.433218] Starting dynamic subtest: rcs0 [78.283978] Dynamic subtest rcs0: SUCCESS (1.856s) [78.291649] Starting dynamic subtest: bcs0 [78.330594] Dynamic subtest bcs0: SUCCESS (0.047s) [78.343071] Starting dynamic subtest: vcs0 [78.371951] Dynamic subtest vcs0: SUCCESS (0.039s) [78.381032] Starting dynamic subtest: vcs1 [80.264321] Dynamic subtest vcs1: SUCCESS (1.890s) [80.272826] Starting dynamic subtest: vecs0 [82.364906] Dynamic subtest vecs0: SUCCESS (2.043s) [82.375123] Starting dynamic subtest: ccs0 [84.293868] Dynamic subtest ccs0: SUCCESS (1.983s) [84.295902] Subtest busy: SUCCESS (7.927s) [84.654988] [012/156] (932s left) kms_big_fb (x-tiled-addfb-size-overflow) [84.767069] Starting subtest: x-tiled-addfb-size-overflow [84.769096] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s) [84.873269] [013/156] (931s left) kms_psr2_su (frontbuffer-xrgb8888) [84.927963] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [84.986175] [014/156] (931s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [85.048858] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [85.051179] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s) [85.145482] [015/156] (931s left) gem_exec_schedule (preempt-hang) [85.320838] Starting subtest: preempt-hang [85.323397] Starting dynamic subtest: rcs0 [85.543857] Dynamic subtest rcs0: SUCCESS (0.224s) [85.554950] Starting dynamic subtest: bcs0 [85.763155] Dynamic subtest bcs0: SUCCESS (0.221s) [85.774487] Starting dynamic subtest: vcs0 [85.977161] Dynamic subtest vcs0: SUCCESS (0.212s) [85.989043] Starting dynamic subtest: vcs1 [86.193820] Dynamic subtest vcs1: SUCCESS (0.217s) [86.202402] Starting dynamic subtest: vecs0 [86.419533] Dynamic subtest vecs0: SUCCESS (0.225s) [86.428834] Starting dynamic subtest: ccs0 [86.647962] Dynamic subtest ccs0: SUCCESS (0.228s) [86.650341] Subtest preempt-hang: SUCCESS (1.327s) [87.404565] [016/156] (929s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [87.537133] Starting subtest: cursorA-vs-flipA-toggle [98.675911] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.134s) [99.475643] [017/156] (917s left) gem_mmap_wc (set-cache-level) [99.537702] Subtest set-cache-level: SKIP (0.000s) [99.591229] [018/156] (917s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [99.701157] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [99.705153] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [99.798378] [019/156] (917s left) kms_chamelium_edid (hdmi-mode-timings) [100.200795] Subtest hdmi-mode-timings: SKIP (0.000s) [100.997627] [020/156] (916s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [101.091868] Starting subtest: pr-overlay-plane-move-continuous-sf [101.096328] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [101.157452] [021/156] (915s left) prime_mmap (test_userptr) [101.206606] Starting subtest: test_userptr [101.208876] Starting dynamic subtest: test_userptr-smem [101.210792] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [101.212652] Subtest test_userptr: SUCCESS (0.001s) [101.284983] [022/156] (915s left) kms_psr (fbc-psr-sprite-mmap-gtt) [101.369311] Starting subtest: fbc-psr-sprite-mmap-gtt [101.371247] Starting dynamic subtest: eDP-1 [101.375341] Dynamic subtest eDP-1: SKIP (0.000s) [101.379432] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s) [101.440413] [023/156] (915s left) gem_exec_await (wide-contexts) [101.624798] Starting subtest: wide-contexts [125.130501] Subtest wide-contexts: SUCCESS (23.490s) [125.312220] [024/156] (891s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible) [125.408949] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s) [125.487788] [025/156] (891s left) kms_selftest (drm_format) [125.535846] Starting subtest: drm_format [125.548095] Starting dynamic subtest: drm_test_format_block_width_invalid [125.652122] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.102s) [125.662229] Starting dynamic subtest: drm_test_format_block_width_one_plane [125.756682] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.105s) [125.767192] Starting dynamic subtest: drm_test_format_block_width_two_plane [125.855628] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.097s) [125.866650] Starting dynamic subtest: drm_test_format_block_width_three_plane [125.957068] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.101s) [125.967267] Starting dynamic subtest: drm_test_format_block_width_tiled [126.048957] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.091s) [126.058950] Starting dynamic subtest: drm_test_format_block_height_invalid [126.140166] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.092s) [126.149642] Starting dynamic subtest: drm_test_format_block_height_one_plane [126.240461] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.100s) [126.250133] Starting dynamic subtest: drm_test_format_block_height_two_plane [126.347186] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.106s) [126.354608] Starting dynamic subtest: drm_test_format_block_height_three_plane [126.461109] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.112s) [126.468758] Starting dynamic subtest: drm_test_format_block_height_tiled [126.553528] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.093s) [126.563551] Starting dynamic subtest: drm_test_format_min_pitch_invalid [126.674464] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.119s) [126.682430] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp [126.770116] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.097s) [126.778175] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp [126.866478] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.093s) [126.876392] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp [126.960515] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.093s) [126.970345] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp [127.065626] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.105s) [127.075568] Starting dynamic subtest: drm_test_format_min_pitch_two_plane [127.179407] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.113s) [127.189222] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp [127.287675] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.107s) [127.297267] Starting dynamic subtest: drm_test_format_min_pitch_tiled [127.391431] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.103s) [127.393416] Subtest drm_format: SUCCESS (1.855s) [127.551222] [026/156] (889s left) kms_addfb_basic (basic-y-tiled-legacy) [127.613916] Starting subtest: basic-y-tiled-legacy [127.618639] Subtest basic-y-tiled-legacy: SKIP (0.000s) [127.766220] [027/156] (889s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [127.832645] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [127.837410] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [128.029649] [028/156] (889s left) gem_exec_params (mmapped) [128.085770] Starting subtest: mmapped [128.090917] Subtest mmapped: SUCCESS (0.003s) [128.220595] [029/156] (889s left) kms_lease (lease-unleased-crtc) [128.310465] Starting subtest: lease-unleased-crtc [128.312783] Starting dynamic subtest: pipe-A-eDP-1 [128.599823] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [128.611897] Starting dynamic subtest: pipe-B-eDP-1 [129.358888] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s) [129.367831] Starting dynamic subtest: pipe-C-eDP-1 [129.370177] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s) [129.378679] Starting dynamic subtest: pipe-D-eDP-1 [129.380806] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s) [129.382946] Subtest lease-unleased-crtc: SUCCESS (1.065s) [129.737497] [030/156] (887s left) kms_big_fb (4-tiled-16bpp-rotate-90) [129.843836] Starting subtest: 4-tiled-16bpp-rotate-90 [129.864125] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s) [129.987680] [031/156] (887s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [130.079391] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [130.081544] Starting dynamic subtest: pipe-A-eDP-1 [130.105888] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [130.115819] Starting dynamic subtest: pipe-B-eDP-1 [130.138247] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [130.146160] Starting dynamic subtest: pipe-C-eDP-1 [130.168619] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [130.176359] Starting dynamic subtest: pipe-D-eDP-1 [130.199422] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [130.203587] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [132.398224] [032/156] (885s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [132.502869] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [132.507436] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [132.592717] [033/156] (884s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [132.685206] Starting subtest: fbc-indfb-scaledprimary [135.576567] Subtest fbc-indfb-scaledprimary: SUCCESS (2.897s) [136.715027] [034/156] (880s left) gem_exec_balancer (indices) [136.781659] Starting subtest: indices [139.232220] Subtest indices: SUCCESS (2.450s) [139.552745] [035/156] (878s left) kms_frontbuffer_tracking (fbc-tiling-4) [139.649071] Starting subtest: fbc-tiling-4 [143.809564] Subtest fbc-tiling-4: SUCCESS (4.167s) [145.032401] [036/156] (872s left) kms_getfb (getfb-handle-not-fb) [145.127832] Starting subtest: getfb-handle-not-fb [145.130158] Subtest getfb-handle-not-fb: SUCCESS (0.000s) [145.207958] [037/156] (872s left) kms_frontbuffer_tracking (fbc-stridechange) [145.301118] Starting subtest: fbc-stridechange [148.589646] Subtest fbc-stridechange: SUCCESS (3.294s) [149.735869] [038/156] (867s left) dumb_buffer (invalid-bpp) [149.783020] Starting subtest: invalid-bpp [149.784993] Subtest invalid-bpp: SUCCESS (0.000s) [149.884123] [039/156] (867s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render) [149.988585] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render [149.992774] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [150.097422] [040/156] (867s left) kms_big_fb (y-tiled-64bpp-rotate-90) [150.194216] Starting subtest: y-tiled-64bpp-rotate-90 [150.198640] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [150.299147] [041/156] (867s left) kms_atomic (plane-primary-legacy) [150.386565] Starting subtest: plane-primary-legacy [150.388904] Starting dynamic subtest: pipe-A-eDP-1 [150.844733] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s) [150.847045] Subtest plane-primary-legacy: SUCCESS (0.459s) [151.644749] [042/156] (866s left) kms_content_protection (lic-type-1) [151.790976] Starting subtest: lic-type-1 [151.795663] Subtest lic-type-1: SKIP (0.000s) [151.907971] [043/156] (866s left) drm_read (empty-nonblock) [152.043996] Starting subtest: empty-nonblock [152.046423] Subtest empty-nonblock: SUCCESS (0.000s) [152.158590] [044/156] (865s left) kms_psr (fbc-psr2-suspend) [152.255403] Starting subtest: fbc-psr2-suspend [152.257603] Starting dynamic subtest: eDP-1 [152.261816] Dynamic subtest eDP-1: SKIP (0.000s) [152.266134] Subtest fbc-psr2-suspend: SKIP (0.001s) [152.331838] [045/156] (865s left) kms_rotation_crc (primary-rotation-180) [152.422271] Starting subtest: primary-rotation-180 [159.483252] Subtest primary-rotation-180: SUCCESS (7.063s) [160.708665] [046/156] (857s left) i915_suspend (forcewake) [160.759069] Starting subtest: forcewake [192.851005] Subtest forcewake: SUCCESS (3.125s) [192.935715] [047/156] (825s left) gem_partial_pwrite_pread (write-snoop) [193.004124] Subtest write-snoop: SKIP (0.000s) [193.105896] [048/156] (825s left) gem_ctx_sseu (engines) [193.164215] Subtest engines: SKIP (0.000s) [193.247758] [049/156] (824s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [193.349611] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [193.353719] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [193.453770] [050/156] (824s left) gem_exec_schedule (preempt-self) [193.525167] Starting subtest: preempt-self [193.527376] Starting dynamic subtest: rcs0 [193.538901] Dynamic subtest rcs0: SUCCESS (0.020s) [193.548699] Starting dynamic subtest: bcs0 [193.558649] Dynamic subtest bcs0: SUCCESS (0.019s) [193.567751] Starting dynamic subtest: vcs0 [193.577103] Dynamic subtest vcs0: SUCCESS (0.017s) [193.586640] Starting dynamic subtest: vcs1 [193.596296] Dynamic subtest vcs1: SUCCESS (0.019s) [193.606214] Starting dynamic subtest: vecs0 [193.617033] Dynamic subtest vecs0: SUCCESS (0.020s) [193.626469] Starting dynamic subtest: ccs0 [193.635211] Dynamic subtest ccs0: SUCCESS (0.017s) [193.637583] Subtest preempt-self: SUCCESS (0.115s) [195.345808] [051/156] (822s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [195.437516] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc [195.441783] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [195.549347] [052/156] (822s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [195.654764] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [195.659274] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [195.765258] [053/156] (822s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite) [195.874564] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite [195.878919] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [196.006572] [054/156] (822s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-pwrite) [196.111088] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-pwrite [196.115070] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [196.214128] [055/156] (822s left) kms_dsc (dsc-fractional-bpp-with-bpc) [196.313118] Starting subtest: dsc-fractional-bpp-with-bpc [196.339417] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s) [196.398185] [056/156] (822s left) kms_pm_dc (dc5-dpms) [197.498992] Starting subtest: dc5-dpms [199.606281] Subtest dc5-dpms: SUCCESS (2.078s) [199.684303] [057/156] (818s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-onoff) [199.781680] Starting subtest: fbchdr-1p-primscrn-cur-indfb-onoff [199.786092] Subtest fbchdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [199.868683] [058/156] (818s left) kms_color (ctm-max) [199.953516] Starting subtest: ctm-max [199.955631] Starting dynamic subtest: pipe-A-eDP-1 [200.670183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s) [200.680618] Starting dynamic subtest: pipe-B-eDP-1 [202.126304] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.439s) [202.135483] Starting dynamic subtest: pipe-C-eDP-1 [203.527770] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s) [203.537163] Starting dynamic subtest: pipe-D-eDP-1 [204.863390] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s) [204.865913] Subtest ctm-max: SUCCESS (4.869s) [205.676955] [059/156] (812s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait) [207.408415] Starting subtest: modeset-non-lpsp-stress-no-wait [207.454075] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.045s) [207.922600] [060/156] (810s left) gem_mmap_gtt (basic-small-bo-tiledx) [207.981883] Subtest basic-small-bo-tiledX: SKIP (0.000s) [208.056155] [061/156] (810s left) syncobj_timeline (single-wait-available-submitted) [208.120846] Starting subtest: single-wait-available-submitted [208.123241] Subtest single-wait-available-submitted: SUCCESS (0.000s) [208.262827] [062/156] (810s left) gem_exec_reloc (basic-cpu-active) [208.325585] Subtest basic-cpu-active: SKIP (0.000s) [208.413978] [063/156] (810s left) kms_invalid_mode (bad-htotal) [208.511610] Starting subtest: bad-htotal [208.513748] Starting dynamic subtest: pipe-A-eDP-1 [208.796334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [208.805621] Starting dynamic subtest: pipe-B-eDP-1 [208.807530] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [208.816229] Starting dynamic subtest: pipe-C-eDP-1 [208.818098] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [208.827080] Starting dynamic subtest: pipe-D-eDP-1 [208.829207] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [208.831405] Subtest bad-htotal: SUCCESS (0.291s) [209.661788] [064/156] (809s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [209.756602] Starting subtest: primary-yf-tiled-reflect-x-180 [209.816311] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [209.918665] [065/156] (808s left) kms_flip (flip-vs-absolute-wf_vblank) [210.015864] Starting subtest: flip-vs-absolute-wf_vblank [210.018212] Starting dynamic subtest: A-eDP1 [218.938026] Dynamic subtest A-eDP1: SUCCESS (8.902s) [218.950415] Starting dynamic subtest: B-eDP1 [227.877598] Dynamic subtest B-eDP1: SUCCESS (8.934s) [227.888918] Starting dynamic subtest: C-eDP1 [236.846114] Dynamic subtest C-eDP1: SUCCESS (8.919s) [236.858652] Starting dynamic subtest: D-eDP1 [245.734404] Dynamic subtest D-eDP1: SUCCESS (8.930s) [245.736732] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.693s) [246.965659] [066/156] (771s left) kms_chamelium_hpd (hdmi-hpd) [247.355399] Subtest hdmi-hpd: SKIP (0.000s) [248.172152] [067/156] (770s left) kms_plane_multiple (tiling-x) [248.273690] Starting subtest: tiling-x [248.276047] Starting dynamic subtest: pipe-A-eDP-1 [252.143934] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.868s) [252.153547] Starting dynamic subtest: pipe-B-eDP-1 [256.676869] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.530s) [256.686998] Starting dynamic subtest: pipe-C-eDP-1 [261.038747] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.361s) [261.049623] Starting dynamic subtest: pipe-D-eDP-1 [265.478226] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.437s) [265.481134] Subtest tiling-x: SUCCESS (17.200s) [266.290048] [068/156] (752s left) kms_flip (2x-blocking-absolute-wf_vblank) [266.392837] Starting subtest: 2x-blocking-absolute-wf_vblank [266.400922] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s) [266.482890] [069/156] (752s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [266.577507] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc [266.579725] Starting dynamic subtest: pipe-A-eDP-1 [266.602034] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [266.616163] Starting dynamic subtest: pipe-B-eDP-1 [266.638506] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [266.649507] Starting dynamic subtest: pipe-C-eDP-1 [266.671334] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [266.680688] Starting dynamic subtest: pipe-D-eDP-1 [266.702623] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [266.706683] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [268.852102] [070/156] (750s left) kms_atomic_interruptible (legacy-cursor) [268.947729] Starting subtest: legacy-cursor [268.950047] Starting dynamic subtest: pipe-A-eDP-1 [276.373998] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.420s) [276.376238] Subtest legacy-cursor: SUCCESS (7.422s) [277.229089] [071/156] (741s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [277.314487] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [277.316731] Starting dynamic subtest: pipe-A-eDP-1 [277.339579] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [277.349866] Starting dynamic subtest: pipe-B-eDP-1 [277.371683] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [277.380952] Starting dynamic subtest: pipe-C-eDP-1 [277.402858] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [277.411976] Starting dynamic subtest: pipe-D-eDP-1 [277.434626] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [277.438649] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s) [279.606102] [072/156] (739s left) gem_lmem_swapping (verify-random) [279.654071] Subtest verify-random: SKIP (0.000s) [279.696796] [073/156] (739s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [279.803824] Starting subtest: fbc-rgb565-draw-blt [284.000197] Subtest fbc-rgb565-draw-blt: SUCCESS (4.201s) [285.200608] [074/156] (734s left) perf (sysctl-defaults) [285.287952] Starting subtest: sysctl-defaults [285.290348] Subtest sysctl-defaults: SUCCESS (0.000s) [285.377426] [075/156] (733s left) perf_pmu (busy-idle) [285.418051] Starting subtest: busy-idle [285.420523] Starting dynamic subtest: rcs0 [286.100712] Dynamic subtest rcs0: SUCCESS (0.683s) [286.114103] Starting dynamic subtest: bcs0 [286.766740] Dynamic subtest bcs0: SUCCESS (0.664s) [286.779736] Starting dynamic subtest: vcs0 [288.295395] Dynamic subtest vcs0: SUCCESS (1.525s) [288.308190] Starting dynamic subtest: vcs1 [290.279995] Dynamic subtest vcs1: SUCCESS (1.982s) [290.292666] Starting dynamic subtest: vecs0 [292.262896] Dynamic subtest vecs0: SUCCESS (1.981s) [292.274750] Starting dynamic subtest: ccs0 [292.940682] Dynamic subtest ccs0: SUCCESS (0.677s) [292.943187] Subtest busy-idle: SUCCESS (7.526s) [293.071139] [076/156] (726s left) gen9_exec_parse (bb-start-cmd) [293.139570] Subtest bb-start-cmd: SKIP (0.000s) [293.224024] [077/156] (726s left) kms_pipe_crc_basic (suspend-read-crc) [293.329233] Starting subtest: suspend-read-crc [293.331651] Starting dynamic subtest: pipe-A-eDP-1 [310.785533] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.528s) [310.796639] Starting dynamic subtest: pipe-B-eDP-1 [328.814373] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.104s) [328.824899] Starting dynamic subtest: pipe-C-eDP-1 [346.775473] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.146s) [346.786132] Starting dynamic subtest: pipe-D-eDP-1 [364.762725] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.050s) [364.765224] Subtest suspend-read-crc: SUCCESS (11.836s) [365.615153] [078/156] (653s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [365.719168] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [372.788084] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.972s) [372.939837] [079/156] (646s left) kms_psr (psr2-basic) [373.032423] Starting subtest: psr2-basic [373.034711] Starting dynamic subtest: eDP-1 [374.631934] Dynamic subtest eDP-1: SUCCESS (1.586s) [374.634333] Subtest psr2-basic: SUCCESS (1.587s) [375.443828] [080/156] (644s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [375.549972] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [375.554091] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [375.657970] [081/156] (643s left) kms_dp_aux_dev (basic) [375.712768] Starting subtest: basic [375.934453] Subtest basic: SUCCESS (0.220s) [376.011206] [082/156] (643s left) kms_frontbuffer_tracking (psr-2p-rte) [376.110721] Starting subtest: psr-2p-rte [376.115071] Subtest psr-2p-rte: SKIP (0.000s) [376.217092] [083/156] (643s left) gem_userptr_blits (probe) [376.288802] Starting subtest: probe [376.365317] Subtest probe: SUCCESS (0.076s) [376.478931] [084/156] (643s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt) [376.573850] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt [376.578000] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [376.667157] [085/156] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [376.758327] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [376.762777] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [376.852801] [086/156] (642s left) api_intel_allocator (fork-simple-stress) [376.898885] Starting subtest: fork-simple-stress [382.373993] Subtest fork-simple-stress: SUCCESS (5.399s) [382.448917] [087/156] (637s left) gem_ctx_param (invalid-get-no-zeromap) [382.519126] Starting subtest: invalid-get-no-zeromap [382.521627] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [382.648467] [088/156] (637s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite) [382.775733] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite [382.780035] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [382.891658] [089/156] (636s left) kms_cursor_crc (cursor-random-32x32) [383.044645] Starting subtest: cursor-random-32x32 [383.090006] Subtest cursor-random-32x32: SKIP (0.043s) [383.399210] [090/156] (636s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc) [383.523179] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc [383.526616] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [383.618636] [091/156] (636s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen) [383.716054] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen [383.719462] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [383.815191] [092/156] (636s left) gem_create (hog-create) [383.888834] Starting subtest: hog-create [383.890772] Starting dynamic subtest: smem0 [417.647877] Dynamic subtest smem0: SUCCESS (33.745s) [417.650449] Subtest hog-create: SUCCESS (33.747s) [417.832495] [093/156] (602s left) kms_big_fb (x-tiled-8bpp-rotate-0) [417.944211] Starting subtest: x-tiled-8bpp-rotate-0 [419.113066] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.169s) [419.248797] [094/156] (600s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt) [419.351797] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt [419.355419] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [419.452049] [095/156] (600s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [419.577764] Starting subtest: short-flip-before-cursor-toggle [420.495031] Subtest short-flip-before-cursor-toggle: SUCCESS (0.914s) [421.316465] [096/156] (598s left) syncobj_timeline (invalid-signal-zero-handles) [421.372248] Starting subtest: invalid-signal-zero-handles [421.374709] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [421.466144] [097/156] (598s left) kms_sequence (get-idle) [421.551944] Starting subtest: get-idle [421.554293] Starting dynamic subtest: pipe-A-eDP-1 [423.368011] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s) [423.378731] Starting dynamic subtest: pipe-B-eDP-1 [425.895714] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.526s) [425.907425] Starting dynamic subtest: pipe-C-eDP-1 [428.365691] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.468s) [428.376043] Starting dynamic subtest: pipe-D-eDP-1 [430.867388] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.500s) [430.869379] Subtest get-idle: SUCCESS (9.311s) [431.671070] [098/156] (588s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [431.780013] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [431.784340] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [431.882752] [099/156] (588s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [431.983761] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [431.987977] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s) [432.058255] [100/156] (588s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [432.160457] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [432.164844] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [432.253325] [101/156] (588s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [432.349172] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [432.353358] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [432.455516] [102/156] (587s left) kms_getfb (getfb2-into-addfb2) [432.545542] Starting subtest: getfb2-into-addfb2 [432.547801] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [432.645523] [103/156] (587s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render) [432.740940] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render [432.744454] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [432.837726] [104/156] (587s left) i915_pm_rpm (system-suspend-devices) [434.761303] Starting subtest: system-suspend-devices [442.435206] Subtest system-suspend-devices: SUCCESS (7.674s) [442.821132] [105/156] (577s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc) [442.919955] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc [449.540045] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.625s) [449.669554] [106/156] (570s left) gem_pread (bench) [449.730960] Subtest bench: SKIP (0.000s) [449.792092] [107/156] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render) [449.894587] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render [456.821169] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.932s) [456.958202] [108/156] (563s left) gem_lmem_evict (dontneed-evict-race) [456.995440] Subtest dontneed-evict-race: SKIP (0.000s) [457.036593] [109/156] (563s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [457.153147] Starting subtest: verify-pxp-stale-buf-optout-execution [458.212416] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.060s) [458.337617] [110/156] (562s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite) [458.445857] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite [458.450160] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [458.557268] [111/156] (562s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [458.652758] Starting subtest: bad-pixel-format-yf-tiled-ccs [458.654981] Starting dynamic subtest: pipe-A-eDP-1 [458.677704] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [458.690841] Starting dynamic subtest: pipe-B-eDP-1 [458.712344] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [458.721782] Starting dynamic subtest: pipe-C-eDP-1 [458.744047] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [458.753683] Starting dynamic subtest: pipe-D-eDP-1 [458.775627] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [458.779658] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.006s) [460.927659] [112/156] (559s left) gem_exec_whisper (basic-contexts-priority-all) [460.985326] Starting subtest: basic-contexts-priority-all [483.847447] Subtest basic-contexts-priority-all: SUCCESS (22.856s) [484.031392] [113/156] (536s left) gem_exec_fence (basic-await) [484.218272] Starting subtest: basic-await [484.220859] Starting dynamic subtest: rcs0 [484.297847] Dynamic subtest rcs0: SUCCESS (0.079s) [484.311685] Starting dynamic subtest: bcs0 [484.370912] Dynamic subtest bcs0: SUCCESS (0.072s) [484.384511] Starting dynamic subtest: vcs0 [484.445989] Dynamic subtest vcs0: SUCCESS (0.073s) [484.458535] Starting dynamic subtest: vcs1 [484.525653] Dynamic subtest vcs1: SUCCESS (0.078s) [484.538487] Starting dynamic subtest: vecs0 [484.599626] Dynamic subtest vecs0: SUCCESS (0.073s) [484.614002] Starting dynamic subtest: ccs0 [484.673591] Dynamic subtest ccs0: SUCCESS (0.072s) [484.676584] Subtest basic-await: SUCCESS (0.456s) [486.698372] [114/156] (534s left) kms_psr (psr2-suspend) [486.794531] Starting subtest: psr2-suspend [486.796761] Starting dynamic subtest: eDP-1 [504.300457] Dynamic subtest eDP-1: SUCCESS (2.942s) [504.303468] Subtest psr2-suspend: SUCCESS (2.943s) [505.207844] [115/156] (515s left) kms_cursor_crc (cursor-random-128x128) [505.425257] Starting subtest: cursor-random-128x128 [505.430924] Starting dynamic subtest: pipe-A-eDP-1 [508.888235] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.392s) [508.920665] Starting dynamic subtest: pipe-D-eDP-1 [512.933900] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.976s) [512.936533] Subtest cursor-random-128x128: SUCCESS (7.393s) [513.799356] [116/156] (507s left) core_auth (getclient-simple) [513.837227] Starting subtest: getclient-simple [513.858227] Subtest getclient-simple: SUCCESS (0.018s) [513.980325] [117/156] (507s left) syncobj_wait (single-wait-for-submit-unsubmitted) [514.031122] Starting subtest: single-wait-for-submit-unsubmitted [514.131256] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.100s) [514.210371] [118/156] (506s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [514.306076] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [514.311212] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [514.391038] [119/156] (506s left) perf_pmu (most-busy-check-all) [514.434971] Starting subtest: most-busy-check-all [514.437613] Starting dynamic subtest: rcs0 [516.223825] Dynamic subtest rcs0: SUCCESS (1.778s) [516.236316] Starting dynamic subtest: bcs0 [516.846878] Dynamic subtest bcs0: FAIL (0.537s) [516.857370] Starting dynamic subtest: vcs0 [518.208753] Dynamic subtest vcs0: SUCCESS (1.433s) [518.221994] Starting dynamic subtest: vcs1 [520.191601] Dynamic subtest vcs1: SUCCESS (1.971s) [520.205298] Starting dynamic subtest: vecs0 [522.177423] Dynamic subtest vecs0: SUCCESS (1.975s) [522.192278] Starting dynamic subtest: ccs0 [524.224968] Dynamic subtest ccs0: SUCCESS (2.039s) [524.227775] Subtest most-busy-check-all: FAIL (9.750s) [524.326976] [120/156] (496s left) gem_exec_reloc (basic-wc-gtt-noreloc) [524.389156] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [524.458733] [121/156] (496s left) sysfs_timeslice_duration (timeout) [524.523325] Starting subtest: timeout [524.526020] Starting dynamic subtest: vecs0 [534.205076] Dynamic subtest vecs0: SUCCESS (9.663s) [534.216674] Starting dynamic subtest: ccs0 [535.374119] Dynamic subtest ccs0: SUCCESS (1.167s) [535.384841] Starting dynamic subtest: vcs0 [545.213778] Dynamic subtest vcs0: SUCCESS (9.834s) [545.224955] Starting dynamic subtest: bcs0 [545.786148] Dynamic subtest bcs0: SUCCESS (0.571s) [545.797183] Starting dynamic subtest: rcs0 [546.958725] Dynamic subtest rcs0: SUCCESS (1.171s) [546.969651] Starting dynamic subtest: vcs1 [556.224403] Dynamic subtest vcs1: SUCCESS (9.262s) [556.227642] Subtest timeout: SUCCESS (31.680s) [556.305114] [122/156] (464s left) syncobj_wait (invalid-signal-bad-pad) [556.365217] Starting subtest: invalid-signal-bad-pad [556.368108] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [556.463479] [123/156] (464s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier) [556.554934] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier [556.583589] Starting dynamic subtest: pipe-A-plane-0 [556.882914] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s) [556.894499] Starting dynamic subtest: pipe-A-plane-3 [557.116646] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s) [557.127262] Starting dynamic subtest: pipe-A-plane-5 [557.132104] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [558.242139] Starting dynamic subtest: pipe-B-plane-0 [558.539162] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s) [558.552707] Starting dynamic subtest: pipe-B-plane-3 [558.771943] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s) [558.785799] Starting dynamic subtest: pipe-B-plane-5 [558.791010] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [559.082731] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.524s) [559.907104] [124/156] (461s left) vgem_basic (dmabuf-mmap) [559.957985] Starting subtest: dmabuf-mmap [560.011632] Subtest dmabuf-mmap: SUCCESS (0.055s) [560.075589] [125/156] (461s left) i915_fb_tiling (basic-x-tiling) [560.140273] Subtest basic-x-tiling: SKIP (0.000s) [560.200393] [126/156] (461s left) kms_cursor_edge_walk (64x64-top-edge) [560.288305] Starting subtest: 64x64-top-edge [560.290636] Starting dynamic subtest: pipe-A-eDP-1 [563.769173] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.480s) [563.782471] Starting dynamic subtest: pipe-D-eDP-1 [566.998765] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.228s) [567.001528] Subtest 64x64-top-edge: SUCCESS (6.710s) [567.807875] [127/156] (453s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [567.908013] Starting subtest: fbcpsr-rgb565-draw-render [574.941153] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.037s) [575.090522] [128/156] (446s left) gem_mmap_offset (bad-flags) [575.142261] Starting subtest: bad-flags [575.145083] Subtest bad-flags: SUCCESS (0.000s) [575.251550] [129/156] (446s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs) [575.343621] Starting subtest: missing-ccs-buffer-yf-tiled-ccs [575.346164] Starting dynamic subtest: pipe-A-eDP-1 [575.372242] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [575.384145] Starting dynamic subtest: pipe-B-eDP-1 [575.409253] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [575.419819] Starting dynamic subtest: pipe-C-eDP-1 [575.445350] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [575.455791] Starting dynamic subtest: pipe-D-eDP-1 [575.481456] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [575.486129] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s) [577.599586] [130/156] (444s left) kms_vrr (negative-basic) [577.700501] Starting subtest: negative-basic [577.708545] Starting dynamic subtest: pipe-A-eDP-1 [583.944820] Dynamic subtest pipe-A-eDP-1: FAIL (5.656s) [583.946945] Subtest negative-basic: FAIL (5.965s) [584.541472] [131/156] (437s left) prime_self_import (basic-with_fd_dup) [584.571069] Starting subtest: basic-with_fd_dup [584.589037] Subtest basic-with_fd_dup: SUCCESS (0.019s) [584.689403] [132/156] (437s left) gem_spin_batch (spin-each) [584.746958] Starting subtest: spin-each [588.018931] Subtest spin-each: SUCCESS (3.260s) [588.308481] [133/156] (433s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc) [588.402916] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc [588.407852] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [588.480422] [134/156] (433s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc) [588.576224] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc [588.581024] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [588.674217] [135/156] (433s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [588.772010] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [588.777044] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [588.869582] [136/156] (433s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [588.923510] Starting subtest: etime-multi-wait-available-unsubmitted [589.027453] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.105s) [589.109989] [137/156] (432s left) gem_mmap_gtt (basic-write-gtt) [589.164841] Subtest basic-write-gtt: SKIP (0.000s) [589.229412] [138/156] (432s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt) [589.325781] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt [589.330758] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [589.415692] [139/156] (432s left) gen3_render_tiledy_blits [589.541063] [140/156] (432s left) syncobj_wait (wait-all-interrupted) [589.587718] Starting subtest: wait-all-interrupted [589.692475] Subtest wait-all-interrupted: SUCCESS (0.106s) [589.783285] [141/156] (432s left) prime_vgem (busy) [589.853124] Starting subtest: busy [589.856151] Starting dynamic subtest: rcs0 [589.892992] Dynamic subtest rcs0: SUCCESS (0.040s) [589.906154] Starting dynamic subtest: bcs0 [589.946667] Dynamic subtest bcs0: SUCCESS (0.052s) [589.957284] Starting dynamic subtest: vcs0 [589.997059] Dynamic subtest vcs0: SUCCESS (0.050s) [590.008250] Starting dynamic subtest: vcs1 [590.045163] Dynamic subtest vcs1: SUCCESS (0.047s) [590.056250] Starting dynamic subtest: vecs0 [590.091694] Dynamic subtest vecs0: SUCCESS (0.046s) [590.103487] Starting dynamic subtest: ccs0 [590.137004] Dynamic subtest ccs0: SUCCESS (0.044s) [590.139946] Subtest busy: SUCCESS (0.284s) [590.266520] [142/156] (431s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [590.355977] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [590.365522] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s) [590.446112] [143/156] (431s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [590.557387] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [597.879994] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.328s) [597.994606] [144/156] (424s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [598.093542] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [598.095962] Starting dynamic subtest: pipe-A-eDP-1 [598.189287] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [598.200398] Starting dynamic subtest: pipe-B-eDP-1 [599.366115] Dynamic subtest pipe-B-eDP-1: SKIP (1.174s) [599.372077] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.277s) [600.550086] [145/156] (421s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [600.642943] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [600.645386] Starting dynamic subtest: pipe-A [600.705549] Dynamic subtest pipe-A: SUCCESS (0.065s) [600.718723] Starting dynamic subtest: pipe-B [601.873970] Dynamic subtest pipe-B: SUCCESS (1.167s) [601.885824] Starting dynamic subtest: pipe-C [602.980214] Dynamic subtest pipe-C: SUCCESS (1.105s) [602.991540] Starting dynamic subtest: pipe-D [604.107538] Dynamic subtest pipe-D: SUCCESS (1.127s) [604.110445] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.469s) [605.267399] [146/156] (417s left) prime_vgem (basic-fence-mmap) [605.337976] Starting subtest: basic-fence-mmap [605.343122] Subtest basic-fence-mmap: SKIP (0.000s) [605.444279] [147/156] (416s left) gem_mmap (big-bo) [605.501053] Subtest big-bo: SKIP (0.000s) [605.558778] [148/156] (416s left) kms_plane (plane-position-covered) [605.647132] Starting subtest: plane-position-covered [606.159435] Starting dynamic subtest: pipe-A-plane-1 [607.439246] Dynamic subtest pipe-A-plane-1: SUCCESS (1.281s) [607.451997] Starting dynamic subtest: pipe-A-plane-2 [608.763164] Dynamic subtest pipe-A-plane-2: SUCCESS (1.323s) [608.776007] Starting dynamic subtest: pipe-A-plane-3 [609.993102] Dynamic subtest pipe-A-plane-3: SUCCESS (1.228s) [610.004389] Starting dynamic subtest: pipe-A-plane-4 [611.225011] Dynamic subtest pipe-A-plane-4: SUCCESS (1.232s) [611.236844] Starting dynamic subtest: pipe-A-plane-5 [611.251094] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s) [612.415901] Starting dynamic subtest: pipe-B-plane-1 [613.715996] Dynamic subtest pipe-B-plane-1: SUCCESS (1.308s) [613.729167] Starting dynamic subtest: pipe-B-plane-2 [615.014974] Dynamic subtest pipe-B-plane-2: SUCCESS (1.300s) [615.026701] Starting dynamic subtest: pipe-B-plane-3 [616.245910] Dynamic subtest pipe-B-plane-3: SUCCESS (1.229s) [616.258235] Starting dynamic subtest: pipe-B-plane-4 [617.484875] Dynamic subtest pipe-B-plane-4: SUCCESS (1.238s) [617.495944] Starting dynamic subtest: pipe-B-plane-5 [617.510251] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s) [617.513140] Subtest plane-position-covered: SUCCESS (11.866s) [618.303607] [149/156] (404s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [618.406511] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [619.208294] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.803s) [619.360802] [150/156] (403s left) gem_ppgtt (blt-vs-render-ctxn) [619.431172] Starting subtest: blt-vs-render-ctxN [652.247660] Subtest blt-vs-render-ctxN: SUCCESS (32.816s) [652.376867] [151/156] (370s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [652.521814] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [652.606472] [152/156] (369s left) gem_mmap (basic-small-bo) [652.664042] Subtest basic-small-bo: SKIP (0.000s) [652.724702] [153/156] (369s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-fullscreen) [652.831031] Starting subtest: fbchdr-1p-primscrn-spr-indfb-fullscreen [652.835624] Subtest fbchdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [652.913599] [154/156] (369s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render) [653.005228] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render [653.010025] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [653.092591] [155/156] (369s left) i915_drm_fdinfo (busy-idle-check-all) [653.137397] Starting subtest: busy-idle-check-all [653.140146] Starting dynamic subtest: rcs0 [653.145738] Dynamic subtest rcs0: SKIP (0.003s) [653.157168] Starting dynamic subtest: bcs0 [653.162103] Dynamic subtest bcs0: SKIP (0.000s) [653.172929] Starting dynamic subtest: vcs0 [653.178006] Dynamic subtest vcs0: SKIP (0.000s) [653.188500] Starting dynamic subtest: vcs1 [653.193889] Dynamic subtest vcs1: SKIP (0.000s) [653.205050] Starting dynamic subtest: vecs0 [653.210150] Dynamic subtest vecs0: SKIP (0.000s) [653.220832] Starting dynamic subtest: ccs0 [653.226088] Dynamic subtest ccs0: SKIP (0.000s) [653.231409] Subtest busy-idle-check-all: SKIP (0.009s) [653.276573] [156/156] (369s left) kms_frontbuffer_tracking (fbchdr-tiling-4) [653.396172] Starting subtest: fbchdr-tiling-4 [653.400985] Subtest fbchdr-tiling-4: SKIP (0.000s) [653.478740] Closing watchdogs results: parsing output: 0/ for test: gem_mmap results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_flip_scaled_crc results: parsing output: 4/ for test: gem_exec_fence results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: gem_ctx_persistence results: parsing output: 7/ for test: kms_flip results: parsing output: 8/ for test: gem_exec_params results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_busy results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: kms_psr2_su results: parsing output: 13/ for test: syncobj_timeline results: parsing output: 14/ for test: gem_exec_schedule results: parsing output: 15/ for test: kms_cursor_legacy results: parsing output: 16/ for test: gem_mmap_wc results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_chamelium_edid results: parsing output: 19/ for test: kms_psr2_sf results: parsing output: 20/ for test: prime_mmap results: parsing output: 21/ for test: kms_psr results: parsing output: 22/ for test: gem_exec_await results: parsing output: 23/ for test: gem_fenced_exec_thrash results: parsing output: 24/ for test: kms_selftest results: parsing output: 25/ for test: kms_addfb_basic results: parsing output: 26/ for test: gem_render_copy results: parsing output: 27/ for test: gem_exec_params results: parsing output: 28/ for test: kms_lease results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: gem_exec_balancer results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_getfb results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: dumb_buffer results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: kms_atomic results: parsing output: 41/ for test: kms_content_protection results: parsing output: 42/ for test: drm_read results: parsing output: 43/ for test: kms_psr results: parsing output: 44/ for test: kms_rotation_crc results: parsing output: 45/ for test: i915_suspend results: parsing output: 46/ for test: gem_partial_pwrite_pread results: parsing output: 47/ for test: gem_ctx_sseu results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_exec_schedule results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_dsc results: parsing output: 55/ for test: kms_pm_dc results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_color results: parsing output: 58/ for test: kms_pm_rpm results: parsing output: 59/ for test: gem_mmap_gtt results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: gem_exec_reloc results: parsing output: 62/ for test: kms_invalid_mode results: parsing output: 63/ for test: kms_rotation_crc results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_chamelium_hpd results: parsing output: 66/ for test: kms_plane_multiple results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: kms_ccs results: parsing output: 69/ for test: kms_atomic_interruptible results: parsing output: 70/ for test: kms_ccs results: parsing output: 71/ for test: gem_lmem_swapping results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: perf results: parsing output: 74/ for test: perf_pmu results: parsing output: 75/ for test: gen9_exec_parse results: parsing output: 76/ for test: kms_pipe_crc_basic results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_dp_aux_dev results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: gem_userptr_blits results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: api_intel_allocator results: parsing output: 86/ for test: gem_ctx_param results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_cursor_crc results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_create results: parsing output: 92/ for test: kms_big_fb results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_cursor_legacy results: parsing output: 95/ for test: syncobj_timeline results: parsing output: 96/ for test: kms_sequence results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_flip_scaled_crc results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_getfb results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: i915_pm_rpm results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_pread results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_lmem_evict results: parsing output: 108/ for test: gem_pxp results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_ccs results: parsing output: 111/ for test: gem_exec_whisper results: parsing output: 112/ for test: gem_exec_fence results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: kms_cursor_crc results: parsing output: 115/ for test: core_auth results: parsing output: 116/ for test: syncobj_wait results: parsing output: 117/ for test: kms_big_fb results: parsing output: 118/ for test: perf_pmu results: parsing output: 119/ for test: gem_exec_reloc results: parsing output: 120/ for test: sysfs_timeslice_duration results: parsing output: 121/ for test: syncobj_wait results: parsing output: 122/ for test: kms_plane results: parsing output: 123/ for test: vgem_basic results: parsing output: 124/ for test: i915_fb_tiling results: parsing output: 125/ for test: kms_cursor_edge_walk results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: gem_mmap_offset results: parsing output: 128/ for test: kms_ccs results: parsing output: 129/ for test: kms_vrr results: parsing output: 130/ for test: prime_self_import results: parsing output: 131/ for test: gem_spin_batch results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: syncobj_timeline results: parsing output: 136/ for test: gem_mmap_gtt results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: gen3_render_tiledy_blits results: parsing output: 139/ for test: syncobj_wait results: parsing output: 140/ for test: prime_vgem results: parsing output: 141/ for test: kms_flip results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_psr2_sf results: parsing output: 144/ for test: kms_plane_scaling results: parsing output: 145/ for test: prime_vgem results: parsing output: 146/ for test: gem_mmap results: parsing output: 147/ for test: kms_plane results: parsing output: 148/ for test: kms_big_fb results: parsing output: 149/ for test: gem_ppgtt results: parsing output: 150/ for test: kms_addfb_basic results: parsing output: 151/ for test: gem_mmap results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: i915_drm_fdinfo results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.