[56.891527] Initializing watchdogs [56.891595] /dev/watchdog0 [56.906746] [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] [56.911345] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.913774] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.917131] [001/133] (960s left) kms_pm_dc (dc6-psr) [58.038590] Starting subtest: dc6-psr [60.930371] Subtest dc6-psr: SUCCESS (2.930s) [61.738093] [002/133] (955s left) kms_plane (plane-panning-bottom-right) [61.836499] Starting subtest: plane-panning-bottom-right [61.838525] Starting dynamic subtest: pipe-A [63.499487] Dynamic subtest pipe-A: SUCCESS (1.678s) [63.508523] Starting dynamic subtest: pipe-B [65.827143] Dynamic subtest pipe-B: SUCCESS (2.342s) [65.829380] Subtest plane-panning-bottom-right: SUCCESS (4.022s) [66.656329] [003/133] (950s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [66.767052] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [67.841485] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.081s) [67.970178] [004/133] (949s left) kms_flip (bo-too-big-interruptible) [68.059469] Starting subtest: bo-too-big-interruptible [68.061524] Starting dynamic subtest: A-eDP1 [69.373346] Dynamic subtest A-eDP1: SUCCESS (1.317s) [69.381882] Starting dynamic subtest: B-eDP1 [70.608873] Dynamic subtest B-eDP1: SUCCESS (1.239s) [70.620757] Starting dynamic subtest: C-eDP1 [71.944235] Dynamic subtest C-eDP1: SUCCESS (1.337s) [71.953296] Starting dynamic subtest: D-eDP1 [73.267471] Dynamic subtest D-eDP1: SUCCESS (1.325s) [73.272508] Subtest bo-too-big-interruptible: SUCCESS (5.228s) [74.573171] [005/133] (943s left) gem_ctx_persistence (engines-hostile-preempt) [74.647751] Starting subtest: engines-hostile-preempt [74.650074] Starting dynamic subtest: rcs0 [74.713556] Dynamic subtest rcs0: SUCCESS (0.066s) [74.724031] Starting dynamic subtest: bcs0 [74.738637] Dynamic subtest bcs0: SUCCESS (0.024s) [74.746098] Starting dynamic subtest: vcs0 [76.316442] Dynamic subtest vcs0: SUCCESS (1.578s) [76.325063] Starting dynamic subtest: vcs1 [78.302679] Dynamic subtest vcs1: SUCCESS (1.988s) [78.311923] Starting dynamic subtest: vecs0 [80.282643] Dynamic subtest vecs0: SUCCESS (1.981s) [80.292298] Starting dynamic subtest: ccs0 [80.318125] Dynamic subtest ccs0: SUCCESS (0.037s) [80.320582] Subtest engines-hostile-preempt: SUCCESS (5.678s) [80.449995] [006/133] (937s left) kms_legacy_colorkey (invalid-plane) [80.548234] Starting subtest: invalid-plane [80.550610] Starting dynamic subtest: zero-id [80.552782] Dynamic subtest zero-id: SUCCESS (0.000s) [80.562072] Starting dynamic subtest: outrange-id [80.564200] Dynamic subtest outrange-id: SUCCESS (0.000s) [80.566089] Subtest invalid-plane: SUCCESS (0.000s) [80.616706] [007/133] (937s left) gem_exec_params (invalid-bsd1-flag-on-blt) [80.672710] Starting subtest: invalid-bsd1-flag-on-blt [80.674994] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [80.765637] [008/133] (936s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [80.873758] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [80.878611] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [80.944852] [009/133] (936s left) gem_workarounds (reset-context) [81.007357] Starting subtest: reset-context [81.157525] Subtest reset-context: SUCCESS (0.150s) [81.279266] [010/133] (936s left) gem_mmap_gtt (basic-small-bo) [81.339020] Subtest basic-small-bo: SKIP (0.000s) [81.395654] [011/133] (936s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [81.452990] Starting subtest: yf-tiled-to-vebox-y-tiled [81.457137] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [81.649228] [012/133] (936s left) gem_ctx_param (basic) [81.700665] Starting subtest: basic [81.703089] Subtest basic: SUCCESS (0.001s) [81.805366] [013/133] (936s left) kms_psr (pr-primary-mmap-gtt) [81.914245] Starting subtest: pr-primary-mmap-gtt [81.918854] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [81.991521] [014/133] (935s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [82.377867] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [83.168600] [015/133] (934s left) dmabuf_sync_file (import-basic) [83.263208] Starting subtest: import-basic [83.265583] Subtest import-basic: SUCCESS (0.004s) [83.323019] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true [83.326150] [016/133] (934s left) api_intel_bb (intel-bb-blit-x) [83.376810] Starting subtest: intel-bb-blit-x [87.326839] Subtest intel-bb-blit-x: SUCCESS (3.951s) [87.445781] [017/133] (930s left) gem_exec_schedule (thriceslice) [87.517300] Starting subtest: thriceslice [87.519656] Starting dynamic subtest: rcs0 [87.565285] Dynamic subtest rcs0: SUCCESS (0.057s) [87.576487] Starting dynamic subtest: bcs0 [87.623279] Dynamic subtest bcs0: SUCCESS (0.058s) [87.634084] Starting dynamic subtest: vcs0 [87.680420] Dynamic subtest vcs0: SUCCESS (0.056s) [87.697395] Starting dynamic subtest: vcs1 [87.737454] Dynamic subtest vcs1: SUCCESS (0.056s) [87.747853] Starting dynamic subtest: vecs0 [87.791363] Dynamic subtest vecs0: SUCCESS (0.053s) [87.802330] Starting dynamic subtest: ccs0 [87.833068] Dynamic subtest ccs0: SUCCESS (0.041s) [87.835348] Subtest thriceslice: SUCCESS (0.325s) [88.130338] [018/133] (929s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [88.235622] Starting subtest: yf-tiled-8bpp-rotate-0 [88.239696] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [88.326871] [019/133] (929s left) gem_exec_capture (capture-recoverable) [88.395879] Starting subtest: capture-recoverable [88.398433] Subtest capture-recoverable: SUCCESS (0.004s) [88.515793] [020/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [88.612401] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [88.616669] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [88.711658] [021/133] (929s left) kms_psr (fbc-psr2-cursor-blt) [88.806966] Starting subtest: fbc-psr2-cursor-blt [88.808995] Starting dynamic subtest: eDP-1 [88.813234] Dynamic subtest eDP-1: SKIP (0.000s) [88.817420] Subtest fbc-psr2-cursor-blt: SKIP (0.000s) [88.881235] [022/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [88.979467] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [88.983727] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [89.080956] [023/133] (929s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [89.189296] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [89.193121] Starting dynamic subtest: A-eDP1 [98.137059] Dynamic subtest A-eDP1: SUCCESS (8.947s) [98.147100] Starting dynamic subtest: B-eDP1 [107.062258] Dynamic subtest B-eDP1: SUCCESS (8.926s) [107.072403] Starting dynamic subtest: C-eDP1 [115.984245] Dynamic subtest C-eDP1: SUCCESS (8.921s) [115.995578] Starting dynamic subtest: D-eDP1 [124.915981] Dynamic subtest D-eDP1: SUCCESS (8.932s) [124.921907] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.736s) [126.154677] [024/133] (892s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [126.262271] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [126.266317] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [126.359467] [025/133] (892s left) gem_tiled_pread_pwrite [126.484505] [026/133] (891s left) sw_sync (alloc_timeline) [126.522060] Starting subtest: alloc_timeline [126.524149] Subtest alloc_timeline: SUCCESS (0.000s) [126.588903] [027/133] (891s left) kms_rmfb (rmfb-ioctl) [126.679912] Starting subtest: rmfb-ioctl [126.682267] Starting dynamic subtest: pipe-A-eDP-1 [126.783713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [126.793025] Starting dynamic subtest: pipe-B-eDP-1 [128.014136] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.229s) [128.024248] Starting dynamic subtest: pipe-C-eDP-1 [129.130197] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s) [129.140931] Starting dynamic subtest: pipe-D-eDP-1 [130.260477] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s) [130.262742] Subtest rmfb-ioctl: SUCCESS (3.583s) [131.384777] [028/133] (887s left) prime_mmap (test_invalid_sync_flags) [131.456055] Starting subtest: test_invalid_sync_flags [131.458415] Starting dynamic subtest: test_invalid_sync_flags-smem [131.460646] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s) [131.462892] Subtest test_invalid_sync_flags: SUCCESS (0.000s) [131.554849] [029/133] (886s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [131.660705] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf [131.663528] Starting dynamic subtest: pipe-A-eDP-1 [131.756941] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [131.767232] Starting dynamic subtest: pipe-B-eDP-1 [132.869322] Dynamic subtest pipe-B-eDP-1: SKIP (1.111s) [132.874100] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.214s) [134.051258] [030/133] (884s left) gem_sync (basic-store-each) [134.127948] Starting subtest: basic-store-each [136.530183] Subtest basic-store-each: SUCCESS (2.414s) [136.718245] [031/133] (881s left) perf_pmu (semaphore-busy) [136.768759] Starting subtest: semaphore-busy [136.771150] Starting dynamic subtest: rcs0 [138.407478] Dynamic subtest rcs0: SUCCESS (1.636s) [138.418967] Starting dynamic subtest: bcs0 [140.040525] Dynamic subtest bcs0: SUCCESS (1.632s) [140.054957] Starting dynamic subtest: vcs0 [143.835625] Dynamic subtest vcs0: SUCCESS (3.794s) [143.849654] Starting dynamic subtest: vcs1 [149.852231] Dynamic subtest vcs1: SUCCESS (6.014s) [149.862796] Starting dynamic subtest: vecs0 [155.866693] Dynamic subtest vecs0: SUCCESS (6.010s) [155.877299] Starting dynamic subtest: ccs0 [158.942514] Dynamic subtest ccs0: SUCCESS (3.073s) [158.945251] Subtest semaphore-busy: SUCCESS (22.168s) [159.058401] [032/133] (859s left) syncobj_timeline (signal-array) [159.125792] Starting subtest: signal-array [159.128144] Subtest signal-array: SUCCESS (0.000s) [159.243856] [033/133] (859s left) kms_draw_crc (draw-method-mmap-wc) [159.343995] Starting subtest: draw-method-mmap-wc [159.346311] Starting dynamic subtest: xrgb8888-untiled [159.588559] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s) [159.598023] Starting dynamic subtest: rgb565-untiled [159.821967] Dynamic subtest rgb565-untiled: SUCCESS (0.233s) [159.831464] Starting dynamic subtest: xrgb2101010-untiled [160.043969] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [160.052855] Starting dynamic subtest: xbgr16161616f-untiled [160.266455] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [160.275361] Starting dynamic subtest: xrgb8888-xtiled [160.388477] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [160.396754] Starting dynamic subtest: rgb565-xtiled [160.510932] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s) [160.519102] Starting dynamic subtest: xrgb2101010-xtiled [160.633103] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [160.641200] Starting dynamic subtest: xbgr16161616f-xtiled [160.755353] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s) [160.763467] Starting dynamic subtest: xrgb8888-4tiled [160.900095] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [160.909221] Starting dynamic subtest: rgb565-4tiled [161.033126] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s) [161.043292] Starting dynamic subtest: xrgb2101010-4tiled [161.177516] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s) [161.190854] Starting dynamic subtest: xbgr16161616f-4tiled [161.378572] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.200s) [161.380636] Subtest draw-method-mmap-wc: SUCCESS (2.034s) [161.472538] [034/133] (857s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [161.558854] Starting subtest: compare-crc-sanitycheck-xr24 [161.560906] Starting dynamic subtest: pipe-A-eDP-1 [162.214695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.652s) [162.224435] Starting dynamic subtest: pipe-B-eDP-1 [163.532634] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.316s) [163.542693] Starting dynamic subtest: pipe-C-eDP-1 [164.752464] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.219s) [164.762255] Starting dynamic subtest: pipe-D-eDP-1 [165.946964] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.192s) [165.949023] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.384s) [166.837711] [035/133] (851s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [166.939644] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [166.941979] Starting dynamic subtest: pipe-A-eDP-1 [166.964063] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [166.972661] Starting dynamic subtest: pipe-B-eDP-1 [166.994449] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [167.004555] Starting dynamic subtest: pipe-C-eDP-1 [167.028262] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [167.037869] Starting dynamic subtest: pipe-D-eDP-1 [167.059521] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [167.063513] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.006s) [169.186045] [036/133] (849s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu) [169.288870] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu [175.992899] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.705s) [176.118733] [037/133] (842s left) gem_madvise (dontneed-before-mmap) [176.156077] Starting subtest: dontneed-before-mmap [176.176671] Subtest dontneed-before-mmap: SUCCESS (0.021s) [176.274987] [038/133] (842s left) kms_cursor_crc (cursor-onscreen-512x512) [176.541819] Starting subtest: cursor-onscreen-512x512 [176.546430] Subtest cursor-onscreen-512x512: SKIP (0.001s) [176.699365] [039/133] (842s left) kms_getfb (getfb2-handle-protection) [176.789046] Starting subtest: getfb2-handle-protection [176.801776] Subtest getfb2-handle-protection: SUCCESS (0.014s) [176.905960] [040/133] (842s left) kms_psr (psr2-cursor-mmap-gtt) [176.993638] Starting subtest: psr2-cursor-mmap-gtt [176.996161] Starting dynamic subtest: eDP-1 [178.682793] Dynamic subtest eDP-1: SUCCESS (1.691s) [178.685099] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.691s) [179.571671] [041/133] (839s left) gem_wait (write-wait) [179.637702] Starting subtest: write-wait [179.640330] Starting dynamic subtest: all-engines [180.739578] Dynamic subtest all-engines: SUCCESS (1.102s) [180.757848] Starting dynamic subtest: rcs0 [181.797462] Dynamic subtest rcs0: SUCCESS (1.056s) [181.813399] Starting dynamic subtest: bcs0 [182.856575] Dynamic subtest bcs0: SUCCESS (1.057s) [182.873061] Starting dynamic subtest: vcs0 [183.910540] Dynamic subtest vcs0: SUCCESS (1.053s) [183.926785] Starting dynamic subtest: vcs1 [184.971587] Dynamic subtest vcs1: SUCCESS (1.059s) [184.987371] Starting dynamic subtest: vecs0 [186.023467] Dynamic subtest vecs0: SUCCESS (1.050s) [186.040303] Starting dynamic subtest: ccs0 [187.080670] Dynamic subtest ccs0: SUCCESS (1.055s) [187.083274] Subtest write-wait: SUCCESS (7.443s) [187.281379] [042/133] (831s left) kms_cursor_crc (cursor-rapid-movement-64x21) [187.489658] Starting subtest: cursor-rapid-movement-64x21 [187.536945] Subtest cursor-rapid-movement-64x21: SKIP (0.042s) [187.793557] [043/133] (831s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [187.886040] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [196.536176] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.651s) [196.650316] [044/133] (822s left) gem_exec_whisper (basic-fds-all) [196.708673] Starting subtest: basic-fds-all [208.256874] Subtest basic-fds-all: SUCCESS (11.542s) [208.438508] [045/133] (810s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [208.538829] Starting subtest: plane-lut1d-ctm3x4-lut1d [208.685975] Starting dynamic subtest: pipe-A-plane-0 [208.840411] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s) [208.851308] Starting dynamic subtest: pipe-A-plane-1 [209.009979] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s) [209.027736] Starting dynamic subtest: pipe-A-plane-2 [209.151691] Dynamic subtest pipe-A-plane-2: SUCCESS (0.143s) [210.405189] Starting dynamic subtest: pipe-B-plane-0 [210.575271] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s) [210.584988] Starting dynamic subtest: pipe-B-plane-1 [210.730979] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s) [210.744722] Starting dynamic subtest: pipe-B-plane-2 [210.953482] Dynamic subtest pipe-B-plane-2: SUCCESS (0.221s) [212.168934] Starting dynamic subtest: pipe-C-plane-0 [212.306377] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [212.316065] Starting dynamic subtest: pipe-C-plane-1 [212.462045] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [212.471411] Starting dynamic subtest: pipe-C-plane-2 [212.628504] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [213.842145] Starting dynamic subtest: pipe-D-plane-0 [213.978309] Dynamic subtest pipe-D-plane-0: SUCCESS (0.143s) [213.987599] Starting dynamic subtest: pipe-D-plane-1 [214.133378] Dynamic subtest pipe-D-plane-1: SUCCESS (0.154s) [214.142636] Starting dynamic subtest: pipe-D-plane-2 [214.288963] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [214.580231] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.041s) [215.415411] [046/133] (803s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [215.506811] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [215.509009] Starting dynamic subtest: pipe-A-eDP-1 [249.209553] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.797s) [249.221902] Starting dynamic subtest: pipe-B-eDP-1 [284.129771] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.534s) [284.139553] Starting dynamic subtest: pipe-C-eDP-1 [319.089297] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.450s) [319.113680] Starting dynamic subtest: pipe-D-eDP-1 [354.092124] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.427s) [354.095050] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.215s) [365.335172] [047/133] (664s left) api_intel_allocator (alloc-simple) [365.407538] Starting subtest: alloc-simple [365.409756] Subtest alloc-simple: SUCCESS (0.006s) [365.518632] [048/133] (663s left) i915_pm_rpm (system-suspend-execbuf) [367.048571] Starting subtest: system-suspend-execbuf [425.350935] Subtest system-suspend-execbuf: SUCCESS (43.255s) [425.746132] [049/133] (603s left) kms_flip (2x-flip-vs-panning) [425.839927] Starting subtest: 2x-flip-vs-panning [425.849494] Subtest 2x-flip-vs-panning: SKIP (0.011s) [425.945266] [050/133] (603s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [426.040477] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [426.044858] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [426.146389] [051/133] (603s left) gem_spin_batch (engines) [426.212346] Starting subtest: engines [426.214695] Starting dynamic subtest: rcs0 [429.456160] Dynamic subtest rcs0: SUCCESS (3.236s) [429.468659] Starting dynamic subtest: bcs0 [432.695886] Dynamic subtest bcs0: SUCCESS (3.234s) [432.708390] Starting dynamic subtest: vcs0 [435.932798] Dynamic subtest vcs0: SUCCESS (3.233s) [435.944770] Starting dynamic subtest: vcs1 [439.171055] Dynamic subtest vcs1: SUCCESS (3.233s) [439.186946] Starting dynamic subtest: vecs0 [442.407914] Dynamic subtest vecs0: SUCCESS (3.234s) [442.419683] Starting dynamic subtest: ccs0 [445.648353] Dynamic subtest ccs0: SUCCESS (3.237s) [445.650561] Subtest engines: SUCCESS (19.424s) [445.879460] [052/133] (583s left) syncobj_basic (bad-fd-to-handle) [445.940654] Starting subtest: bad-fd-to-handle [445.942934] Subtest bad-fd-to-handle: SUCCESS (0.000s) [446.053670] [053/133] (583s left) kms_big_fb (4-tiled-16bpp-rotate-0) [446.156163] Starting subtest: 4-tiled-16bpp-rotate-0 [447.489861] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.335s) [447.589371] [054/133] (582s left) gem_exec_suspend (basic) [447.646703] Starting subtest: basic [447.648651] Starting dynamic subtest: smem [449.129263] Dynamic subtest smem: SUCCESS (1.480s) [449.132181] Subtest basic: SUCCESS (1.482s) [449.313803] [055/133] (580s left) kms_pm_rpm (package-g7) [451.246121] Starting subtest: package-g7 [451.250986] Subtest package-g7: SKIP (0.000s) [451.631240] [056/133] (578s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [451.735856] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [451.740012] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [451.855885] [057/133] (577s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip) [451.962693] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip [451.967172] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [452.060371] [058/133] (577s left) gem_mmap_wc (write) [452.122598] Subtest write: SKIP (0.000s) [452.178296] [059/133] (577s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [452.265968] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [452.269771] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [452.350839] [060/133] (577s left) gem_exercise_blt (fast-copy) [452.414813] Starting subtest: fast-copy [452.417636] Starting dynamic subtest: linear-smem-smem [452.439172] Dynamic subtest linear-smem-smem: SUCCESS (0.025s) [452.451082] Starting dynamic subtest: xmajor-smem-smem [452.456971] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s) [452.466547] Starting dynamic subtest: tile4-smem-smem [452.475286] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s) [452.484807] Starting dynamic subtest: tile64-smem-smem [452.514869] Dynamic subtest tile64-smem-smem: SUCCESS (0.039s) [452.517230] Subtest fast-copy: SUCCESS (0.101s) [452.615604] [061/133] (577s left) gem_exec_reloc (basic-write-wc-noreloc) [452.666009] Subtest basic-write-wc-noreloc: SKIP (0.000s) [452.748012] [062/133] (577s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [452.842688] Starting subtest: primary-yf-tiled-reflect-x-180 [452.904037] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [453.006502] [063/133] (577s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [453.116242] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [453.119881] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [453.214375] [064/133] (576s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [453.308352] Starting subtest: planes-downscale-factor-0-5-unity-scaling [453.310232] Starting dynamic subtest: pipe-A [453.328555] Dynamic subtest pipe-A: SKIP (0.018s) [453.338498] Starting dynamic subtest: pipe-B [453.359897] Dynamic subtest pipe-B: SKIP (0.031s) [453.369519] Starting dynamic subtest: pipe-C [453.393392] Dynamic subtest pipe-C: SKIP (0.031s) [453.402777] Starting dynamic subtest: pipe-D [453.424359] Dynamic subtest pipe-D: SKIP (0.032s) [453.427885] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.114s) [453.541568] [065/133] (576s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [453.676597] Starting subtest: modeset-atomic-cursor-hotspot [453.680304] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [453.820616] [066/133] (576s left) i915_getparams_basic (basic-subslice-total) [453.873928] Starting subtest: basic-subslice-total [453.878254] Subtest basic-subslice-total: SUCCESS (0.000s) [453.973793] [067/133] (576s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [454.062717] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [460.328679] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.268s) [461.545709] [068/133] (568s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [461.644486] Starting subtest: fbcpsr-rgb101010-draw-render [468.399560] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.759s) [468.513581] [069/133] (561s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [468.616804] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [468.621059] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [468.736541] [070/133] (561s left) kms_psr (fbc-pr-cursor-render) [468.832282] Starting subtest: fbc-pr-cursor-render [468.836302] Subtest fbc-pr-cursor-render: SKIP (0.000s) [468.907065] [071/133] (561s left) kms_flip (flip-vs-suspend) [469.011171] Starting subtest: flip-vs-suspend [469.013508] Starting dynamic subtest: A-eDP1 [582.953371] Dynamic subtest A-eDP1: SUCCESS (11.734s) [582.956090] Subtest flip-vs-suspend: SUCCESS (11.736s) [589.156985] [072/133] (447s left) gem_mmap_offset (open-flood) [589.235699] Starting subtest: open-flood [610.448400] Subtest open-flood: SUCCESS (21.491s) [610.549845] [073/133] (425s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [610.651328] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [610.655244] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [610.751027] [074/133] (425s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [610.851044] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [618.183161] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.349s) [618.337099] [075/133] (418s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [618.437978] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [622.423782] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.994s) [623.636304] [076/133] (413s left) gem_exec_fence (syncobj-wait) [624.098949] Starting subtest: syncobj-wait [625.344861] Subtest syncobj-wait: SUCCESS (1.247s) [627.344407] [077/133] (409s left) gem_exec_schedule (preempt) [627.410662] Starting subtest: preempt [627.412671] Starting dynamic subtest: rcs0 [627.440475] Dynamic subtest rcs0: SUCCESS (0.038s) [627.452575] Starting dynamic subtest: bcs0 [627.475097] Dynamic subtest bcs0: SUCCESS (0.033s) [627.488037] Starting dynamic subtest: vcs0 [627.505986] Dynamic subtest vcs0: SUCCESS (0.030s) [627.516083] Starting dynamic subtest: vcs1 [627.537530] Dynamic subtest vcs1: SUCCESS (0.031s) [627.548511] Starting dynamic subtest: vecs0 [627.567035] Dynamic subtest vecs0: SUCCESS (0.029s) [627.579236] Starting dynamic subtest: ccs0 [627.613884] Dynamic subtest ccs0: SUCCESS (0.046s) [627.616961] Subtest preempt: SUCCESS (0.211s) [629.361890] [078/133] (407s left) kms_chamelium_color (ctm-0-75) [629.472786] Subtest ctm-0-75: SKIP (0.000s) [629.527181] [079/133] (407s left) intel_hwmon (hwmon-write) [629.589572] Subtest hwmon-write: SKIP (0.000s) [629.657655] [080/133] (407s left) gem_ctx_persistence (file) [629.715074] Starting subtest: file [629.834551] Subtest file: SUCCESS (0.122s) [629.976764] [081/133] (406s left) kms_addfb_basic (unused-pitches) [630.044962] Starting subtest: unused-pitches [630.047334] Subtest unused-pitches: SUCCESS (0.000s) [630.180134] [082/133] (406s left) gem_userptr_blits (create-destroy-unsync) [630.242389] Subtest create-destroy-unsync: SKIP (0.000s) [630.365732] [083/133] (406s left) i915_drm_fdinfo (virtual-busy-all) [630.412050] Starting subtest: virtual-busy-all [630.416781] Subtest virtual-busy-all: SKIP (0.000s) [630.485827] [084/133] (406s left) gem_exec_reloc (basic-cpu-read-noreloc) [630.545876] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [630.613458] [085/133] (406s left) perf (per-context-mode-unprivileged) [630.730023] Starting subtest: per-context-mode-unprivileged [630.734618] Subtest per-context-mode-unprivileged: SKIP (0.000s) [630.779585] [086/133] (406s left) syncobj_basic (bad-pad-handle-to-fd) [630.829771] Starting subtest: bad-pad-handle-to-fd [630.831886] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [630.913558] [087/133] (406s left) gen9_exec_parse (basic-rejected-ctx-param) [630.973982] Subtest basic-rejected-ctx-param: SKIP (0.000s) [631.038478] [088/133] (406s left) gem_eio (kms) [631.296316] Starting subtest: kms [650.921819] Subtest kms: SUCCESS (19.623s) [652.112940] [089/133] (385s left) perf_pmu (busy-accuracy-2) [652.165220] Starting subtest: busy-accuracy-2 [652.168068] Starting dynamic subtest: rcs0 [655.207847] Dynamic subtest rcs0: SUCCESS (3.044s) [655.220822] Starting dynamic subtest: bcs0 [658.271011] Dynamic subtest bcs0: SUCCESS (3.062s) [658.283194] Starting dynamic subtest: vcs0 [661.321698] Dynamic subtest vcs0: SUCCESS (3.047s) [661.334095] Starting dynamic subtest: vcs1 [664.369776] Dynamic subtest vcs1: SUCCESS (3.048s) [664.382040] Starting dynamic subtest: vecs0 [667.414586] Dynamic subtest vecs0: SUCCESS (3.044s) [667.425678] Starting dynamic subtest: ccs0 [670.473423] Dynamic subtest ccs0: SUCCESS (3.057s) [670.476095] Subtest busy-accuracy-2: SUCCESS (18.315s) [670.591018] [090/133] (366s left) kms_chamelium_frames (hdmi-frame-dump) [670.978288] Subtest hdmi-frame-dump: SKIP (0.000s) [671.804527] [091/133] (365s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [671.859756] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [671.963072] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [672.042340] [092/133] (365s left) kms_big_fb (x-tiled-16bpp-rotate-270) [672.141018] Starting subtest: x-tiled-16bpp-rotate-270 [672.161628] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s) [672.270594] [093/133] (365s left) gem_pread (snoop) [672.332532] Subtest snoop: SKIP (0.000s) [672.391230] [094/133] (365s left) gem_pxp (create-regular-context-1) [672.522719] Starting subtest: create-regular-context-1 [672.525830] Subtest create-regular-context-1: SUCCESS (0.002s) [672.641975] [095/133] (364s left) kms_big_fb (4-tiled-64bpp-rotate-270) [672.738753] Starting subtest: 4-tiled-64bpp-rotate-270 [672.758813] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s) [672.875960] [096/133] (364s left) kms_psr (fbc-psr-cursor-plane-move) [672.970290] Starting subtest: fbc-psr-cursor-plane-move [672.972816] Starting dynamic subtest: eDP-1 [672.976728] Dynamic subtest eDP-1: SKIP (0.000s) [672.980908] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [673.048018] [097/133] (364s left) perf_pmu (idle-no-semaphores) [673.085594] Starting subtest: idle-no-semaphores [673.087645] Starting dynamic subtest: rcs0 [673.630886] Dynamic subtest rcs0: SUCCESS (0.544s) [673.644639] Starting dynamic subtest: bcs0 [674.148357] Dynamic subtest bcs0: SUCCESS (0.513s) [674.161668] Starting dynamic subtest: vcs0 [674.677925] Dynamic subtest vcs0: SUCCESS (0.527s) [674.692331] Starting dynamic subtest: vcs1 [675.206881] Dynamic subtest vcs1: SUCCESS (0.526s) [675.220671] Starting dynamic subtest: vecs0 [675.722021] Dynamic subtest vecs0: SUCCESS (0.513s) [675.735107] Starting dynamic subtest: ccs0 [676.251640] Dynamic subtest ccs0: SUCCESS (0.527s) [676.254874] Subtest idle-no-semaphores: SUCCESS (3.167s) [676.346041] [098/133] (361s left) kms_flip (dpms-vs-vblank-race) [676.454323] Starting subtest: dpms-vs-vblank-race [676.456962] Starting dynamic subtest: A-eDP1 [680.315771] Dynamic subtest A-eDP1: SUCCESS (3.863s) [680.329315] Starting dynamic subtest: B-eDP1 [684.932539] Dynamic subtest B-eDP1: SUCCESS (4.616s) [684.943677] Starting dynamic subtest: C-eDP1 [689.570696] Dynamic subtest C-eDP1: SUCCESS (4.635s) [689.581908] Starting dynamic subtest: D-eDP1 [694.199951] Dynamic subtest D-eDP1: SUCCESS (4.624s) [694.202640] Subtest dpms-vs-vblank-race: SUCCESS (17.750s) [695.073070] [099/133] (342s left) kms_plane_cursor (primary) [695.175274] Starting subtest: primary [695.180688] Starting dynamic subtest: pipe-A-eDP-1-size-64 [697.749728] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.575s) [697.774652] Starting dynamic subtest: pipe-A-eDP-1-size-128 [700.318811] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.550s) [700.344063] Starting dynamic subtest: pipe-A-eDP-1-size-256 [702.886841] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.550s) [703.203653] Starting dynamic subtest: pipe-B-eDP-1-size-64 [706.437838] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.245s) [706.464532] Starting dynamic subtest: pipe-B-eDP-1-size-128 [709.051856] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s) [709.076974] Starting dynamic subtest: pipe-B-eDP-1-size-256 [711.619977] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.550s) [711.935286] Starting dynamic subtest: pipe-C-eDP-1-size-64 [714.906055] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.981s) [714.933980] Starting dynamic subtest: pipe-C-eDP-1-size-128 [717.250020] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.325s) [717.279071] Starting dynamic subtest: pipe-C-eDP-1-size-256 [719.495344] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s) [719.821804] Starting dynamic subtest: pipe-D-eDP-1-size-64 [722.759525] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.958s) [722.787086] Starting dynamic subtest: pipe-D-eDP-1-size-128 [724.959490] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.181s) [724.989072] Starting dynamic subtest: pipe-D-eDP-1-size-256 [727.182781] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.203s) [727.490904] Subtest primary: SUCCESS (32.311s) [728.312333] [100/133] (309s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [728.413035] Starting subtest: psr-1p-primscrn-cur-indfb-move [735.783818] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.376s) [735.909186] [101/133] (301s left) kms_addfb_basic (too-high) [736.004986] Starting subtest: too-high [736.007625] Subtest too-high: SUCCESS (0.001s) [736.105340] [102/133] (301s left) gem_workarounds (suspend-resume-context) [736.172367] Starting subtest: suspend-resume-context [752.930435] Subtest suspend-resume-context: SUCCESS (1.600s) [761.094220] [103/133] (284s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [761.218229] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [761.223153] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [761.318048] [104/133] (284s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [761.414209] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [761.418615] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [761.522776] [105/133] (284s left) syncobj_timeline (invalid-signal-illegal-point) [761.574572] Starting subtest: invalid-signal-illegal-point [761.577402] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [761.673764] [106/133] (284s left) kms_vblank (ts-continuation-suspend) [761.764542] Starting subtest: ts-continuation-suspend [761.766749] Starting dynamic subtest: pipe-A-eDP-1 [778.243442] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.956s) [778.258637] Starting dynamic subtest: pipe-D-eDP-1 [796.217868] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.565s) [796.221012] Subtest ts-continuation-suspend: SUCCESS (4.525s) [803.062071] [107/133] (249s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [803.137493] Starting subtest: multi-wait-for-submit-available-signaled [803.140186] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s) [803.262192] [108/133] (248s left) kms_flip (2x-wf_vblank-ts-check) [803.363634] Starting subtest: 2x-wf_vblank-ts-check [803.374935] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s) [803.459508] [109/133] (248s left) gem_exec_balancer (bonded-pair) [803.516059] Starting subtest: bonded-pair [803.521018] Subtest bonded-pair: SKIP (0.000s) [803.810835] [110/133] (248s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [803.899692] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [803.902127] Starting dynamic subtest: pipe-A-default-mode [805.036743] Dynamic subtest pipe-A-default-mode: SKIP (1.134s) [805.041322] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.136s) [805.204790] [111/133] (247s left) kms_addfb_basic (bad-pitch-63) [805.269292] Starting subtest: bad-pitch-63 [805.271873] Subtest bad-pitch-63: SUCCESS (0.000s) [805.413130] [112/133] (246s left) kms_joiner (basic-ultra-joiner) [805.507913] Starting subtest: basic-ultra-joiner [805.512955] Subtest basic-ultra-joiner: SKIP (0.000s) [805.576395] [113/133] (246s left) syncobj_timeline (wait-zero-handles) [805.639206] Starting subtest: wait-zero-handles [805.641653] Subtest wait-zero-handles: SUCCESS (0.000s) [805.754750] [114/133] (246s left) kms_scaling_modes (scaling-mode-none) [805.846910] Starting subtest: scaling-mode-none [805.849150] Starting dynamic subtest: pipe-A-eDP-1 [805.945632] Dynamic subtest pipe-A-eDP-1: SKIP (0.097s) [805.958191] Starting dynamic subtest: pipe-B-eDP-1 [805.982782] Dynamic subtest pipe-B-eDP-1: SKIP (0.035s) [805.994556] Starting dynamic subtest: pipe-C-eDP-1 [806.016907] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s) [806.027565] Starting dynamic subtest: pipe-D-eDP-1 [806.052926] Dynamic subtest pipe-D-eDP-1: SKIP (0.035s) [806.057758] Subtest scaling-mode-none: SKIP (0.206s) [806.178517] [115/133] (246s left) kms_big_fb (linear-8bpp-rotate-90) [806.270201] Starting subtest: linear-8bpp-rotate-90 [806.291475] Subtest linear-8bpp-rotate-90: SKIP (0.020s) [806.397411] [116/133] (246s left) kms_frontbuffer_tracking (fbc-stridechange) [806.486660] Starting subtest: fbc-stridechange [809.778110] Subtest fbc-stridechange: SUCCESS (3.293s) [810.919452] [117/133] (241s left) syncobj_wait (invalid-reset-illegal-handle) [810.978556] Starting subtest: invalid-reset-illegal-handle [810.981493] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [811.085959] [118/133] (241s left) gem_ccs (block-copy-compressed) [811.137260] Starting subtest: block-copy-compressed [811.142677] Subtest block-copy-compressed: SKIP (0.000s) [811.233673] [119/133] (241s left) gem_exec_reloc (basic-gtt-cpu) [811.296402] Subtest basic-gtt-cpu: SKIP (0.000s) [811.369852] [120/133] (241s left) gem_exec_fence (syncobj-timeline-invalid-wait) [811.938398] Starting subtest: syncobj-timeline-invalid-wait [811.941256] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.005s) [813.466541] [121/133] (239s left) gem_lmem_swapping (parallel-random-verify) [813.509587] Subtest parallel-random-verify: SKIP (0.000s) [813.560409] [122/133] (239s left) kms_content_protection (dp-mst-lic-type-0) [813.725717] Starting subtest: dp-mst-lic-type-0 [813.730996] Subtest dp-mst-lic-type-0: SKIP (0.000s) [813.837705] [123/133] (238s left) gem_pxp (protected-encrypted-src-copy-not-readible) [813.948218] Starting subtest: protected-encrypted-src-copy-not-readible [814.059571] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.113s) [814.166702] [124/133] (238s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping) [814.259190] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping [814.286807] Starting dynamic subtest: pipe-A-plane-0 [814.575142] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [814.585732] Starting dynamic subtest: pipe-A-plane-3 [814.842702] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s) [815.917842] Starting dynamic subtest: pipe-B-plane-0 [816.220907] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s) [816.235150] Starting dynamic subtest: pipe-B-plane-3 [816.465421] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s) [816.776272] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.516s) [817.598657] [125/133] (235s left) i915_pm_sseu (full-enable) [817.658222] Subtest full-enable: SKIP (0.000s) [817.766009] [126/133] (235s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [817.847762] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [817.850231] Starting dynamic subtest: pipe-A-eDP-1 [818.146072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.266s) [818.158681] Starting dynamic subtest: pipe-B-eDP-1 [819.384759] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.237s) [819.396078] Starting dynamic subtest: pipe-C-eDP-1 [820.591549] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s) [820.603126] Starting dynamic subtest: pipe-D-eDP-1 [821.828203] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s) [821.830645] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.944s) [822.926336] [127/133] (230s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [823.028626] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [823.033835] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [824.164476] [128/133] (228s left) kms_psr (psr-sprite-mmap-cpu) [824.252922] Starting subtest: psr-sprite-mmap-cpu [824.255732] Starting dynamic subtest: eDP-1 [825.976837] Dynamic subtest eDP-1: SUCCESS (1.722s) [825.979084] Subtest psr-sprite-mmap-cpu: SUCCESS (1.723s) [826.818639] [129/133] (226s left) kms_big_fb (y-tiled-16bpp-rotate-0) [826.931724] Starting subtest: y-tiled-16bpp-rotate-0 [826.936416] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [827.027332] [130/133] (226s left) gem_create (create-massive) [827.085140] Starting subtest: create-massive [827.087989] Subtest create-massive: SUCCESS (0.000s) [827.274813] [131/133] (225s left) kms_cursor_crc (cursor-tearing-position-change) [827.389678] Starting subtest: cursor-tearing-position-change [827.391969] Starting dynamic subtest: pipe-A-eDP-1 [827.966632] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s) [827.977664] Starting dynamic subtest: pipe-D-eDP-1 [829.257553] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.289s) [829.259928] Subtest cursor-tearing-position-change: SUCCESS (1.867s) [830.097781] [132/133] (223s left) kms_flip (flip-vs-wf_vblank-interruptible) [830.191671] Starting subtest: flip-vs-wf_vblank-interruptible [830.194099] Starting dynamic subtest: A-eDP1 [832.141501] Dynamic subtest A-eDP1: SUCCESS (1.948s) [832.154195] Starting dynamic subtest: B-eDP1 [834.074392] Dynamic subtest B-eDP1: SUCCESS (1.931s) [834.086174] Starting dynamic subtest: C-eDP1 [835.994427] Dynamic subtest C-eDP1: SUCCESS (1.916s) [836.009214] Starting dynamic subtest: D-eDP1 [837.932223] Dynamic subtest D-eDP1: SUCCESS (1.935s) [837.934929] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.742s) [839.155577] [133/133] (214s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [839.219721] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [839.320665] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s) [839.409518] Closing watchdogs results: parsing output: 0/ for test: kms_pm_dc results: parsing output: 1/ for test: kms_plane results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: kms_flip results: parsing output: 4/ for test: gem_ctx_persistence results: parsing output: 5/ for test: kms_legacy_colorkey results: parsing output: 6/ for test: gem_exec_params results: parsing output: 7/ for test: kms_psr2_sf results: parsing output: 8/ for test: gem_workarounds results: parsing output: 9/ for test: gem_mmap_gtt results: parsing output: 10/ for test: gem_render_copy results: parsing output: 11/ for test: gem_ctx_param results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: kms_chamelium_hpd results: parsing output: 14/ for test: dmabuf_sync_file results: parsing output: 15/ for test: api_intel_bb results: parsing output: 16/ for test: gem_exec_schedule results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: gem_exec_capture results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_flip results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: gem_tiled_pread_pwrite results: parsing output: 25/ for test: sw_sync results: parsing output: 26/ for test: kms_rmfb results: parsing output: 27/ for test: prime_mmap results: parsing output: 28/ for test: kms_psr2_sf results: parsing output: 29/ for test: gem_sync results: parsing output: 30/ for test: perf_pmu results: parsing output: 31/ for test: syncobj_timeline results: parsing output: 32/ for test: kms_draw_crc results: parsing output: 33/ for test: kms_pipe_crc_basic results: parsing output: 34/ for test: kms_ccs results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_madvise results: parsing output: 37/ for test: kms_cursor_crc results: parsing output: 38/ for test: kms_getfb results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: gem_wait results: parsing output: 41/ for test: kms_cursor_crc results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_exec_whisper results: parsing output: 44/ for test: kms_color_pipeline results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: api_intel_allocator results: parsing output: 47/ for test: i915_pm_rpm results: parsing output: 48/ for test: kms_flip results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_spin_batch results: parsing output: 51/ for test: syncobj_basic results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: gem_exec_suspend results: parsing output: 54/ for test: kms_pm_rpm results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: gem_mmap_wc results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_exercise_blt results: parsing output: 60/ for test: gem_exec_reloc results: parsing output: 61/ for test: kms_rotation_crc results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_plane_scaling results: parsing output: 64/ for test: kms_cursor_legacy results: parsing output: 65/ for test: i915_getparams_basic results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_psr results: parsing output: 70/ for test: kms_flip results: parsing output: 71/ for test: gem_mmap_offset results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: gem_exec_fence results: parsing output: 76/ for test: gem_exec_schedule results: parsing output: 77/ for test: kms_chamelium_color results: parsing output: 78/ for test: intel_hwmon results: parsing output: 79/ for test: gem_ctx_persistence results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: gem_userptr_blits results: parsing output: 82/ for test: i915_drm_fdinfo results: parsing output: 83/ for test: gem_exec_reloc results: parsing output: 84/ for test: perf results: parsing output: 85/ for test: syncobj_basic results: parsing output: 86/ for test: gen9_exec_parse results: parsing output: 87/ for test: gem_eio results: parsing output: 88/ for test: perf_pmu results: parsing output: 89/ for test: kms_chamelium_frames results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: gem_pread results: parsing output: 93/ for test: gem_pxp results: parsing output: 94/ for test: kms_big_fb results: parsing output: 95/ for test: kms_psr results: parsing output: 96/ for test: perf_pmu results: parsing output: 97/ for test: kms_flip results: parsing output: 98/ for test: kms_plane_cursor results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_addfb_basic results: parsing output: 101/ for test: gem_workarounds results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: syncobj_timeline results: parsing output: 105/ for test: kms_vblank results: parsing output: 106/ for test: syncobj_timeline results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: gem_exec_balancer results: parsing output: 109/ for test: kms_flip_scaled_crc results: parsing output: 110/ for test: kms_addfb_basic results: parsing output: 111/ for test: kms_joiner results: parsing output: 112/ for test: syncobj_timeline results: parsing output: 113/ for test: kms_scaling_modes results: parsing output: 114/ for test: kms_big_fb results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: syncobj_wait results: parsing output: 117/ for test: gem_ccs results: parsing output: 118/ for test: gem_exec_reloc results: parsing output: 119/ for test: gem_exec_fence results: parsing output: 120/ for test: gem_lmem_swapping results: parsing output: 121/ for test: kms_content_protection results: parsing output: 122/ for test: gem_pxp results: parsing output: 123/ for test: kms_plane results: parsing output: 124/ for test: i915_pm_sseu results: parsing output: 125/ for test: kms_ccs results: parsing output: 126/ for test: kms_ccs results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_big_fb results: parsing output: 129/ for test: gem_create results: parsing output: 130/ for test: kms_cursor_crc results: parsing output: 131/ for test: kms_flip results: parsing output: 132/ for test: syncobj_timeline Done.