[58.887979] Initializing watchdogs [58.888526] /dev/watchdog0 [58.904181] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.908939] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.911270] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.914743] [001/156] (960s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [59.036279] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [59.038658] Starting dynamic subtest: pipe-A-eDP-1 [59.061810] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [59.074066] Starting dynamic subtest: pipe-B-eDP-1 [59.095315] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [59.102263] Starting dynamic subtest: pipe-C-eDP-1 [59.124043] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [59.131468] Starting dynamic subtest: pipe-D-eDP-1 [59.154482] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [59.158716] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s) [61.369175] [002/156] (958s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt) [61.467062] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt [61.471189] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [61.569306] [003/156] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [61.668590] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [66.174897] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.513s) [67.372645] [004/156] (952s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [67.484630] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu [67.488824] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [67.614350] [005/156] (951s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf) [67.709352] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf [67.713594] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [67.778128] [006/156] (951s left) gem_exec_whisper (basic-fds-priority) [67.843644] Starting subtest: basic-fds-priority [92.682352] Subtest basic-fds-priority: SUCCESS (24.833s) [92.859712] [007/156] (926s left) syncobj_timeline (wait-for-submit-complex) [92.926290] Starting subtest: wait-for-submit-complex [92.988937] Subtest wait-for-submit-complex: SUCCESS (0.062s) [93.067903] [008/156] (926s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt) [93.173704] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt [93.178133] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [93.258178] [009/156] (926s left) gem_partial_pwrite_pread (reads-snoop) [93.311610] Subtest reads-snoop: SKIP (0.000s) [93.387872] [010/156] (926s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [93.484193] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [100.781215] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.304s) [100.898547] [011/156] (918s left) kms_busy (basic) [101.013381] Starting subtest: basic [101.015737] Starting dynamic subtest: flip [101.700202] Dynamic subtest flip: SUCCESS (0.688s) [101.710651] Starting dynamic subtest: modeset [105.134443] Dynamic subtest modeset: SUCCESS (3.433s) [105.136774] Subtest basic: SUCCESS (4.123s) [105.937823] [012/156] (913s left) kms_big_fb (y-tiled-16bpp-rotate-180) [106.045062] Starting subtest: y-tiled-16bpp-rotate-180 [106.049287] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [106.125517] [013/156] (913s left) kms_plane (pixel-format-y-tiled-modifier) [106.219200] Starting subtest: pixel-format-y-tiled-modifier [106.223286] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s) [106.290170] [014/156] (913s left) kms_fbcon_fbt (fbc-suspend) [106.358967] Starting subtest: fbc-suspend [156.358601] Subtest fbc-suspend: SUCCESS (20.734s) [158.678285] [015/156] (862s left) gen3_render_mixed_blits [158.806295] [016/156] (862s left) syncobj_wait (wait-all-snapshot) [158.850952] Starting subtest: wait-all-snapshot [158.931692] Subtest wait-all-snapshot: SUCCESS (0.081s) [159.009589] [017/156] (862s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0) [159.119075] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0 [160.164141] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.046s) [160.297784] [018/156] (860s left) gem_lmem_swapping (verify-random) [160.344713] Subtest verify-random: SKIP (0.000s) [160.381525] [019/156] (860s left) syncobj_wait (multi-wait-all-for-submit-submitted) [160.431255] Starting subtest: multi-wait-all-for-submit-submitted [160.537978] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s) [160.613344] [020/156] (860s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-pwrite) [160.704923] Starting subtest: fbcpsrhdr-rgb565-draw-pwrite [160.709106] Subtest fbcpsrhdr-rgb565-draw-pwrite: SKIP (0.000s) [160.800291] [021/156] (860s left) fbdev (unaligned-write) [160.847212] Starting subtest: unaligned-write [161.015049] Subtest unaligned-write: SUCCESS (0.166s) [161.077949] [022/156] (860s left) kms_cursor_crc (cursor-sliding-64x21) [161.272662] Starting subtest: cursor-sliding-64x21 [161.322517] Subtest cursor-sliding-64x21: SKIP (0.043s) [161.570630] [023/156] (859s left) syncobj_wait (invalid-reset-one-illegal-handle) [161.625165] Starting subtest: invalid-reset-one-illegal-handle [161.627440] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [161.739660] [024/156] (859s left) kms_plane_lowres (tiling-yf) [161.826004] Starting subtest: tiling-yf [161.830126] Subtest tiling-yf: SKIP (0.000s) [161.902098] [025/156] (859s left) drm_read (invalid-buffer) [162.055670] Starting subtest: invalid-buffer [162.058307] Subtest invalid-buffer: SUCCESS (0.000s) [162.178951] [026/156] (859s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [162.275083] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu [162.278547] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [162.373961] [027/156] (859s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [162.478028] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [167.039914] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.564s) [168.186079] [028/156] (853s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [168.294795] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [168.297104] Starting dynamic subtest: pipe-A-eDP-1 [168.412607] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s) [168.426020] Starting dynamic subtest: pipe-B-eDP-1 [169.559681] Dynamic subtest pipe-B-eDP-1: SKIP (1.145s) [169.564274] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.269s) [170.739904] [029/156] (850s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [170.837270] Starting subtest: primary-y-tiled-reflect-x-90 [170.841262] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [170.907303] [030/156] (850s left) i915_pm_rpm (system-suspend) [172.748366] Starting subtest: system-suspend [191.051561] Subtest system-suspend: SUCCESS (3.290s) [199.464583] [031/156] (830s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [199.570122] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [204.124112] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.558s) [205.247982] [032/156] (824s left) kms_frontbuffer_tracking (fbchdr-tiling-4) [205.350605] Starting subtest: fbchdr-tiling-4 [205.354990] Subtest fbchdr-tiling-4: SKIP (0.000s) [205.441006] [033/156] (824s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-pwrite) [205.535586] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-pwrite [205.539877] Subtest hdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [205.633824] [034/156] (824s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite) [205.730051] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite [205.734537] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [205.813366] [035/156] (823s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-onoff) [205.917225] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-onoff [205.921415] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [206.013445] [036/156] (823s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [206.108677] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [213.194995] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.087s) [213.327623] [037/156] (816s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [213.424042] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [213.426358] Starting dynamic subtest: pipe-A-eDP-1 [213.447239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [213.461915] Starting dynamic subtest: pipe-B-eDP-1 [213.481400] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [213.498615] Starting dynamic subtest: pipe-C-eDP-1 [213.519197] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [213.530811] Starting dynamic subtest: pipe-D-eDP-1 [213.551764] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [213.554035] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [215.744112] [038/156] (814s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [215.835896] Starting subtest: addfb25-y-tiled-small-legacy [215.840129] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [215.941989] [039/156] (814s left) gem_create (create-clear) [216.001225] Starting subtest: create-clear [216.003401] Starting dynamic subtest: smem0 [248.734203] Dynamic subtest smem0: SUCCESS (32.726s) [248.736474] Subtest create-clear: SUCCESS (32.727s) [248.934871] [040/156] (781s left) gem_pwrite (basic-random) [248.986459] Subtest basic-random: SKIP (0.000s) [249.055334] [041/156] (780s left) kms_getfb (getfb-handle-not-fb) [249.150738] Starting subtest: getfb-handle-not-fb [249.153036] Subtest getfb-handle-not-fb: SUCCESS (0.000s) [249.243300] [042/156] (780s left) kms_chamelium_hpd (dp-hpd-fast) [249.615438] Subtest dp-hpd-fast: SKIP (0.000s) [250.457789] [043/156] (779s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt) [250.556914] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt [250.560957] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [250.658949] [044/156] (779s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [250.760565] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [250.765031] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [250.838086] [045/156] (779s left) gem_pxp (hw-rejects-pxp-context) [250.952880] Starting subtest: hw-rejects-pxp-context [250.957524] Subtest hw-rejects-pxp-context: SKIP (0.000s) [251.057223] [046/156] (779s left) kms_joiner (invalid-modeset-big-joiner) [251.144438] Starting subtest: invalid-modeset-big-joiner [251.148581] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [251.222778] [047/156] (779s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc) [251.324813] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc [251.328938] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [251.418993] [048/156] (778s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [251.541161] Starting subtest: flip-vs-cursor-busy-crc-legacy [252.256033] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.712s) [253.110963] [049/156] (777s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt) [253.207304] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt [253.211618] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [253.300919] [050/156] (777s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs) [253.385811] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs [253.388106] Starting dynamic subtest: pipe-A-eDP-1 [253.411806] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [253.424637] Starting dynamic subtest: pipe-B-eDP-1 [253.446055] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [253.457035] Starting dynamic subtest: pipe-C-eDP-1 [253.478426] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [253.488282] Starting dynamic subtest: pipe-D-eDP-1 [253.510279] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [253.514374] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s) [255.663361] [051/156] (774s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [255.766162] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [255.778806] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s) [255.862725] [052/156] (774s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [255.962465] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [265.525475] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.566s) [265.657560] [053/156] (764s left) kms_addfb_basic (framebuffer-vs-set-tiling) [265.706978] Starting subtest: framebuffer-vs-set-tiling [265.711238] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [265.832730] [054/156] (764s left) kms_cursor_crc (cursor-rapid-movement-32x10) [265.990352] Starting subtest: cursor-rapid-movement-32x10 [266.040043] Subtest cursor-rapid-movement-32x10: SKIP (0.043s) [266.282647] [055/156] (764s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt) [266.391887] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt [266.395895] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [266.480732] [056/156] (764s left) kms_content_protection (legacy) [266.607266] Starting subtest: legacy [266.610771] Subtest legacy: SKIP (0.000s) [266.722833] [057/156] (763s left) syncobj_basic (bad-pad-handle-to-fd) [266.770891] Starting subtest: bad-pad-handle-to-fd [266.772558] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [266.859236] [058/156] (763s left) syncobj_basic (bad-create-flags) [266.917385] Starting subtest: bad-create-flags [266.919655] Subtest bad-create-flags: SUCCESS (0.000s) [267.026793] [059/156] (763s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc) [267.118219] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc [267.121714] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [267.239257] [060/156] (763s left) kms_color (legacy-gamma) [267.322243] Starting subtest: legacy-gamma [267.323870] Starting dynamic subtest: pipe-A-eDP-1 [268.053211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s) [268.066320] Starting dynamic subtest: pipe-B-eDP-1 [269.468956] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.414s) [269.480193] Starting dynamic subtest: pipe-C-eDP-1 [270.846012] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s) [270.857075] Starting dynamic subtest: pipe-D-eDP-1 [272.275382] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.427s) [272.277776] Subtest legacy-gamma: SUCCESS (4.954s) [273.163977] [061/156] (757s left) kms_psr (psr2-cursor-mmap-cpu) [273.260600] Starting subtest: psr2-cursor-mmap-cpu [273.262906] Starting dynamic subtest: eDP-1 [274.948586] Dynamic subtest eDP-1: SUCCESS (1.686s) [274.950489] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.686s) [275.842535] [062/156] (755s left) syncobj_timeline (etime-single-wait-submitted) [275.893536] Starting subtest: etime-single-wait-submitted [275.999169] Subtest etime-single-wait-submitted: SUCCESS (0.105s) [276.089220] [063/156] (754s left) kms_properties (invalid-properties-atomic) [276.180528] Starting subtest: invalid-properties-atomic [276.479636] Subtest invalid-properties-atomic: SUCCESS (0.299s) [276.551658] [064/156] (754s left) api_intel_bb (object-reloc-purge-cache) [276.610894] Starting subtest: object-reloc-purge-cache [276.615536] Subtest object-reloc-purge-cache: SKIP (0.003s) [276.701888] [065/156] (754s left) gem_exec_schedule (preempt-engines) [276.775511] Starting subtest: preempt-engines [276.777511] Starting dynamic subtest: rcs0 [279.030424] Dynamic subtest rcs0: SUCCESS (2.260s) [279.044472] Starting dynamic subtest: bcs0 [281.334954] Dynamic subtest bcs0: SUCCESS (2.303s) [281.345241] Starting dynamic subtest: vcs0 [283.617704] Dynamic subtest vcs0: SUCCESS (2.281s) [283.630078] Starting dynamic subtest: vcs1 [285.899352] Dynamic subtest vcs1: SUCCESS (2.279s) [285.910009] Starting dynamic subtest: vecs0 [288.242213] Dynamic subtest vecs0: SUCCESS (2.340s) [288.252922] Starting dynamic subtest: ccs0 [290.560425] Dynamic subtest ccs0: SUCCESS (2.315s) [290.562893] Subtest preempt-engines: SUCCESS (13.790s) [290.860134] [066/156] (740s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc) [290.964548] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc [290.968997] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [291.047085] [067/156] (740s left) kms_prime (d3hot) [291.130054] Subtest D3hot: SKIP (0.000s) [291.298748] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true [291.302048] [068/156] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [291.406596] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [291.410644] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [291.521042] [069/156] (739s left) kms_chamelium_edid (dp-mode-timings) [291.908950] Subtest dp-mode-timings: SKIP (0.000s) [292.765575] [070/156] (738s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [292.865460] Starting subtest: flip-vs-dpms-on-nop-interruptible [292.869921] Starting dynamic subtest: A-eDP1 [294.777355] Dynamic subtest A-eDP1: SUCCESS (1.909s) [294.788327] Starting dynamic subtest: B-eDP1 [296.603298] Dynamic subtest B-eDP1: SUCCESS (1.824s) [296.616024] Starting dynamic subtest: C-eDP1 [298.431529] Dynamic subtest C-eDP1: SUCCESS (1.826s) [298.448238] Starting dynamic subtest: D-eDP1 [300.256687] Dynamic subtest D-eDP1: SUCCESS (1.822s) [300.261821] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.395s) [301.455602] [071/156] (729s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [301.550036] Starting subtest: plane-downscale-factor-0-5-with-rotation [301.552429] Starting dynamic subtest: pipe-A [301.572503] Dynamic subtest pipe-A: SKIP (0.017s) [301.582925] Starting dynamic subtest: pipe-B [301.603896] Dynamic subtest pipe-B: SKIP (0.032s) [301.613910] Starting dynamic subtest: pipe-C [301.636655] Dynamic subtest pipe-C: SKIP (0.031s) [301.653242] Starting dynamic subtest: pipe-D [301.666786] Dynamic subtest pipe-D: SKIP (0.032s) [301.671220] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.114s) [301.769060] [072/156] (729s left) kms_vblank (wait-busy) [301.863413] Starting subtest: wait-busy [301.865355] Starting dynamic subtest: pipe-A-eDP-1 [303.734577] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s) [303.749901] Starting dynamic subtest: pipe-D-eDP-1 [306.317282] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.579s) [306.319651] Subtest wait-busy: SUCCESS (4.456s) [307.129160] [073/156] (724s left) syncobj_wait (multi-wait-for-submit-submitted) [307.188817] Starting subtest: multi-wait-for-submit-submitted [307.294351] Subtest multi-wait-for-submit-submitted: SUCCESS (0.106s) [307.375418] [074/156] (724s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [307.472227] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu [307.476214] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [307.587260] [075/156] (723s left) gem_ctx_isolation (dirty-switch) [307.644087] Starting subtest: dirty-switch [307.646556] Starting dynamic subtest: rcs0 [307.843776] Dynamic subtest rcs0: SUCCESS (0.199s) [307.856552] Starting dynamic subtest: bcs0 [308.069453] Dynamic subtest bcs0: SUCCESS (0.225s) [308.081995] Starting dynamic subtest: vcs0 [308.274624] Dynamic subtest vcs0: SUCCESS (0.204s) [308.285326] Starting dynamic subtest: vcs1 [309.769732] Dynamic subtest vcs1: SUCCESS (1.494s) [309.783644] Starting dynamic subtest: vecs0 [311.766585] Dynamic subtest vecs0: SUCCESS (1.994s) [311.779504] Starting dynamic subtest: ccs0 [313.807753] Dynamic subtest ccs0: SUCCESS (2.040s) [313.809930] Subtest dirty-switch: SUCCESS (6.165s) [314.054469] [076/156] (717s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-blt) [314.152552] Starting subtest: psrhdr-rgb101010-draw-blt [314.156777] Subtest psrhdr-rgb101010-draw-blt: SKIP (0.000s) [314.245710] [077/156] (717s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [314.369176] Starting subtest: cursorA-vs-flipA-varying-size [325.511312] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.143s) [326.367397] [078/156] (705s left) kms_big_fb (linear-16bpp-rotate-180) [326.476696] Starting subtest: linear-16bpp-rotate-180 [327.822302] Subtest linear-16bpp-rotate-180: SUCCESS (1.346s) [327.956334] [079/156] (703s left) syncobj_timeline (reset-multiple-signaled) [328.016076] Starting subtest: reset-multiple-signaled [328.018083] Subtest reset-multiple-signaled: SUCCESS (0.001s) [328.117361] [080/156] (703s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [328.221011] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [328.224715] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [328.305493] [081/156] (703s left) kms_plane_alpha_blend (alpha-opaque-fb) [328.409165] Starting subtest: alpha-opaque-fb [328.704013] Starting dynamic subtest: pipe-A-eDP-1 [329.415902] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s) [329.427183] Starting dynamic subtest: pipe-D-eDP-1 [330.799728] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.385s) [330.802089] Subtest alpha-opaque-fb: SUCCESS (2.393s) [331.629997] [082/156] (700s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [331.727533] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [331.731619] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [331.830342] [083/156] (699s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [331.917991] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [331.922404] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s) [331.992993] [084/156] (699s left) gem_exec_fence (syncobj-timeline-invalid-flags) [332.542658] Starting subtest: syncobj-timeline-invalid-flags [332.545576] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [333.666057] [085/156] (698s left) gem_ctx_bad_destroy (double-destroy) [333.721696] Starting subtest: double-destroy [333.724062] Subtest double-destroy: SUCCESS (0.000s) [333.793194] [086/156] (698s left) perf (gen12-group-exclusive-stream-sample-oa) [333.910631] Starting subtest: gen12-group-exclusive-stream-sample-oa [333.932816] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.023s) [333.983995] [087/156] (697s left) gem_ctx_shared (q-out-order) [334.049550] Starting subtest: Q-out-order [334.051909] Starting dynamic subtest: rcs0 [334.146435] Dynamic subtest rcs0: SUCCESS (0.096s) [334.165428] Starting dynamic subtest: vcs0 [334.226653] Dynamic subtest vcs0: SUCCESS (0.079s) [334.246098] Starting dynamic subtest: vcs1 [334.304981] Dynamic subtest vcs1: SUCCESS (0.077s) [334.323517] Starting dynamic subtest: vecs0 [334.376288] Dynamic subtest vecs0: SUCCESS (0.070s) [334.392685] Starting dynamic subtest: ccs0 [334.458961] Dynamic subtest ccs0: SUCCESS (0.083s) [334.461338] Subtest Q-out-order: SUCCESS (0.410s) [335.727821] [088/156] (696s left) gem_partial_pwrite_pread (write) [335.785502] Subtest write: SKIP (0.000s) [335.850592] [089/156] (696s left) gem_close_race (basic-threads) [335.919874] Starting subtest: basic-threads [337.378255] Subtest basic-threads: SUCCESS (1.460s) [337.582338] [090/156] (694s left) kms_psr (fbc-psr-sprite-plane-move) [337.680698] Starting subtest: fbc-psr-sprite-plane-move [337.683009] Starting dynamic subtest: eDP-1 [337.687207] Dynamic subtest eDP-1: SKIP (0.000s) [337.691558] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [337.768188] [091/156] (694s left) prime_vgem (basic-fence-blt) [337.830272] Starting subtest: basic-fence-blt [337.912917] Subtest basic-fence-blt: SUCCESS (0.082s) [338.059100] [092/156] (694s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-render) [338.159033] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-render [338.163042] Subtest psrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [338.287964] [093/156] (693s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [338.392674] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [338.396744] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [338.486724] [094/156] (693s left) kms_flip (2x-absolute-wf_vblank-interruptible) [338.585576] Starting subtest: 2x-absolute-wf_vblank-interruptible [338.597662] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s) [338.676485] [095/156] (693s left) gem_exec_basic (basic) [338.737363] Starting subtest: basic [338.739118] Starting dynamic subtest: rcs0-smem [338.740979] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [338.751104] Starting dynamic subtest: bcs0-smem [338.753006] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [338.763083] Starting dynamic subtest: vcs0-smem [338.764809] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [338.774482] Starting dynamic subtest: vcs1-smem [338.776185] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [338.785893] Starting dynamic subtest: vecs0-smem [338.787636] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [338.797070] Starting dynamic subtest: ccs0-smem [338.798817] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [338.800548] Subtest basic: SUCCESS (0.014s) [340.670060] [096/156] (691s left) gem_exec_fence (syncobj-timeline-wait) [341.195890] Starting subtest: syncobj-timeline-wait [342.636707] Subtest syncobj-timeline-wait: SUCCESS (1.439s) [344.647253] [097/156] (687s left) kms_cursor_crc (cursor-onscreen-64x64) [344.840933] Starting subtest: cursor-onscreen-64x64 [344.843257] Starting dynamic subtest: pipe-A-eDP-1 [346.975614] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.130s) [347.007063] Starting dynamic subtest: pipe-D-eDP-1 [349.810101] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.814s) [349.812545] Subtest cursor-onscreen-64x64: SUCCESS (4.971s) [350.693348] [098/156] (681s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite) [350.794273] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite [358.208463] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.418s) [359.411656] [099/156] (673s left) gem_exec_create (forked) [359.469060] Starting subtest: forked [359.471327] Starting dynamic subtest: smem [379.658966] Dynamic subtest smem: SUCCESS (20.190s) [379.661365] Subtest forked: SUCCESS (20.191s) [379.851865] [100/156] (652s left) gem_softpin (evict-single-offset) [379.918579] Starting subtest: evict-single-offset [408.595921] Subtest evict-single-offset: SUCCESS (28.671s) [408.683993] [101/156] (623s left) api_intel_allocator (reopen) [408.784499] Starting subtest: reopen [408.790152] Subtest reopen: SUCCESS (0.007s) [408.901702] [102/156] (623s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-cpu) [409.007022] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-cpu [409.011112] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [409.100544] [103/156] (623s left) gen7_exec_parse (basic-allocation) [409.149973] Subtest basic-allocation: SKIP (0.000s) [409.222408] [104/156] (623s left) perf (polling) [409.350109] Starting subtest: polling [409.352433] Starting dynamic subtest: 0-rcs0 [419.369967] Dynamic subtest 0-rcs0: SUCCESS (10.020s) [419.382369] Starting dynamic subtest: 1-vecs0 [429.391888] Dynamic subtest 1-vecs0: SUCCESS (10.019s) [429.394555] Subtest polling: SUCCESS (20.042s) [429.443507] [105/156] (603s left) sysfs_heartbeat_interval (nopreempt) [429.504589] Starting subtest: nopreempt [429.506898] Starting dynamic subtest: vecs0 [439.565016] Dynamic subtest vecs0: SUCCESS (10.061s) [439.579995] Starting dynamic subtest: ccs0 [443.566828] Dynamic subtest ccs0: SUCCESS (3.998s) [443.578459] Starting dynamic subtest: vcs0 [452.623187] Dynamic subtest vcs0: SUCCESS (9.054s) [452.637696] Starting dynamic subtest: bcs0 [456.538368] Dynamic subtest bcs0: SUCCESS (3.914s) [456.552833] Starting dynamic subtest: rcs0 [460.579659] Dynamic subtest rcs0: SUCCESS (4.041s) [460.593909] Starting dynamic subtest: vcs1 [470.607936] Dynamic subtest vcs1: SUCCESS (10.023s) [470.610451] Subtest nopreempt: SUCCESS (41.102s) [470.687253] [106/156] (562s left) kms_big_fb (x-tiled-16bpp-rotate-270) [470.802260] Starting subtest: x-tiled-16bpp-rotate-270 [470.821501] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [470.937858] [107/156] (561s left) gem_fenced_exec_thrash (too-many-fences) [471.008792] Subtest too-many-fences: SKIP (0.000s) [471.090045] [108/156] (561s left) vgem_basic (second-client) [471.142925] Starting subtest: second-client [471.164785] Subtest second-client: SUCCESS (0.022s) [471.227076] [109/156] (561s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [471.330699] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [471.334813] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [471.420212] [110/156] (561s left) kms_dp_link_training (uhbr-mst) [471.508021] Starting subtest: uhbr-mst [471.516382] Subtest uhbr-mst: SKIP (0.000s) [471.583274] [111/156] (561s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [471.680198] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [478.242594] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.567s) [478.368877] [112/156] (554s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [478.479579] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [478.483744] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [478.588188] [113/156] (554s left) kms_psr (fbc-pr-primary-page-flip) [478.682825] Starting subtest: fbc-pr-primary-page-flip [478.687311] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [478.759574] [114/156] (554s left) kms_chamelium_color (ctm-green-to-red) [478.855250] Subtest ctm-green-to-red: SKIP (0.000s) [478.901484] [115/156] (554s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-render) [478.999764] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-render [479.004250] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [479.093906] [116/156] (554s left) kms_async_flips (invalid-async-flip-atomic) [479.194926] Starting subtest: invalid-async-flip-atomic [479.567415] Starting dynamic subtest: pipe-A-eDP-1 [480.440207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.873s) [480.810226] Starting dynamic subtest: pipe-B-eDP-1 [481.679934] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.879s) [482.051777] Starting dynamic subtest: pipe-C-eDP-1 [482.907144] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.868s) [483.265393] Starting dynamic subtest: pipe-D-eDP-1 [484.049344] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.797s) [484.051533] Subtest invalid-async-flip-atomic: SUCCESS (4.855s) [485.284001] [117/156] (548s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [485.391810] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [485.396293] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [485.487963] [118/156] (547s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [485.574721] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [485.579239] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [486.717401] [119/156] (546s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [486.771127] Starting subtest: multi-wait-all-for-submit-available-signaled [486.772945] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [486.870488] [120/156] (546s left) gem_exec_whisper (basic-queues-forked) [486.925587] Starting subtest: basic-queues-forked [509.789498] Subtest basic-queues-forked: SUCCESS (22.858s) [509.974198] [121/156] (523s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [510.081812] Starting subtest: fbcpsr-slowdraw [535.432118] Subtest fbcpsr-slowdraw: SUCCESS (25.353s) [535.569472] [122/156] (497s left) syncobj_wait (invalid-signal-zero-handles) [535.623431] Starting subtest: invalid-signal-zero-handles [535.625415] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [535.725514] [123/156] (497s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [535.828991] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [536.910194] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.082s) [537.025131] [124/156] (496s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [537.112489] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [537.114417] Starting dynamic subtest: pipe-A [537.134341] Dynamic subtest pipe-A: SKIP (0.019s) [537.145854] Starting dynamic subtest: pipe-B [537.169489] Dynamic subtest pipe-B: SKIP (0.033s) [537.180398] Starting dynamic subtest: pipe-C [537.200573] Dynamic subtest pipe-C: SKIP (0.032s) [537.211383] Starting dynamic subtest: pipe-D [537.233569] Dynamic subtest pipe-D: SKIP (0.032s) [537.237086] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.119s) [537.331259] [125/156] (496s left) gem_exec_balancer (bonded-dual) [537.387926] Starting subtest: bonded-dual [537.391779] Subtest bonded-dual: SKIP (0.000s) [537.683418] [126/156] (496s left) gem_ctx_persistence (heartbeat-stop) [537.733653] Starting subtest: heartbeat-stop [537.738090] Subtest heartbeat-stop: SKIP (0.000s) [537.833307] [127/156] (495s left) core_setmaster (master-drop-set-user) [537.912211] Starting subtest: master-drop-set-user [537.925768] Subtest master-drop-set-user: SUCCESS (0.014s) [537.967071] [128/156] (495s left) sw_sync (sync_busy) [537.999386] Starting subtest: sync_busy [538.001741] Subtest sync_busy: SUCCESS (0.002s) [538.065088] [129/156] (495s left) kms_selftest (drm_dp_mst_helper) [538.103437] Starting subtest: drm_dp_mst_helper [538.138472] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [538.234329] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.098s) [538.245698] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [538.332144] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.096s) [538.342579] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [538.438592] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.106s) [538.440514] Subtest drm_dp_mst_helper: SUCCESS (0.334s) [538.595627] [130/156] (495s left) perf_pmu (render-node-busy-idle) [538.660439] Starting subtest: render-node-busy-idle [538.662453] Starting dynamic subtest: rcs0 [539.354911] Dynamic subtest rcs0: SUCCESS (0.693s) [539.369347] Starting dynamic subtest: bcs0 [540.017893] Dynamic subtest bcs0: SUCCESS (0.660s) [540.031563] Starting dynamic subtest: vcs0 [541.586819] Dynamic subtest vcs0: SUCCESS (1.565s) [541.600537] Starting dynamic subtest: vcs1 [543.634480] Dynamic subtest vcs1: SUCCESS (2.045s) [543.648101] Starting dynamic subtest: vecs0 [545.619261] Dynamic subtest vecs0: SUCCESS (1.982s) [545.633507] Starting dynamic subtest: ccs0 [546.281545] Dynamic subtest ccs0: SUCCESS (0.661s) [546.284144] Subtest render-node-busy-idle: SUCCESS (7.621s) [546.363062] [131/156] (487s left) gem_mmap_gtt (basic-wc) [546.419654] Subtest basic-wc: SKIP (0.000s) [546.493768] [132/156] (487s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [546.556611] Starting subtest: yf-tiled-to-vebox-x-tiled [546.561131] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [546.743195] [133/156] (487s left) i915_hangman (engine-error-state-capture) [546.807226] Starting subtest: engine-error-state-capture [546.809424] Starting dynamic subtest: rcs0 [550.577372] Dynamic subtest rcs0: SUCCESS (3.769s) [550.592788] Starting dynamic subtest: bcs0 [556.593280] Dynamic subtest bcs0: SUCCESS (6.012s) [556.607921] Starting dynamic subtest: vcs0 [562.546179] Dynamic subtest vcs0: SUCCESS (5.949s) [562.562044] Starting dynamic subtest: vcs1 [568.497136] Dynamic subtest vcs1: SUCCESS (5.948s) [568.511902] Starting dynamic subtest: vecs0 [573.552743] Dynamic subtest vecs0: SUCCESS (5.053s) [573.567147] Starting dynamic subtest: ccs0 [579.569035] Dynamic subtest ccs0: SUCCESS (6.012s) [579.571924] Subtest engine-error-state-capture: SUCCESS (32.760s) [579.652240] [134/156] (454s left) gen9_exec_parse (cmd-crossing-page) [579.716102] Subtest cmd-crossing-page: SKIP (0.000s) [579.776227] [135/156] (454s left) kms_draw_crc (draw-method-mmap-wc) [579.877158] Starting subtest: draw-method-mmap-wc [579.879123] Starting dynamic subtest: xrgb8888-untiled [580.130903] Dynamic subtest xrgb8888-untiled: SUCCESS (0.256s) [580.142434] Starting dynamic subtest: rgb565-untiled [580.342058] Dynamic subtest rgb565-untiled: SUCCESS (0.210s) [580.353515] Starting dynamic subtest: xrgb2101010-untiled [580.553171] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s) [580.565124] Starting dynamic subtest: xbgr16161616f-untiled [580.763775] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s) [580.774727] Starting dynamic subtest: xrgb8888-xtiled [580.897299] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s) [580.909332] Starting dynamic subtest: rgb565-xtiled [581.019474] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s) [581.030547] Starting dynamic subtest: xrgb2101010-xtiled [581.141854] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [581.153178] Starting dynamic subtest: xbgr16161616f-xtiled [581.275362] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [581.286436] Starting dynamic subtest: xrgb8888-4tiled [581.419962] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [581.432332] Starting dynamic subtest: rgb565-4tiled [581.564501] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s) [581.575889] Starting dynamic subtest: xrgb2101010-4tiled [581.697318] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s) [581.708383] Starting dynamic subtest: xbgr16161616f-4tiled [581.864054] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s) [581.865863] Subtest draw-method-mmap-wc: SUCCESS (1.990s) [581.951813] [136/156] (452s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-plflip-blt) [582.050021] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-plflip-blt [582.053587] Subtest fbcpsrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [582.138422] [137/156] (452s left) kms_flip (2x-flip-vs-panning-interruptible) [582.233184] Starting subtest: 2x-flip-vs-panning-interruptible [582.245796] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s) [582.322971] [138/156] (451s left) perf (buffer-fill) [582.410442] Starting subtest: buffer-fill [582.412581] Starting dynamic subtest: 0-rcs0 [584.706722] Dynamic subtest 0-rcs0: SUCCESS (2.294s) [584.719222] Starting dynamic subtest: 1-vecs0 [589.185291] Dynamic subtest 1-vecs0: SUCCESS (4.476s) [589.187580] Subtest buffer-fill: SUCCESS (6.773s) [589.239408] [139/156] (445s left) kms_invalid_mode (bad-hsync-end) [589.336064] Starting subtest: bad-hsync-end [589.338284] Starting dynamic subtest: pipe-A-eDP-1 [589.621283] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [589.634249] Starting dynamic subtest: pipe-B-eDP-1 [589.636370] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [589.646922] Starting dynamic subtest: pipe-C-eDP-1 [589.649261] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [589.660508] Starting dynamic subtest: pipe-D-eDP-1 [589.662862] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [589.665144] Subtest bad-hsync-end: SUCCESS (0.293s) [590.473637] [140/156] (443s left) gem_mmap_offset (bad-extensions) [590.531553] Starting subtest: bad-extensions [590.533768] Subtest bad-extensions: SUCCESS (0.000s) [590.650850] [141/156] (443s left) kms_pm_dc (dc5-dpms) [591.748417] Starting subtest: dc5-dpms [593.862915] Subtest dc5-dpms: SUCCESS (2.114s) [593.941528] [142/156] (440s left) i915_drm_fdinfo (busy) [593.981115] Starting subtest: busy [593.982913] Starting dynamic subtest: rcs0 [594.009555] Dynamic subtest rcs0: SKIP (0.027s) [594.023142] Starting dynamic subtest: bcs0 [594.027292] Dynamic subtest bcs0: SKIP (0.000s) [594.039780] Starting dynamic subtest: vcs0 [594.043832] Dynamic subtest vcs0: SKIP (0.000s) [594.055766] Starting dynamic subtest: vcs1 [594.059655] Dynamic subtest vcs1: SKIP (0.000s) [594.069778] Starting dynamic subtest: vecs0 [594.073662] Dynamic subtest vecs0: SKIP (0.000s) [594.083883] Starting dynamic subtest: ccs0 [594.087766] Dynamic subtest ccs0: SKIP (0.000s) [594.091616] Subtest busy: SKIP (0.033s) [594.130435] [143/156] (440s left) kms_selftest (drm_format_helper) [594.165328] Starting subtest: drm_format_helper [594.174090] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [594.273447] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.098s) [594.284369] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [594.372508] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.100s) [594.383691] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [594.469709] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.096s) [594.481014] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [594.588057] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.117s) [594.599226] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [594.708222] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.119s) [594.719043] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [594.811171] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.102s) [594.822347] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [594.906075] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.095s) [594.917889] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [594.996106] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.088s) [595.007707] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [595.073991] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.078s) [595.085143] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [595.242419] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.136s) [595.256276] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [595.310863] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.098s) [595.322420] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [595.409947] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.097s) [595.422479] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [595.507125] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.094s) [595.518568] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [595.598806] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.089s) [595.610583] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [595.694230] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.095s) [595.705681] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [595.791566] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.097s) [595.804907] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [595.898179] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.106s) [595.900402] Subtest drm_format_helper: SUCCESS (1.735s) [596.067021] [144/156] (438s left) gem_sync (basic-many-each) [596.138494] Starting subtest: basic-many-each [598.435302] Subtest basic-many-each: SUCCESS (2.305s) [598.623110] [145/156] (435s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [598.721578] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc [598.725714] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [598.824427] [146/156] (435s left) gem_mmap_gtt (coherency) [598.892587] Subtest coherency: SKIP (0.000s) [598.953842] [147/156] (435s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [599.055035] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [599.058960] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [599.165884] [148/156] (435s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [599.226078] Starting subtest: etime-multi-wait-all-for-submit-submitted [599.334234] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s) [599.416350] [149/156] (435s left) kms_lease (invalid-create-leases) [599.503239] Starting subtest: invalid-create-leases [599.508043] Subtest invalid-create-leases: SUCCESS (0.007s) [599.618541] [150/156] (435s left) gem_ctx_param (basic-default) [599.667498] Starting subtest: basic-default [599.669647] Subtest basic-default: SUCCESS (0.000s) [599.759936] [151/156] (435s left) gem_exec_schedule (preempt-user) [599.832126] Starting subtest: preempt-user [599.834413] Starting dynamic subtest: rcs0 [599.854653] Dynamic subtest rcs0: SUCCESS (0.027s) [599.866854] Starting dynamic subtest: bcs0 [599.874821] Dynamic subtest bcs0: SUCCESS (0.019s) [599.886520] Starting dynamic subtest: vcs0 [599.894893] Dynamic subtest vcs0: SUCCESS (0.019s) [599.906922] Starting dynamic subtest: vcs1 [599.916903] Dynamic subtest vcs1: SUCCESS (0.021s) [599.929488] Starting dynamic subtest: vecs0 [599.937238] Dynamic subtest vecs0: SUCCESS (0.020s) [599.949053] Starting dynamic subtest: ccs0 [599.960122] Dynamic subtest ccs0: SUCCESS (0.022s) [599.962364] Subtest preempt-user: SUCCESS (0.133s) [601.700721] [152/156] (433s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render) [601.801626] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render [601.805670] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [601.901842] [153/156] (432s left) kms_psr (fbc-psr2-sprite-plane-onoff) [601.998555] Starting subtest: fbc-psr2-sprite-plane-onoff [602.001154] Starting dynamic subtest: eDP-1 [602.005873] Dynamic subtest eDP-1: SKIP (0.000s) [602.010352] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s) [602.072117] [154/156] (432s left) i915_suspend (fence-restore-tiled2untiled) [602.129791] Starting subtest: fence-restore-tiled2untiled [602.134447] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [602.246852] [155/156] (432s left) kms_psr (psr2-primary-render) [602.335016] Starting subtest: psr2-primary-render [602.337295] Starting dynamic subtest: eDP-1 [604.105406] Dynamic subtest eDP-1: SUCCESS (1.770s) [604.107661] Subtest psr2-primary-render: SUCCESS (1.771s) [604.975879] [156/156] (430s left) gem_userptr_blits (input-checking) [605.038342] Starting subtest: input-checking [605.040581] Subtest input-checking: SUCCESS (0.000s) [605.183816] Closing watchdogs results: parsing output: 0/ for test: kms_ccs 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_frontbuffer_tracking results: parsing output: 4/ for test: kms_psr2_sf results: parsing output: 5/ for test: gem_exec_whisper results: parsing output: 6/ for test: syncobj_timeline results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: gem_partial_pwrite_pread results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_busy results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: kms_plane results: parsing output: 13/ for test: kms_fbcon_fbt results: parsing output: 14/ for test: gen3_render_mixed_blits results: parsing output: 15/ for test: syncobj_wait results: parsing output: 16/ for test: kms_big_fb results: parsing output: 17/ for test: gem_lmem_swapping results: parsing output: 18/ for test: syncobj_wait results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: fbdev results: parsing output: 21/ for test: kms_cursor_crc results: parsing output: 22/ for test: syncobj_wait results: parsing output: 23/ for test: kms_plane_lowres results: parsing output: 24/ for test: drm_read results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_psr2_sf results: parsing output: 28/ for test: kms_rotation_crc results: parsing output: 29/ for test: i915_pm_rpm results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: kms_addfb_basic results: parsing output: 38/ for test: gem_create results: parsing output: 39/ for test: gem_pwrite results: parsing output: 40/ for test: kms_getfb results: parsing output: 41/ for test: kms_chamelium_hpd results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: gem_pxp results: parsing output: 45/ for test: kms_joiner results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_cursor_legacy results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_flip results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_addfb_basic results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_content_protection results: parsing output: 56/ for test: syncobj_basic results: parsing output: 57/ for test: syncobj_basic results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_color results: parsing output: 60/ for test: kms_psr results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: kms_properties results: parsing output: 63/ for test: api_intel_bb results: parsing output: 64/ for test: gem_exec_schedule results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_prime results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_chamelium_edid results: parsing output: 69/ for test: kms_flip results: parsing output: 70/ for test: kms_plane_scaling results: parsing output: 71/ for test: kms_vblank results: parsing output: 72/ for test: syncobj_wait results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: gem_ctx_isolation results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_cursor_legacy results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: syncobj_timeline results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_plane_alpha_blend results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_flip_scaled_crc results: parsing output: 83/ for test: gem_exec_fence results: parsing output: 84/ for test: gem_ctx_bad_destroy results: parsing output: 85/ for test: perf results: parsing output: 86/ for test: gem_ctx_shared results: parsing output: 87/ for test: gem_partial_pwrite_pread results: parsing output: 88/ for test: gem_close_race results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: prime_vgem results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: gem_exec_basic results: parsing output: 95/ for test: gem_exec_fence results: parsing output: 96/ for test: kms_cursor_crc results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: gem_exec_create results: parsing output: 99/ for test: gem_softpin results: parsing output: 100/ for test: api_intel_allocator results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: gen7_exec_parse results: parsing output: 103/ for test: perf results: parsing output: 104/ for test: sysfs_heartbeat_interval results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: gem_fenced_exec_thrash results: parsing output: 107/ for test: vgem_basic results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_dp_link_training results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_psr results: parsing output: 113/ for test: kms_chamelium_color results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_async_flips results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_ccs results: parsing output: 118/ for test: syncobj_timeline results: parsing output: 119/ for test: gem_exec_whisper results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: syncobj_wait results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: kms_plane_scaling results: parsing output: 124/ for test: gem_exec_balancer results: parsing output: 125/ for test: gem_ctx_persistence results: parsing output: 126/ for test: core_setmaster results: parsing output: 127/ for test: sw_sync results: parsing output: 128/ for test: kms_selftest results: parsing output: 129/ for test: perf_pmu results: parsing output: 130/ for test: gem_mmap_gtt results: parsing output: 131/ for test: gem_render_copy results: parsing output: 132/ for test: i915_hangman results: parsing output: 133/ for test: gen9_exec_parse results: parsing output: 134/ for test: kms_draw_crc results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_flip results: parsing output: 137/ for test: perf results: parsing output: 138/ for test: kms_invalid_mode results: parsing output: 139/ for test: gem_mmap_offset results: parsing output: 140/ for test: kms_pm_dc results: parsing output: 141/ for test: i915_drm_fdinfo results: parsing output: 142/ for test: kms_selftest results: parsing output: 143/ for test: gem_sync results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: gem_mmap_gtt results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: syncobj_timeline results: parsing output: 148/ for test: kms_lease results: parsing output: 149/ for test: gem_ctx_param results: parsing output: 150/ for test: gem_exec_schedule results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: kms_psr results: parsing output: 153/ for test: i915_suspend results: parsing output: 154/ for test: kms_psr results: parsing output: 155/ for test: gem_userptr_blits Done.