[56.794415] Initializing watchdogs
[56.794465]   /dev/watchdog0
[56.808304] [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.812722] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.815134] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.818311] [001/133] (960s left) kms_cursor_crc (cursor-random-512x512)
[57.126510] Starting subtest: cursor-random-512x512
[57.130891] Subtest cursor-random-512x512: SKIP (0.001s)
[57.289564] [002/133] (960s left) gem_eio (context-create)
[57.453182] Starting subtest: context-create
[57.663989] Subtest context-create: SUCCESS (0.210s)
[57.821288] [003/133] (959s left) kms_frontbuffer_tracking (psr-2p-rte)
[57.924132] Starting subtest: psr-2p-rte
[57.927931] Subtest psr-2p-rte: SKIP (0.000s)
[58.014480] [004/133] (959s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[58.101300] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[58.103245] Starting dynamic subtest: pipe-A-eDP-1
[58.379035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.252s)
[58.391699] Starting dynamic subtest: pipe-B-eDP-1
[59.703099] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.312s)
[59.711122] Starting dynamic subtest: pipe-C-eDP-1
[60.924036] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.218s)
[60.933610] Starting dynamic subtest: pipe-D-eDP-1
[62.156021] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[62.158097] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.014s)
[63.372255] [005/133] (954s left) gem_exec_gttfill (all-engines)
[63.449600] Starting subtest: all-engines
[86.508581] Subtest all-engines: SUCCESS (23.046s)
[86.704882] [006/133] (930s left) gen7_exec_parse (basic-rejected)
[86.823288] Subtest basic-rejected: SKIP (0.000s)
[86.904123] [007/133] (930s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[86.970739] Subtest tiled-to-tiled: SKIP (0.000s)
[87.033899] [008/133] (930s left) syncobj_wait (multi-wait-submitted)
[87.098060] Starting subtest: multi-wait-submitted
[87.203787] Subtest multi-wait-submitted: SUCCESS (0.104s)
[87.294615] [009/133] (930s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[87.365051] Starting subtest: y-tiled-ccs-to-x-tiled
[87.369486] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[87.543249] [010/133] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[87.653570] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[94.749094] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.097s)
[94.896174] [011/133] (922s left) gem_exec_balancer (fairslice)
[94.957128] Starting subtest: fairslice
[97.905307] Subtest fairslice: SUCCESS (2.946s)
[98.225203] [012/133] (919s left) gem_ctx_param (invalid-size-get)
[98.272585] Starting subtest: invalid-size-get
[98.274783] Subtest invalid-size-get: SUCCESS (0.001s)
[98.364017] [013/133] (919s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[98.496073] Starting subtest: short-flip-after-cursor-toggle
[99.440554] Subtest short-flip-after-cursor-toggle: SUCCESS (0.944s)
[100.241216] [014/133] (917s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[100.347441] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[100.349708] Starting dynamic subtest: pipe-A-eDP-1
[100.358763] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.367865] Starting dynamic subtest: pipe-B-eDP-1
[100.376736] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.384489] Starting dynamic subtest: pipe-C-eDP-1
[100.393124] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.400791] Starting dynamic subtest: pipe-D-eDP-1
[100.409392] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.413667] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[102.605680] [015/133] (915s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[102.701250] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[102.703606] Starting dynamic subtest: pipe-A
[102.816562] Dynamic subtest pipe-A: SKIP (0.110s)
[102.825223] Starting dynamic subtest: pipe-B
[103.983266] Dynamic subtest pipe-B: SKIP (1.164s)
[103.994089] Starting dynamic subtest: pipe-C
[105.196753] Dynamic subtest pipe-C: SUCCESS (1.220s)
[105.204850] Starting dynamic subtest: pipe-D
[106.433952] Dynamic subtest pipe-D: SUCCESS (1.237s)
[106.436378] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.733s)
[107.623426] [016/133] (910s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[107.719900] Starting subtest: plane-lut1d-post-ctm3x4
[107.889315] Starting dynamic subtest: pipe-A-plane-0
[108.055604] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[108.065616] Starting dynamic subtest: pipe-A-plane-1
[108.212888] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[108.222383] Starting dynamic subtest: pipe-A-plane-2
[108.399746] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[109.620473] Starting dynamic subtest: pipe-B-plane-0
[109.802342] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[109.811525] Starting dynamic subtest: pipe-B-plane-1
[109.991088] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[110.000581] Starting dynamic subtest: pipe-B-plane-2
[110.146597] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[111.360997] Starting dynamic subtest: pipe-C-plane-0
[111.499060] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[111.509391] Starting dynamic subtest: pipe-C-plane-1
[111.643731] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[111.651998] Starting dynamic subtest: pipe-C-plane-2
[111.788094] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[112.995988] Starting dynamic subtest: pipe-D-plane-0
[113.131890] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[113.141187] Starting dynamic subtest: pipe-D-plane-1
[113.276675] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[113.286093] Starting dynamic subtest: pipe-D-plane-2
[113.443319] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[113.728641] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.009s)
[114.562198] [017/133] (903s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[114.658424] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[114.663106] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[114.730641] [018/133] (903s left) api_intel_allocator (fork-simple-stress)
[114.787893] Starting subtest: fork-simple-stress
[120.244691] Subtest fork-simple-stress: SUCCESS (5.404s)
[120.341302] [019/133] (897s left) gem_reg_read (timestamp-monotonic)
[120.395721] Starting subtest: timestamp-monotonic
[124.891016] Subtest timestamp-monotonic: SUCCESS (4.442s)
[124.927765] [020/133] (893s left) gem_workarounds (reset-fd)
[125.005389] Starting subtest: reset-fd
[125.197431] Subtest reset-fd: SUCCESS (0.193s)
[125.306980] [021/133] (892s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[125.414069] Starting subtest: 2x-flip-vs-modeset-vs-hang
[125.423084] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[125.517434] [022/133] (892s left) gem_exec_endless (dispatch)
[125.595960] Starting subtest: dispatch
[125.598898] Starting dynamic subtest: rcs0
[125.603704] Dynamic subtest rcs0: SUCCESS (0.005s)
[125.612609] Starting dynamic subtest: bcs0
[125.616839] Dynamic subtest bcs0: SUCCESS (0.004s)
[125.625484] Starting dynamic subtest: vcs0
[125.630091] Dynamic subtest vcs0: SUCCESS (0.005s)
[125.638241] Starting dynamic subtest: vcs1
[125.642722] Dynamic subtest vcs1: SUCCESS (0.007s)
[125.650992] Starting dynamic subtest: vecs0
[125.655425] Dynamic subtest vecs0: SUCCESS (0.005s)
[125.663632] Starting dynamic subtest: ccs0
[125.668077] Dynamic subtest ccs0: SUCCESS (0.004s)
[125.670285] Subtest dispatch: SUCCESS (0.034s)
[126.986541] [023/133] (891s left) kms_tiled_display (basic-test-pattern)
[127.099767] Subtest basic-test-pattern: SKIP (0.000s)
[127.139949] [024/133] (891s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[127.236875] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[127.239151] Starting dynamic subtest: pipe-A-default-mode
[129.989317] Dynamic subtest pipe-A-default-mode: SUCCESS (2.750s)
[129.991503] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.754s)
[130.847275] [025/133] (887s left) gem_tiled_partial_pwrite_pread (reads)
[130.906110] Subtest reads: SKIP (0.000s)
[130.964210] [026/133] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[131.061628] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[131.065760] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[131.164047] [027/133] (887s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[131.225324] Starting subtest: etime-single-wait-all-for-submit-submitted
[131.333500] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[131.405630] [028/133] (886s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[131.464918] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[131.466963] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[131.558935] [029/133] (886s left) gem_mmap_offset (bad-flags)
[131.622958] Starting subtest: bad-flags
[131.624870] Subtest bad-flags: SUCCESS (0.000s)
[131.746577] [030/133] (886s left) kms_addfb_basic (bad-pitch-65536)
[131.796120] Starting subtest: bad-pitch-65536
[131.798305] Subtest bad-pitch-65536: SUCCESS (0.000s)
[131.928722] [031/133] (886s left) kms_big_fb (linear-64bpp-rotate-0)
[132.028268] Starting subtest: linear-64bpp-rotate-0
[133.628160] Subtest linear-64bpp-rotate-0: SUCCESS (1.600s)
[133.809674] [032/133] (884s left) kms_atomic_interruptible (legacy-setmode)
[133.907224] Starting subtest: legacy-setmode
[133.909515] Starting dynamic subtest: pipe-A-eDP-1
[140.802582] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.894s)
[140.804954] Subtest legacy-setmode: SUCCESS (6.896s)
[141.669703] [033/133] (876s left) kms_invalid_mode (zero-clock)
[141.768258] Starting subtest: zero-clock
[141.770502] Starting dynamic subtest: pipe-A-eDP-1
[142.056797] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[142.065475] Starting dynamic subtest: pipe-B-eDP-1
[142.067358] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[142.075034] Starting dynamic subtest: pipe-C-eDP-1
[142.076916] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[142.085112] Starting dynamic subtest: pipe-D-eDP-1
[142.087261] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[142.089498] Subtest zero-clock: SUCCESS (0.294s)
[142.907182] [034/133] (875s left) gem_eio (in-flight-external)
[143.139256] Starting subtest: in-flight-external
[144.997336] Subtest in-flight-external: SUCCESS (1.856s)
[145.112148] [035/133] (873s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[145.211026] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[145.857339] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[146.016083] [036/133] (872s left) gem_exec_schedule (in-order)
[146.093244] Starting subtest: in-order
[146.095109] Starting dynamic subtest: rcs0
[146.195537] Dynamic subtest rcs0: SUCCESS (0.109s)
[146.206164] Starting dynamic subtest: vcs0
[146.276471] Dynamic subtest vcs0: SUCCESS (0.080s)
[146.286925] Starting dynamic subtest: vcs1
[146.361548] Dynamic subtest vcs1: SUCCESS (0.085s)
[146.372022] Starting dynamic subtest: vecs0
[146.450045] Dynamic subtest vecs0: SUCCESS (0.087s)
[146.460651] Starting dynamic subtest: ccs0
[146.556729] Dynamic subtest ccs0: SUCCESS (0.106s)
[146.559249] Subtest in-order: SUCCESS (0.470s)
[148.025825] [037/133] (870s left) kms_vblank (wait-forked-busy)
[148.120286] Starting subtest: wait-forked-busy
[148.122467] Starting dynamic subtest: pipe-A-eDP-1
[150.007690] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[150.021198] Starting dynamic subtest: pipe-D-eDP-1
[152.571436] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.563s)
[152.573835] Subtest wait-forked-busy: SUCCESS (4.454s)
[153.367811] [038/133] (865s left) vgem_slow (nohang)
[153.493662] Starting subtest: nohang
[164.009566] Subtest nohang: SUCCESS (10.465s)
[164.042993] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[164.046208] [039/133] (854s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[164.154069] Starting subtest: plane-all-modeset-transition-internal-panels
[164.156255] Starting dynamic subtest: pipe-A-eDP-1
[165.521770] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.368s)
[165.802292] Starting dynamic subtest: pipe-B-eDP-1
[166.842903] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.047s)
[167.110039] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.956s)
[167.947412] [040/133] (850s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[168.038831] Starting subtest: plane-upscale-20x20-with-pixel-format
[168.041064] Starting dynamic subtest: pipe-A
[169.086727] Dynamic subtest pipe-A: SUCCESS (1.050s)
[169.097068] Starting dynamic subtest: pipe-B
[171.184354] Dynamic subtest pipe-B: SUCCESS (2.097s)
[171.195357] Starting dynamic subtest: pipe-C
[172.355587] Dynamic subtest pipe-C: SUCCESS (1.169s)
[172.364788] Starting dynamic subtest: pipe-D
[173.577781] Dynamic subtest pipe-D: SUCCESS (1.220s)
[173.580267] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.541s)
[174.776659] [041/133] (844s left) kms_plane_cursor (primary)
[174.866085] Starting subtest: primary
[174.870806] Starting dynamic subtest: pipe-A-eDP-1-size-64
[177.443118] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.576s)
[177.469991] Starting dynamic subtest: pipe-A-eDP-1-size-128
[180.021647] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[180.045741] Starting dynamic subtest: pipe-A-eDP-1-size-256
[182.633922] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.594s)
[182.949726] Starting dynamic subtest: pipe-B-eDP-1-size-64
[186.262434] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.322s)
[186.286356] Starting dynamic subtest: pipe-B-eDP-1-size-128
[188.830533] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[188.854078] Starting dynamic subtest: pipe-B-eDP-1-size-256
[191.419277] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s)
[191.755044] Starting dynamic subtest: pipe-C-eDP-1-size-64
[194.645250] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.900s)
[194.670722] Starting dynamic subtest: pipe-C-eDP-1-size-128
[196.878428] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s)
[196.904125] Starting dynamic subtest: pipe-C-eDP-1-size-256
[199.112064] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s)
[199.431803] Starting dynamic subtest: pipe-D-eDP-1-size-64
[202.374156] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.951s)
[202.399537] Starting dynamic subtest: pipe-D-eDP-1-size-128
[204.673237] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.280s)
[204.699486] Starting dynamic subtest: pipe-D-eDP-1-size-256
[206.884052] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[207.194421] Subtest primary: SUCCESS (32.326s)
[208.003134] [042/133] (810s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[208.102406] Starting subtest: plane-primary-toggle-with-vblank-wait
[208.104865] Starting dynamic subtest: pipe-A-eDP-1
[208.277427] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[208.588192] Starting dynamic subtest: pipe-B-eDP-1
[209.495722] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.916s)
[209.806483] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.702s)
[210.653708] [043/133] (808s left) syncobj_timeline (invalid-query-illegal-handle)
[210.707169] Starting subtest: invalid-query-illegal-handle
[210.709524] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[210.827630] [044/133] (808s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[210.923956] Starting subtest: fbc-dirtyfb-ioctl
[210.926141] Starting dynamic subtest: A-eDP-1
[213.548946] Dynamic subtest A-eDP-1: SUCCESS (2.625s)
[213.551310] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.627s)
[214.422447] [045/133] (804s left) kms_addfb_basic (invalid-get-prop)
[214.485551] Starting subtest: invalid-get-prop
[214.487798] Subtest invalid-get-prop: SUCCESS (0.000s)
[214.629064] [046/133] (804s left) syncobj_wait (wait-for-submit-snapshot)
[214.691725] Starting subtest: wait-for-submit-snapshot
[214.771338] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[214.861031] [047/133] (804s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[214.955384] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[214.959575] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[215.073483] [048/133] (804s left) i915_drm_fdinfo (memory-info-active)
[215.122940] Starting subtest: memory-info-active
[215.124970] Starting dynamic subtest: smem0
[217.796318] Dynamic subtest smem0: SUCCESS (2.676s)
[217.798694] Subtest memory-info-active: SUCCESS (2.677s)
[217.875951] [049/133] (801s left) api_intel_bb (object-noreloc-purge-cache-simple)
[217.931009] Starting subtest: object-noreloc-purge-cache-simple
[217.937884] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.009s)
[218.046192] [050/133] (801s left) kms_psr (psr-cursor-mmap-gtt)
[218.148100] Starting subtest: psr-cursor-mmap-gtt
[218.149935] Starting dynamic subtest: eDP-1
[219.824421] Dynamic subtest eDP-1: SUCCESS (1.674s)
[219.826365] Subtest psr-cursor-mmap-gtt: SUCCESS (1.675s)
[220.677171] [051/133] (798s left) kms_pipe_crc_basic (suspend-read-crc)
[220.777352] Starting subtest: suspend-read-crc
[220.779709] Starting dynamic subtest: pipe-A-eDP-1
[238.310727] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.671s)
[238.320494] Starting dynamic subtest: pipe-B-eDP-1
[256.332744] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.125s)
[256.342922] Starting dynamic subtest: pipe-C-eDP-1
[274.288648] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.026s)
[274.298031] Starting dynamic subtest: pipe-D-eDP-1
[292.323394] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.090s)
[292.325774] Subtest suspend-read-crc: SUCCESS (11.918s)
[293.157001] [052/133] (726s left) kms_chamelium_hpd (hdmi-hpd-fast)
[293.579158] Subtest hdmi-hpd-fast: SKIP (0.000s)
[294.387906] [053/133] (725s left) kms_cursor_crc (cursor-tearing-position-change)
[294.502784] Starting subtest: cursor-tearing-position-change
[294.504868] Starting dynamic subtest: pipe-A-eDP-1
[295.064233] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[295.078398] Starting dynamic subtest: pipe-D-eDP-1
[296.339311] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[296.342100] Subtest cursor-tearing-position-change: SUCCESS (1.819s)
[297.170434] [054/133] (722s left) perf (short-reads)
[297.319193] Starting subtest: short-reads
[297.333239] Subtest short-reads: SUCCESS (0.015s)
[297.383640] [055/133] (722s left) kms_chamelium_edid (dp-mode-timings)
[298.524323] Subtest dp-mode-timings: SKIP (0.000s)
[298.861208] [056/133] (720s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[298.960279] Starting subtest: fbc-pr-sprite-mmap-gtt
[298.965340] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[299.033195] [057/133] (720s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[299.137971] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[308.600304] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.431s)
[308.742604] [058/133] (710s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[308.878356] Starting subtest: verify-pxp-key-change-after-suspend-resume
[316.022197] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.136s)
[316.145773] [059/133] (703s left) gem_exec_reloc (basic-cpu-read-noreloc)
[316.219498] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[316.297876] [060/133] (703s left) perf (mi-rpc)
[316.384522] Starting subtest: mi-rpc
[316.390438] Subtest mi-rpc: SKIP (0.000s)
[316.432725] [061/133] (703s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[316.525279] Starting subtest: fbcpsr-tiling-4
[323.595652] Subtest fbcpsr-tiling-4: SUCCESS (7.072s)
[323.726918] [062/133] (696s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[323.892286] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[323.897543] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[323.989153] [063/133] (695s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[324.092071] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[324.097754] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[324.213139] [064/133] (695s left) kms_lease (lease-uevent)
[324.314218] Starting subtest: lease-uevent
[325.320641] Subtest lease-uevent: SUCCESS (1.009s)
[325.420964] [065/133] (694s left) kms_pm_backlight (brightness-with-dpms)
[325.526395] Starting subtest: brightness-with-dpms
[325.579584] Starting dynamic subtest: eDP-1
[328.212181] Dynamic subtest eDP-1: SUCCESS (2.635s)
[328.214872] Subtest brightness-with-dpms: SUCCESS (2.688s)
[329.085578] [066/133] (690s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[329.242232] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[329.247284] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[329.352808] [067/133] (690s left) kms_flip (2x-plain-flip-fb-recreate)
[329.455564] Starting subtest: 2x-plain-flip-fb-recreate
[329.478306] Subtest 2x-plain-flip-fb-recreate: SKIP (0.023s)
[329.567546] [068/133] (690s left) gem_wait (await)
[329.649941] Starting subtest: await
[329.651987] Starting dynamic subtest: all-engines
[330.769543] Dynamic subtest all-engines: SUCCESS (1.122s)
[330.786729] Starting dynamic subtest: rcs0
[331.835619] Dynamic subtest rcs0: SUCCESS (1.063s)
[331.853340] Starting dynamic subtest: bcs0
[332.899437] Dynamic subtest bcs0: SUCCESS (1.062s)
[332.919947] Starting dynamic subtest: vcs0
[333.961486] Dynamic subtest vcs0: SUCCESS (1.059s)
[333.978649] Starting dynamic subtest: vcs1
[335.019853] Dynamic subtest vcs1: SUCCESS (1.055s)
[335.037500] Starting dynamic subtest: vecs0
[336.078650] Dynamic subtest vecs0: SUCCESS (1.056s)
[336.095754] Starting dynamic subtest: ccs0
[337.140417] Dynamic subtest ccs0: SUCCESS (1.059s)
[337.143217] Subtest await: SUCCESS (7.492s)
[337.344277] [069/133] (682s left) kms_psr (fbc-psr-primary-page-flip)
[337.456504] Starting subtest: fbc-psr-primary-page-flip
[337.458945] Starting dynamic subtest: eDP-1
[337.463679] Dynamic subtest eDP-1: SKIP (0.000s)
[337.468793] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[337.531109] [070/133] (682s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[337.632315] Starting subtest: 4-tiled-32bpp-rotate-0
[338.979534] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.345s)
[339.102160] [071/133] (681s left) kms_async_flips (async-flip-dpms)
[339.193061] Starting subtest: async-flip-dpms
[339.566156] Starting dynamic subtest: pipe-A-eDP-1
[343.390800] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.823s)
[343.775503] Starting dynamic subtest: pipe-B-eDP-1
[346.552465] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.784s)
[346.946278] Starting dynamic subtest: pipe-C-eDP-1
[349.736119] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.795s)
[350.124261] Starting dynamic subtest: pipe-D-eDP-1
[352.900720] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.782s)
[352.903227] Subtest async-flip-dpms: SUCCESS (13.707s)
[354.092120] [072/133] (666s left) kms_cdclk (mode-transition-all-outputs)
[354.193957] Starting subtest: mode-transition-all-outputs
[354.488510] Subtest mode-transition-all-outputs: SKIP (0.293s)
[355.321789] [073/133] (664s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[355.418526] Starting subtest: fbc-rgb101010-draw-blt
[360.040000] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.622s)
[361.230868] [074/133] (659s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[361.329109] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[367.887359] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.559s)
[367.991148] [075/133] (652s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[368.087751] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[368.092914] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[368.201893] [076/133] (652s left) perf_pmu (gt-awake)
[368.245531] Starting subtest: gt-awake
[376.392414] Subtest gt-awake: SUCCESS (8.148s)
[376.509308] [077/133] (643s left) i915_getparams_basic (basic-eu-total)
[376.568276] Starting subtest: basic-eu-total
[376.573470] Subtest basic-eu-total: SUCCESS (0.000s)
[376.662229] [078/133] (643s left) kms_prop_blob (basic)
[376.717013] Starting subtest: basic
[376.719802] Subtest basic: SUCCESS (0.000s)
[376.820969] [079/133] (643s left) gem_mmap_wc (write-wc-read-gtt)
[376.886996] Subtest write-wc-read-gtt: SKIP (0.000s)
[376.965746] [080/133] (643s left) kms_cursor_crc (cursor-offscreen-128x42)
[377.229521] Starting subtest: cursor-offscreen-128x42
[377.275397] Subtest cursor-offscreen-128x42: SKIP (0.043s)
[377.480860] [081/133] (643s left) kms_psr (pr-sprite-render)
[377.571077] Starting subtest: pr-sprite-render
[377.575266] Subtest pr-sprite-render: SKIP (0.000s)
[377.652940] [082/133] (643s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[377.711507] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[377.819406] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[377.897451] [083/133] (642s left) perf_pmu (semaphore-wait-idle)
[377.941844] Starting subtest: semaphore-wait-idle
[377.944236] Starting dynamic subtest: rcs0
[378.462027] Dynamic subtest rcs0: SUCCESS (0.518s)
[378.476137] Starting dynamic subtest: bcs0
[378.976153] Dynamic subtest bcs0: SUCCESS (0.511s)
[378.989642] Starting dynamic subtest: vcs0
[379.489987] Dynamic subtest vcs0: SUCCESS (0.511s)
[379.504086] Starting dynamic subtest: vcs1
[380.004665] Dynamic subtest vcs1: SUCCESS (0.511s)
[380.017535] Starting dynamic subtest: vecs0
[380.516503] Dynamic subtest vecs0: SUCCESS (0.510s)
[380.529888] Starting dynamic subtest: ccs0
[381.032540] Dynamic subtest ccs0: SUCCESS (0.513s)
[381.035510] Subtest semaphore-wait-idle: SUCCESS (3.090s)
[382.436898] [084/133] (638s left) gem_exec_reloc (basic-cpu)
[382.495315] Subtest basic-cpu: SKIP (0.000s)
[382.572386] [085/133] (638s left) gem_exec_fence (keep-in-fence)
[382.754167] Starting subtest: keep-in-fence
[382.757005] Starting dynamic subtest: rcs0
[382.825706] Dynamic subtest rcs0: SUCCESS (0.071s)
[382.838244] Starting dynamic subtest: bcs0
[382.883810] Dynamic subtest bcs0: SUCCESS (0.057s)
[382.896382] Starting dynamic subtest: vcs0
[384.392938] Dynamic subtest vcs0: SUCCESS (1.506s)
[384.407733] Starting dynamic subtest: vcs1
[386.494066] Dynamic subtest vcs1: SUCCESS (2.043s)
[386.506140] Starting dynamic subtest: vecs0
[388.423874] Dynamic subtest vecs0: SUCCESS (1.981s)
[388.436323] Starting dynamic subtest: ccs0
[388.668805] Dynamic subtest ccs0: SUCCESS (0.243s)
[388.671891] Subtest keep-in-fence: SUCCESS (5.915s)
[390.485363] [086/133] (630s left) gem_exec_whisper (basic-fds-forked)
[390.556355] Starting subtest: basic-fds-forked
[415.045403] Subtest basic-fds-forked: SUCCESS (24.482s)
[415.242426] [087/133] (605s left) gem_ctx_isolation (dirty-create)
[415.320272] Starting subtest: dirty-create
[415.322526] Starting dynamic subtest: rcs0
[415.572055] Dynamic subtest rcs0: SUCCESS (0.254s)
[415.583055] Starting dynamic subtest: bcs0
[415.859526] Dynamic subtest bcs0: SUCCESS (0.286s)
[415.870087] Starting dynamic subtest: vcs0
[416.127935] Dynamic subtest vcs0: SUCCESS (0.268s)
[416.138808] Starting dynamic subtest: vcs1
[417.636934] Dynamic subtest vcs1: SUCCESS (1.507s)
[417.650679] Starting dynamic subtest: vecs0
[419.609277] Dynamic subtest vecs0: SUCCESS (1.971s)
[419.619894] Starting dynamic subtest: ccs0
[421.615328] Dynamic subtest ccs0: SUCCESS (2.005s)
[421.618228] Subtest dirty-create: SUCCESS (6.297s)
[421.864397] [088/133] (599s left) kms_content_protection (lic-type-1)
[422.003608] Starting subtest: lic-type-1
[422.009010] Subtest lic-type-1: SKIP (0.000s)
[422.140551] [089/133] (598s left) gem_exec_create (madvise)
[422.207506] Starting subtest: madvise
[422.210499] Starting dynamic subtest: smem
[442.504310] Dynamic subtest smem: SUCCESS (20.288s)
[442.507264] Subtest madvise: SUCCESS (20.289s)
[443.364009] [090/133] (577s left) kms_prop_blob (invalid-get-prop-any)
[443.441182] Starting subtest: invalid-get-prop-any
[443.444288] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[443.552920] [091/133] (577s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[443.652352] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[443.654959] Starting dynamic subtest: pipe-A-eDP-1
[443.679273] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[443.690725] Starting dynamic subtest: pipe-B-eDP-1
[443.717124] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[443.727593] Starting dynamic subtest: pipe-C-eDP-1
[443.753292] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[443.764453] Starting dynamic subtest: pipe-D-eDP-1
[443.790958] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[443.796150] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.007s)
[445.818887] [092/133] (575s left) gem_ctx_engines (execute-one)
[445.875165] Starting subtest: execute-one
[448.104912] Subtest execute-one: SUCCESS (2.229s)
[448.443294] [093/133] (572s left) gem_spin_batch (resubmit-new)
[448.498355] Starting subtest: resubmit-new
[448.501200] Starting dynamic subtest: rcs0
[448.513271] Dynamic subtest rcs0: SUCCESS (0.015s)
[448.525541] Starting dynamic subtest: bcs0
[448.527746] Dynamic subtest bcs0: SUCCESS (0.008s)
[448.538508] Starting dynamic subtest: vcs0
[448.541750] Dynamic subtest vcs0: SUCCESS (0.006s)
[448.554088] Starting dynamic subtest: vcs1
[448.556526] Dynamic subtest vcs1: SUCCESS (0.013s)
[448.566905] Starting dynamic subtest: vecs0
[448.569232] Dynamic subtest vecs0: SUCCESS (0.008s)
[448.579554] Starting dynamic subtest: ccs0
[448.582039] Dynamic subtest ccs0: SUCCESS (0.010s)
[448.584409] Subtest resubmit-new: SUCCESS (0.066s)
[450.417956] [094/133] (570s left) gem_ccs (ctrl-surf-copy)
[450.471541] Starting subtest: ctrl-surf-copy
[450.477063] Subtest ctrl-surf-copy: SKIP (0.000s)
[450.574663] [095/133] (570s left) kms_flip (flip-vs-fences)
[450.676206] Starting subtest: flip-vs-fences
[450.680961] Subtest flip-vs-fences: SKIP (0.000s)
[450.785523] [096/133] (570s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[450.874172] Starting subtest: x-tiled-32bpp-rotate-90
[450.895034] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s)
[451.013386] [097/133] (570s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[451.108956] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[451.113515] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[451.212018] [098/133] (570s left) gem_exec_await (wide-all)
[451.443154] Starting subtest: wide-all
[474.422318] Subtest wide-all: SUCCESS (22.954s)
[474.610023] [099/133] (546s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[474.748558] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[474.751425] Starting dynamic subtest: pipe-A-default-mode
[475.892311] Dynamic subtest pipe-A-default-mode: SKIP (1.139s)
[475.897602] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.140s)
[476.028589] [100/133] (545s left) kms_feature_discovery (psr1)
[476.117491] Starting subtest: psr1
[476.120320] Subtest psr1: SUCCESS (0.000s)
[476.193760] [101/133] (545s left) gem_exec_schedule (u-lateslice)
[476.276361] Starting subtest: u-lateslice
[476.278795] Starting dynamic subtest: rcs0
[476.291927] Dynamic subtest rcs0: SUCCESS (0.024s)
[476.303061] Starting dynamic subtest: bcs0
[476.310021] Dynamic subtest bcs0: SUCCESS (0.018s)
[476.320325] Starting dynamic subtest: vcs0
[476.327082] Dynamic subtest vcs0: SUCCESS (0.016s)
[476.337278] Starting dynamic subtest: vcs1
[476.346436] Dynamic subtest vcs1: SUCCESS (0.018s)
[476.356525] Starting dynamic subtest: vecs0
[476.364415] Dynamic subtest vecs0: SUCCESS (0.018s)
[476.374688] Starting dynamic subtest: ccs0
[476.383107] Dynamic subtest ccs0: SUCCESS (0.018s)
[476.385781] Subtest u-lateslice: SUCCESS (0.116s)
[477.469594] [102/133] (544s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[477.562473] Starting subtest: psr-1p-primscrn-spr-indfb-move
[485.167052] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.606s)
[485.293876] [103/133] (536s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[485.392219] Starting subtest: invalidate-primary-flip-overlay
[496.122827] Subtest invalidate-primary-flip-overlay: SUCCESS (10.728s)
[496.227786] [104/133] (525s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[496.339631] Starting subtest: psr2-plane-move-sf-dmg-area
[496.341859] Starting dynamic subtest: pipe-A-eDP-1
[500.865040] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.526s)
[500.876964] Starting dynamic subtest: pipe-B-eDP-1
[506.178442] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.309s)
[506.181423] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.838s)
[507.042483] [105/133] (514s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[507.152194] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[511.967830] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.816s)
[513.167762] [106/133] (508s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[513.286383] Starting subtest: basic-flip-after-cursor-atomic
[514.244181] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.957s)
[515.092273] [107/133] (506s left) kms_flip (dpms-vs-vblank-race-interruptible)
[515.183376] Starting subtest: dpms-vs-vblank-race-interruptible
[515.186329] Starting dynamic subtest: A-eDP1
[520.179372] Dynamic subtest A-eDP1: SUCCESS (4.992s)
[520.191511] Starting dynamic subtest: B-eDP1
[523.684559] Dynamic subtest B-eDP1: SUCCESS (3.501s)
[523.695454] Starting dynamic subtest: C-eDP1
[528.308446] Dynamic subtest C-eDP1: SUCCESS (4.620s)
[528.319560] Starting dynamic subtest: D-eDP1
[532.972286] Dynamic subtest D-eDP1: SUCCESS (4.657s)
[532.975042] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.782s)
[533.837067] [108/133] (488s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[533.900256] Starting subtest: y-tiled-to-vebox-yf-tiled
[533.905445] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[534.087613] [109/133] (487s left) perf_pmu (all-busy-check-all)
[534.132824] Starting subtest: all-busy-check-all
[535.431940] Subtest all-busy-check-all: SUCCESS (1.300s)
[535.543422] [110/133] (486s left) i915_pm_rps (thresholds-idle)
[535.607055] Starting subtest: thresholds-idle
[535.612507] Subtest thresholds-idle: SKIP (0.000s)
[535.718942] [111/133] (486s left) kms_flip (modeset-vs-vblank-race)
[535.812071] Starting subtest: modeset-vs-vblank-race
[535.814576] Starting dynamic subtest: A-eDP1
[540.552218] Dynamic subtest A-eDP1: SUCCESS (4.741s)
[540.565289] Starting dynamic subtest: B-eDP1
[545.305525] Dynamic subtest B-eDP1: SUCCESS (4.749s)
[545.317305] Starting dynamic subtest: C-eDP1
[550.004552] Dynamic subtest C-eDP1: SUCCESS (4.695s)
[550.015822] Starting dynamic subtest: D-eDP1
[554.550525] Dynamic subtest D-eDP1: SUCCESS (4.543s)
[554.556227] Subtest modeset-vs-vblank-race: SUCCESS (18.738s)
[555.717274] [112/133] (466s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[555.810675] Starting subtest: psr-rgb565-draw-mmap-gtt
[555.815841] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[555.893815] [113/133] (466s left) dmabuf_sync_file (export-multiwait)
[555.944784] Starting subtest: export-multiwait
[555.947295] Subtest export-multiwait: SUCCESS (0.000s)
[556.013207] [114/133] (466s left) kms_flip (nonexisting-fb)
[556.103184] Starting subtest: nonexisting-fb
[556.105673] Starting dynamic subtest: A-eDP1
[557.304493] Dynamic subtest A-eDP1: SUCCESS (1.200s)
[557.320519] Starting dynamic subtest: B-eDP1
[558.441711] Dynamic subtest B-eDP1: SUCCESS (1.136s)
[558.452173] Starting dynamic subtest: C-eDP1
[559.569950] Dynamic subtest C-eDP1: SUCCESS (1.126s)
[559.580889] Starting dynamic subtest: D-eDP1
[560.695514] Dynamic subtest D-eDP1: SUCCESS (1.124s)
[560.698366] Subtest nonexisting-fb: SUCCESS (4.594s)
[561.868920] [115/133] (460s left) sysfs_timeslice_duration (idempotent)
[561.929858] Starting subtest: idempotent
[561.932243] Starting dynamic subtest: vecs0
[561.934519] Dynamic subtest vecs0: SUCCESS (0.000s)
[561.944538] Starting dynamic subtest: ccs0
[561.946790] Dynamic subtest ccs0: SUCCESS (0.000s)
[561.956588] Starting dynamic subtest: vcs0
[561.958697] Dynamic subtest vcs0: SUCCESS (0.000s)
[561.968684] Starting dynamic subtest: bcs0
[561.971320] Dynamic subtest bcs0: SUCCESS (0.000s)
[561.981320] Starting dynamic subtest: rcs0
[561.983684] Dynamic subtest rcs0: SUCCESS (0.000s)
[561.994013] Starting dynamic subtest: vcs1
[561.996314] Dynamic subtest vcs1: SUCCESS (0.000s)
[561.998784] Subtest idempotent: SUCCESS (0.007s)
[562.038898] [116/133] (460s left) gem_exec_params (invalid-fence-in)
[562.104156] Starting subtest: invalid-fence-in
[562.106565] Subtest invalid-fence-in: SUCCESS (0.000s)
[562.205372] [117/133] (460s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[562.311717] Starting subtest: yf-tiled-64bpp-rotate-180
[562.316165] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[562.413077] [118/133] (459s left) gem_lmem_swapping (verify-random)
[562.457299] Subtest verify-random: SKIP (0.000s)
[562.505878] [119/133] (459s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[562.604509] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[562.607326] Starting dynamic subtest: pipe-A-eDP-1
[562.634296] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[562.646315] Starting dynamic subtest: pipe-B-eDP-1
[562.671437] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[562.682122] Starting dynamic subtest: pipe-C-eDP-1
[562.707743] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[562.718569] Starting dynamic subtest: pipe-D-eDP-1
[562.745498] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[562.750426] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[564.924551] [120/133] (457s left) i915_pm_rpm (system-suspend-devices)
[566.557060] Starting subtest: system-suspend-devices
[574.254048] Subtest system-suspend-devices: SUCCESS (7.694s)
[574.642885] [121/133] (447s left) gem_close_race (basic-threads)
[574.713501] Starting subtest: basic-threads
[576.074059] Subtest basic-threads: SUCCESS (1.362s)
[576.270918] [122/133] (446s left) syncobj_timeline (wait-all-interrupted)
[576.336208] Starting subtest: wait-all-interrupted
[576.437354] Subtest wait-all-interrupted: SUCCESS (0.101s)
[576.516254] [123/133] (446s left) kms_flip (2x-flip-vs-panning-interruptible)
[576.626829] Starting subtest: 2x-flip-vs-panning-interruptible
[576.639130] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[576.715488] [124/133] (445s left) kms_atomic (plane-primary-legacy)
[576.825380] Starting subtest: plane-primary-legacy
[576.828270] Starting dynamic subtest: pipe-A-eDP-1
[577.270035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[577.272734] Subtest plane-primary-legacy: SUCCESS (0.447s)
[578.158206] [125/133] (444s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[578.254164] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[578.258727] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[578.345854] [126/133] (444s left) gem_lmem_swapping (massive-random)
[578.386302] Subtest massive-random: SKIP (0.000s)
[578.437145] [127/133] (444s left) gem_eio (in-flight-internal-10ms)
[578.646491] Starting subtest: in-flight-internal-10ms
[580.493285] Subtest in-flight-internal-10ms: SUCCESS (1.846s)
[580.643041] [128/133] (442s left) kms_busy (extended-pageflip-hang-newfb)
[580.730443] Starting subtest: extended-pageflip-hang-newfb
[580.733314] Starting dynamic subtest: pipe-A
[607.193368] Dynamic subtest pipe-A: SUCCESS (26.484s)
[607.204778] Starting dynamic subtest: pipe-D
[622.177809] Dynamic subtest pipe-D: SUCCESS (14.990s)
[622.180341] Subtest extended-pageflip-hang-newfb: SUCCESS (41.479s)
[623.002103] [129/133] (399s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[623.107379] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[623.112283] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[623.176990] [130/133] (399s left) gem_ctx_persistence (legacy-engines-persistence)
[623.232389] Starting subtest: legacy-engines-persistence
[623.234885] Starting dynamic subtest: render
[624.018273] Dynamic subtest render: SUCCESS (0.788s)
[624.032290] Starting dynamic subtest: bsd1
[624.772195] Dynamic subtest bsd1: SUCCESS (0.752s)
[624.785551] Starting dynamic subtest: bsd2
[625.538258] Dynamic subtest bsd2: SUCCESS (0.764s)
[625.551821] Starting dynamic subtest: blt
[626.310153] Dynamic subtest blt: SUCCESS (0.769s)
[626.322897] Starting dynamic subtest: vebox
[627.079749] Dynamic subtest vebox: SUCCESS (0.768s)
[627.082419] Subtest legacy-engines-persistence: SUCCESS (3.854s)
[627.163650] [131/133] (395s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[627.270520] Starting subtest: y-tiled-8bpp-rotate-0
[627.275848] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[627.374316] [132/133] (395s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[627.464118] Starting subtest: primary-yf-tiled-reflect-x-180
[627.537746] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.073s)
[627.652422] [133/133] (395s left) kms_vrr (seamless-rr-switch-virtual)
[627.742495] Starting subtest: seamless-rr-switch-virtual
[627.750120] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[627.811515] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_exec_gttfill
results: parsing output: 5/ for test: gen7_exec_parse
results: parsing output: 6/ for test: gem_set_tiling_vs_blt
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: gem_ctx_param
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: kms_color_pipeline
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: api_intel_allocator
results: parsing output: 18/ for test: gem_reg_read
results: parsing output: 19/ for test: gem_workarounds
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_exec_endless
results: parsing output: 22/ for test: kms_tiled_display
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_mmap_offset
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_atomic_interruptible
results: parsing output: 32/ for test: kms_invalid_mode
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_vblank
results: parsing output: 37/ for test: vgem_slow
results: parsing output: 38/ for test: kms_atomic_transition
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_plane_cursor
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_dirtyfb
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_pipe_crc_basic
results: parsing output: 51/ for test: kms_chamelium_hpd
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_chamelium_edid
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_pxp
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_lease
results: parsing output: 64/ for test: kms_pm_backlight
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_wait
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_async_flips
results: parsing output: 71/ for test: kms_cdclk
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: perf_pmu
results: parsing output: 76/ for test: i915_getparams_basic
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: gem_mmap_wc
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: gem_ctx_isolation
results: parsing output: 87/ for test: kms_content_protection
results: parsing output: 88/ for test: gem_exec_create
results: parsing output: 89/ for test: kms_prop_blob
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: gem_ctx_engines
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: gem_ccs
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_await
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_feature_discovery
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_psr_stress_test
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: i915_pm_rps
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: sysfs_timeslice_duration
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: gem_close_race
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_atomic
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_lmem_swapping
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_busy
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_rotation_crc
results: parsing output: 132/ for test: kms_vrr
Done.