[59.131974] Initializing watchdogs
[59.132186]   /dev/watchdog0
[59.146706] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.151149] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.153707] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.156911] [001/156] (960s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[59.293085] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[59.297606] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[59.389757] [002/156] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[59.481491] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[65.985998] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.510s)
[66.083802] [003/156] (953s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[66.196233] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[66.864426] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.670s)
[67.023315] [004/156] (952s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt)
[67.133414] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt
[67.137882] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[67.241836] [005/156] (952s left) gem_exec_schedule (noreorder)
[67.425061] Starting subtest: noreorder
[67.427844] Starting dynamic subtest: rcs0
[67.480046] Dynamic subtest rcs0: SUCCESS (0.056s)
[67.490210] Starting dynamic subtest: vcs0
[69.310418] Dynamic subtest vcs0: SUCCESS (1.829s)
[69.321858] Starting dynamic subtest: vcs1
[71.292808] Dynamic subtest vcs1: SUCCESS (1.981s)
[71.305147] Starting dynamic subtest: vecs0
[73.275640] Dynamic subtest vecs0: SUCCESS (1.982s)
[73.289273] Starting dynamic subtest: ccs0
[73.522999] Dynamic subtest ccs0: SUCCESS (0.247s)
[73.525443] Subtest noreorder: SUCCESS (6.099s)
[73.706443] [006/156] (946s left) i915_drm_fdinfo (memory-info-active)
[73.751629] Starting subtest: memory-info-active
[73.754165] Starting dynamic subtest: smem0
[76.504977] Dynamic subtest smem0: SUCCESS (2.753s)
[76.507559] Subtest memory-info-active: SUCCESS (2.755s)
[76.584988] [007/156] (943s left) kms_big_fb (linear-32bpp-rotate-270)
[76.688968] Starting subtest: linear-32bpp-rotate-270
[76.712779] Subtest linear-32bpp-rotate-270: SKIP (0.022s)
[76.820794] [008/156] (943s left) gem_render_copy (yf-tiled)
[76.885941] Starting subtest: yf-tiled
[76.889686] Subtest yf-tiled: SKIP (0.000s)
[77.064310] [009/156] (942s left) gem_ctx_param (vm)
[77.118730] Starting subtest: vm
[77.174936] Subtest vm: SUCCESS (0.055s)
[77.308388] [010/156] (942s left) prime_vgem (basic-read)
[77.414098] Starting subtest: basic-read
[77.422223] Subtest basic-read: SKIP (0.006s)
[77.533950] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[77.537410] [011/156] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[77.641568] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[77.646028] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[77.738851] [012/156] (942s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[77.828061] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[77.832238] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[77.901681] [013/156] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[78.002387] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[84.628190] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.631s)
[84.765260] [014/156] (935s left) gem_exec_params (invalid-fence-in-submit)
[84.813707] Starting subtest: invalid-fence-in-submit
[84.818465] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[84.933931] [015/156] (935s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-rte)
[85.035087] Starting subtest: fbcpsrhdr-2p-rte
[85.039402] Subtest fbcpsrhdr-2p-rte: SKIP (0.000s)
[85.126505] [016/156] (935s left) gem_userptr_blits (sync-unmap-cycles)
[85.194250] Starting subtest: sync-unmap-cycles
[90.567210] Subtest sync-unmap-cycles: SUCCESS (5.374s)
[90.701402] [017/156] (929s left) i915_pm_rpm (system-suspend-devices)
[92.431441] Starting subtest: system-suspend-devices
[100.219376] Subtest system-suspend-devices: SUCCESS (7.790s)
[100.606976] [018/156] (919s left) kms_psr (pr-primary-mmap-cpu)
[100.708986] Starting subtest: pr-primary-mmap-cpu
[100.714098] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[100.779532] [019/156] (919s left) gem_exec_reloc (basic-range-active)
[100.846740] Subtest basic-range-active: SKIP (0.000s)
[100.922619] [020/156] (919s left) kms_vrr (lobf)
[101.015541] Starting subtest: lobf
[101.019739] Subtest lobf: SKIP (0.000s)
[101.088175] [021/156] (919s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[101.179924] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[101.184061] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[101.288086] [022/156] (919s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[101.394114] Starting subtest: hdr-modesetfrombusy
[101.398268] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[101.481713] [023/156] (919s left) syncobj_wait (multi-wait-all-signaled)
[101.533427] Starting subtest: multi-wait-all-signaled
[101.535355] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[101.641680] [024/156] (918s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[101.731884] Starting subtest: nonblocking-crc-frame-sequence
[101.733958] Starting dynamic subtest: pipe-A-eDP-1
[102.461544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.724s)
[102.470936] Starting dynamic subtest: pipe-B-eDP-1
[103.875781] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.416s)
[103.886724] Starting dynamic subtest: pipe-C-eDP-1
[105.266237] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[105.275279] Starting dynamic subtest: pipe-D-eDP-1
[106.616921] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s)
[106.619627] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.885s)
[107.509305] [025/156] (913s left) kms_cursor_crc (cursor-offscreen-64x21)
[107.697127] Starting subtest: cursor-offscreen-64x21
[107.746945] Subtest cursor-offscreen-64x21: SKIP (0.044s)
[107.972163] [026/156] (912s left) gem_pipe_control_store_loop (reused-buffer)
[108.027863] Starting subtest: reused-buffer
[110.180055] Subtest reused-buffer: SUCCESS (2.152s)
[110.290739] [027/156] (910s left) sw_sync (sync_multi_consumer)
[110.325719] Starting subtest: sync_multi_consumer
[110.751953] Subtest sync_multi_consumer: SUCCESS (0.427s)
[110.814056] [028/156] (909s left) gem_exec_whisper (basic-fds-priority)
[110.879484] Starting subtest: basic-fds-priority
[135.246414] Subtest basic-fds-priority: SUCCESS (24.364s)
[135.426509] [029/156] (885s left) gem_basic (bad-close)
[135.492681] Starting subtest: bad-close
[135.497395] Subtest bad-close: SUCCESS (0.000s)
[135.605094] [030/156] (885s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[135.700016] Starting subtest: primary-4-tiled-reflect-x-0
[142.632819] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.935s)
[143.792184] [031/156] (877s left) gem_exec_schedule (u-submit-golden-slice)
[143.861224] Starting subtest: u-submit-golden-slice
[143.863417] Starting dynamic subtest: rcs0
[143.888801] Dynamic subtest rcs0: SUCCESS (0.036s)
[143.901112] Starting dynamic subtest: bcs0
[143.919534] Dynamic subtest bcs0: SUCCESS (0.029s)
[143.930497] Starting dynamic subtest: vcs0
[143.949897] Dynamic subtest vcs0: SUCCESS (0.030s)
[143.959092] Starting dynamic subtest: vcs1
[143.982919] Dynamic subtest vcs1: SUCCESS (0.032s)
[143.995205] Starting dynamic subtest: vecs0
[144.021106] Dynamic subtest vecs0: SUCCESS (0.038s)
[144.031780] Starting dynamic subtest: ccs0
[144.061994] Dynamic subtest ccs0: SUCCESS (0.040s)
[144.064334] Subtest u-submit-golden-slice: SUCCESS (0.210s)
[145.364789] [032/156] (875s left) gem_busy (extended)
[145.546429] Starting subtest: extended
[145.548365] Starting dynamic subtest: rcs0
[145.621128] Dynamic subtest rcs0: SUCCESS (0.078s)
[145.632942] Starting dynamic subtest: bcs0
[145.664581] Dynamic subtest bcs0: SUCCESS (0.042s)
[145.674922] Starting dynamic subtest: vcs0
[147.267081] Dynamic subtest vcs0: SUCCESS (1.599s)
[147.279802] Starting dynamic subtest: vcs1
[149.314568] Dynamic subtest vcs1: SUCCESS (2.046s)
[149.327139] Starting dynamic subtest: vecs0
[151.299492] Dynamic subtest vecs0: SUCCESS (1.983s)
[151.310659] Starting dynamic subtest: ccs0
[151.345237] Dynamic subtest ccs0: SUCCESS (0.046s)
[151.347636] Subtest extended: SUCCESS (5.802s)
[151.597560] [033/156] (869s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[151.660295] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[151.726602] [034/156] (869s left) kms_force_connector_basic (prune-stale-modes)
[151.798445] Starting subtest: prune-stale-modes
[152.244560] Subtest prune-stale-modes: SUCCESS (0.448s)
[152.383196] [035/156] (868s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[152.493046] Starting subtest: x-tiled-8bpp-rotate-180
[153.687487] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.194s)
[153.808923] [036/156] (867s left) gem_exec_balancer (semaphore)
[153.873442] Starting subtest: semaphore
[155.327374] Subtest semaphore: SUCCESS (1.452s)
[155.635143] [037/156] (865s left) kms_psr2_su (page_flip-xrgb8888)
[155.692587] Subtest page_flip-XRGB8888: SKIP (0.000s)
[155.749446] [038/156] (865s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[155.858671] Starting subtest: hdr-2p-pri-indfb-multidraw
[155.862796] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[155.958746] [039/156] (865s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[156.530274] Starting subtest: syncobj-backward-timeline-chain-engines
[156.637762] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.108s)
[158.367367] [040/156] (862s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[158.480144] Starting subtest: fbc-shrfb-scaledprimary
[161.326654] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.852s)
[162.521887] [041/156] (858s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt)
[162.631286] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt
[162.635369] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[162.726462] [042/156] (858s left) kms_pm_rpm (modeset-lpsp)
[164.455431] Starting subtest: modeset-lpsp
[165.929789] Subtest modeset-lpsp: SUCCESS (1.476s)
[166.071800] [043/156] (855s left) api_intel_allocator (gem-pool)
[166.120129] Starting subtest: gem-pool
[166.125917] Subtest gem-pool: SUCCESS (0.008s)
[166.259781] [044/156] (855s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-cpu)
[166.357037] Starting subtest: fbchdr-rgb101010-draw-mmap-cpu
[166.361518] Subtest fbchdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[166.460308] [045/156] (854s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[166.565287] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[166.567564] Starting dynamic subtest: pipe-A-eDP-1
[166.590690] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[166.601919] Starting dynamic subtest: pipe-B-eDP-1
[166.623781] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[166.633029] Starting dynamic subtest: pipe-C-eDP-1
[166.654966] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[166.664081] Starting dynamic subtest: pipe-D-eDP-1
[166.686196] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[166.690210] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[168.809906] [046/156] (852s left) gem_mmap_wc (close)
[168.860576] Subtest close: SKIP (0.000s)
[168.918950] [047/156] (852s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[169.012595] Starting subtest: fbcpsr-rgb101010-draw-blt
[173.658674] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.650s)
[173.796498] [048/156] (847s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[173.905694] Starting subtest: extended-modeset-hang-oldfb-with-reset
[173.908048] Starting dynamic subtest: pipe-A
[185.957390] Dynamic subtest pipe-A: SUCCESS (12.050s)
[185.967431] Starting dynamic subtest: pipe-D
[198.440979] Dynamic subtest pipe-D: SUCCESS (12.479s)
[198.443278] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.534s)
[199.302710] [049/156] (822s left) gem_reg_read (timestamp-monotonic)
[199.360408] Starting subtest: timestamp-monotonic
[204.326135] Subtest timestamp-monotonic: SUCCESS (4.966s)
[204.419640] [050/156] (817s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[204.526989] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[204.529247] Starting dynamic subtest: pipe-A-eDP-1
[204.945901] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[204.958910] Starting dynamic subtest: pipe-B-eDP-1
[204.980746] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[204.993059] Starting dynamic subtest: pipe-C-eDP-1
[205.012149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[205.022140] Starting dynamic subtest: pipe-D-eDP-1
[205.041747] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[205.044262] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.435s)
[207.231702] [051/156] (814s left) kms_cursor_edge_walk (64x64-top-bottom)
[207.327939] Starting subtest: 64x64-top-bottom
[207.330316] Starting dynamic subtest: pipe-A-eDP-1
[210.836749] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.509s)
[210.848092] Starting dynamic subtest: pipe-D-eDP-1
[214.031109] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.192s)
[214.033695] Subtest 64x64-top-bottom: SUCCESS (6.703s)
[214.907145] [052/156] (806s left) sysfs_preempt_timeout (idempotent)
[214.984582] Starting subtest: idempotent
[214.986951] Starting dynamic subtest: vecs0
[214.989182] Dynamic subtest vecs0: SUCCESS (0.000s)
[214.999935] Starting dynamic subtest: ccs0
[215.002196] Dynamic subtest ccs0: SUCCESS (0.000s)
[215.011799] Starting dynamic subtest: vcs0
[215.014080] Dynamic subtest vcs0: SUCCESS (0.000s)
[215.023314] Starting dynamic subtest: bcs0
[215.025575] Dynamic subtest bcs0: SUCCESS (0.000s)
[215.034985] Starting dynamic subtest: rcs0
[215.037173] Dynamic subtest rcs0: SUCCESS (0.000s)
[215.046922] Starting dynamic subtest: vcs1
[215.049231] Dynamic subtest vcs1: SUCCESS (0.000s)
[215.051078] Subtest idempotent: SUCCESS (0.006s)
[215.111962] [053/156] (806s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[215.211489] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[215.215822] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[215.322286] [054/156] (806s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[215.423585] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[215.428082] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[215.522536] [055/156] (806s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[215.577512] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[215.687467] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[215.777369] [056/156] (806s left) gen9_exec_parse (allowed-single)
[215.836933] Subtest allowed-single: SKIP (0.000s)
[215.910311] [057/156] (806s left) kms_color_pipeline (plane-ctm3x4)
[216.013082] Starting subtest: plane-ctm3x4
[216.181704] Starting dynamic subtest: pipe-A-plane-0
[216.326764] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[216.340543] Starting dynamic subtest: pipe-A-plane-1
[216.437435] Dynamic subtest pipe-A-plane-1: SUCCESS (0.111s)
[216.453118] Starting dynamic subtest: pipe-A-plane-2
[216.561569] Dynamic subtest pipe-A-plane-2: SUCCESS (0.121s)
[217.781168] Starting dynamic subtest: pipe-B-plane-0
[217.895293] Dynamic subtest pipe-B-plane-0: SUCCESS (0.122s)
[217.906625] Starting dynamic subtest: pipe-B-plane-1
[218.006188] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s)
[218.015860] Starting dynamic subtest: pipe-B-plane-2
[218.117170] Dynamic subtest pipe-B-plane-2: SUCCESS (0.109s)
[219.364453] Starting dynamic subtest: pipe-C-plane-0
[219.464128] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[219.474769] Starting dynamic subtest: pipe-C-plane-1
[219.575806] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[219.586610] Starting dynamic subtest: pipe-C-plane-2
[219.686279] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[220.864752] Starting dynamic subtest: pipe-D-plane-0
[220.967970] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[220.981455] Starting dynamic subtest: pipe-D-plane-1
[221.078368] Dynamic subtest pipe-D-plane-1: SUCCESS (0.109s)
[221.089959] Starting dynamic subtest: pipe-D-plane-2
[221.189745] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[221.476031] Subtest plane-ctm3x4: SUCCESS (5.464s)
[222.322522] [058/156] (799s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[222.419087] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[222.423621] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[222.501235] [059/156] (799s left) i915_drm_fdinfo (virtual-busy-idle-all)
[222.537707] Starting subtest: virtual-busy-idle-all
[222.542329] Subtest virtual-busy-idle-all: SKIP (0.000s)
[222.599649] [060/156] (799s left) gem_softpin (allocator-nopin-reserve)
[222.649730] Starting subtest: allocator-nopin-reserve
[222.731897] Subtest allocator-nopin-reserve: SUCCESS (0.082s)
[222.846522] [061/156] (799s left) kms_chamelium_frames (dp-crc-multiple)
[223.233462] Subtest dp-crc-multiple: SKIP (0.000s)
[224.090267] [062/156] (798s left) kms_pm_rpm (dpms-non-lpsp)
[225.605468] Starting subtest: dpms-non-lpsp
[225.610929] Subtest dpms-non-lpsp: SKIP (0.001s)
[226.348428] [063/156] (795s left) prime_busy (before)
[226.416616] Starting subtest: before
[226.421457] Starting dynamic subtest: rcs0
[226.444517] Dynamic subtest rcs0: SUCCESS (0.024s)
[226.454184] Starting dynamic subtest: bcs0
[226.492189] Dynamic subtest bcs0: SUCCESS (0.047s)
[226.501500] Starting dynamic subtest: vcs0
[226.532240] Dynamic subtest vcs0: SUCCESS (0.038s)
[226.543360] Starting dynamic subtest: vcs1
[226.571562] Dynamic subtest vcs1: SUCCESS (0.040s)
[226.581185] Starting dynamic subtest: vecs0
[226.612326] Dynamic subtest vecs0: SUCCESS (0.040s)
[226.624447] Starting dynamic subtest: ccs0
[226.656292] Dynamic subtest ccs0: SUCCESS (0.043s)
[226.765073] Subtest before: SUCCESS (0.346s)
[226.843659] [064/156] (795s left) gem_mmap_offset (open-flood)
[226.903272] Starting subtest: open-flood
[248.389930] Subtest open-flood: SUCCESS (21.489s)
[248.498818] [065/156] (773s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[248.602104] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[248.630681] Starting dynamic subtest: pipe-A-plane-0
[248.919760] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[248.931085] Starting dynamic subtest: pipe-A-plane-3
[249.152517] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[250.255351] Starting dynamic subtest: pipe-B-plane-0
[250.536110] Dynamic subtest pipe-B-plane-0: SUCCESS (0.288s)
[250.549186] Starting dynamic subtest: pipe-B-plane-3
[250.769461] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[251.089459] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.487s)
[251.903947] [066/156] (770s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[251.999783] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[252.004319] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[252.096128] [067/156] (770s left) gen7_exec_parse (basic-allocation)
[252.163082] Subtest basic-allocation: SKIP (0.000s)
[252.237947] [068/156] (770s left) kms_draw_crc (draw-method-mmap-cpu)
[252.329738] Starting subtest: draw-method-mmap-cpu
[252.331598] Starting dynamic subtest: xrgb8888-untiled
[252.561616] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[252.572272] Starting dynamic subtest: rgb565-untiled
[252.772627] Dynamic subtest rgb565-untiled: SUCCESS (0.209s)
[252.786736] Starting dynamic subtest: xrgb2101010-untiled
[252.983266] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[252.993385] Starting dynamic subtest: xbgr16161616f-untiled
[253.194473] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[253.203932] Starting dynamic subtest: xrgb8888-xtiled
[253.327851] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[253.338525] Starting dynamic subtest: rgb565-xtiled
[253.450337] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[253.468347] Starting dynamic subtest: xrgb2101010-xtiled
[253.583056] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s)
[253.593332] Starting dynamic subtest: xbgr16161616f-xtiled
[253.705543] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[253.715503] Starting dynamic subtest: xrgb8888-4tiled
[253.838937] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[253.848891] Starting dynamic subtest: rgb565-4tiled
[253.972120] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[253.983083] Starting dynamic subtest: xrgb2101010-4tiled
[254.105297] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[254.114931] Starting dynamic subtest: xbgr16161616f-4tiled
[254.249832] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[254.251673] Subtest draw-method-mmap-cpu: SUCCESS (1.922s)
[254.342983] [069/156] (768s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[254.441426] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[254.444861] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[254.533628] [070/156] (767s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[254.639548] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[254.643120] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[254.733924] [071/156] (767s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[254.814054] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[254.815865] Starting dynamic subtest: pipe-A-eDP-1
[271.097543] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.437s)
[271.108487] Starting dynamic subtest: pipe-B-eDP-1
[288.063565] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.418s)
[288.075601] Starting dynamic subtest: pipe-C-eDP-1
[305.038467] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.337s)
[305.049350] Starting dynamic subtest: pipe-D-eDP-1
[322.048697] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.377s)
[322.050560] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.573s)
[323.301124] [072/156] (699s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-blt)
[323.407881] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-blt
[323.412461] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[323.517647] [073/156] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[323.619537] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[323.623594] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[323.725400] [074/156] (698s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[323.830183] Starting subtest: psr-modesetfrombusy
[329.983359] Subtest psr-modesetfrombusy: SUCCESS (6.163s)
[330.125250] [075/156] (692s left) kms_properties (crtc-properties-atomic)
[330.226970] Starting subtest: crtc-properties-atomic
[330.228936] Starting dynamic subtest: pipe-A-eDP-1
[330.671754] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[330.683832] Starting dynamic subtest: pipe-B-eDP-1
[331.838105] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.162s)
[331.848828] Starting dynamic subtest: pipe-C-eDP-1
[333.023817] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s)
[333.035597] Starting dynamic subtest: pipe-D-eDP-1
[334.228051] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.201s)
[334.229974] Subtest crtc-properties-atomic: SUCCESS (4.002s)
[335.107419] [076/156] (687s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[335.176840] Starting subtest: y-tiled-to-vebox-y-tiled
[335.180962] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[335.363461] [077/156] (687s left) syncobj_basic (bad-fd-to-handle)
[335.413939] Starting subtest: bad-fd-to-handle
[335.417510] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[335.521155] [078/156] (687s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite)
[335.617731] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite
[335.621805] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[335.712046] [079/156] (687s left) gem_pxp (create-valid-protected-context)
[335.833195] Starting subtest: create-valid-protected-context
[335.835951] Subtest create-valid-protected-context: SUCCESS (0.001s)
[335.941566] [080/156] (687s left) gem_mmap_gtt (medium-copy-odd)
[336.009279] Subtest medium-copy-odd: SKIP (0.000s)
[336.069781] [081/156] (686s left) syncobj_timeline (signal-point-0)
[336.124775] Starting subtest: signal-point-0
[336.126623] Subtest signal-point-0: SUCCESS (0.000s)
[336.240378] [082/156] (686s left) gem_close_race (multigpu-basic-process)
[336.294840] Starting subtest: multigpu-basic-process
[336.299257] Subtest multigpu-basic-process: SKIP (0.000s)
[336.539688] [083/156] (686s left) kms_vrr (flipline)
[336.634250] Starting subtest: flipline
[336.640962] Subtest flipline: SKIP (0.000s)
[336.709371] [084/156] (686s left) prime_self_import (basic-with_one_bo_two_files)
[336.743090] Starting subtest: basic-with_one_bo_two_files
[336.755941] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s)
[336.863874] [085/156] (686s left) kms_atomic (plane-invalid-params-fence)
[336.956301] Starting subtest: plane-invalid-params-fence
[336.958606] Starting dynamic subtest: pipe-A-eDP-1
[337.327402] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.372s)
[337.329693] Subtest plane-invalid-params-fence: SUCCESS (0.373s)
[338.198582] [086/156] (684s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[338.295171] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[344.684116] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.395s)
[344.798542] [087/156] (678s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt)
[344.899743] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt
[344.903916] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[345.007193] [088/156] (678s left) i915_query (test-query-geometry-subslices)
[345.056255] Starting subtest: test-query-geometry-subslices
[345.058178] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[345.169063] [089/156] (678s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[345.263062] Starting subtest: fbc-rgb565-draw-blt
[349.414006] Subtest fbc-rgb565-draw-blt: SUCCESS (4.158s)
[350.594930] [090/156] (672s left) gem_ctx_persistence (idempotent)
[350.660745] Starting subtest: idempotent
[350.663659] Subtest idempotent: SUCCESS (0.000s)
[350.762809] [091/156] (672s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[350.873797] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[351.832289] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.959s)
[352.694429] [092/156] (670s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[352.799469] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[352.803837] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[352.927296] [093/156] (670s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[353.022083] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[353.026522] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[353.105853] [094/156] (670s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[353.155681] Starting subtest: multi-wait-available-submitted-signaled
[353.158149] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[353.280318] [095/156] (670s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[353.404558] Starting subtest: cursorB-vs-flipA-atomic-transitions
[353.408869] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[353.550413] [096/156] (670s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[353.639569] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[353.641509] Starting dynamic subtest: pipe-A
[354.689131] Dynamic subtest pipe-A: SUCCESS (1.050s)
[354.700162] Starting dynamic subtest: pipe-B
[356.865221] Dynamic subtest pipe-B: SUCCESS (2.174s)
[356.877757] Starting dynamic subtest: pipe-C
[358.029538] Dynamic subtest pipe-C: SUCCESS (1.162s)
[358.039656] Starting dynamic subtest: pipe-D
[359.228451] Dynamic subtest pipe-D: SUCCESS (1.197s)
[359.230810] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.587s)
[360.392633] [097/156] (663s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[360.453087] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[360.557699] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[360.636104] [098/156] (663s left) drm_read (empty-nonblock)
[360.774685] Starting subtest: empty-nonblock
[360.777146] Subtest empty-nonblock: SUCCESS (0.000s)
[360.917965] [099/156] (662s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[361.015082] Starting subtest: fbc-psr2-primary-mmap-gtt
[361.017270] Starting dynamic subtest: eDP-1
[361.021240] Dynamic subtest eDP-1: SKIP (0.000s)
[361.025115] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[361.090792] [100/156] (662s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[361.204565] Starting subtest: 2x-long-flip-vs-cursor-atomic
[361.208953] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[361.348550] [101/156] (662s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[361.434855] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[361.436974] Starting dynamic subtest: pipe-A
[361.453688] Dynamic subtest pipe-A: SKIP (0.016s)
[361.467026] Starting dynamic subtest: pipe-B
[361.488314] Dynamic subtest pipe-B: SKIP (0.032s)
[361.498605] Starting dynamic subtest: pipe-C
[361.514955] Dynamic subtest pipe-C: SKIP (0.028s)
[361.525422] Starting dynamic subtest: pipe-D
[361.544766] Dynamic subtest pipe-D: SKIP (0.028s)
[361.548888] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.107s)
[361.652959] [102/156] (662s left) kms_psr (psr2-sprite-plane-onoff)
[361.733917] Starting subtest: psr2-sprite-plane-onoff
[361.735798] Starting dynamic subtest: eDP-1
[363.486488] Dynamic subtest eDP-1: SUCCESS (1.752s)
[363.488866] Subtest psr2-sprite-plane-onoff: SUCCESS (1.753s)
[364.284770] [103/156] (659s left) api_intel_bb (full-batch)
[364.344630] Starting subtest: full-batch
[364.350291] Subtest full-batch: SUCCESS (0.006s)
[364.481437] [104/156] (659s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-blt)
[364.582569] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-blt
[364.586733] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[364.660336] [105/156] (659s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[364.762811] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[364.767232] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[364.882497] [106/156] (659s left) kms_flip (dpms-vs-vblank-race)
[364.982775] Starting subtest: dpms-vs-vblank-race
[364.985606] Starting dynamic subtest: A-eDP1
[368.854823] Dynamic subtest A-eDP1: SUCCESS (3.870s)
[368.865290] Starting dynamic subtest: B-eDP1
[372.364278] Dynamic subtest B-eDP1: SUCCESS (3.506s)
[372.374697] Starting dynamic subtest: C-eDP1
[375.852095] Dynamic subtest C-eDP1: SUCCESS (3.483s)
[375.863009] Starting dynamic subtest: D-eDP1
[379.365185] Dynamic subtest D-eDP1: SUCCESS (3.513s)
[379.367599] Subtest dpms-vs-vblank-race: SUCCESS (14.384s)
[380.190010] [107/156] (643s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[380.287400] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[380.289690] Starting dynamic subtest: pipe-A-eDP-1
[380.348918] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[380.358944] Starting dynamic subtest: pipe-B-eDP-1
[380.416602] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[380.427717] Starting dynamic subtest: pipe-C-eDP-1
[380.485750] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[380.496879] Starting dynamic subtest: pipe-D-eDP-1
[380.553579] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[380.558051] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[382.500857] [108/156] (641s left) dumb_buffer (map-invalid-size)
[382.557613] Starting subtest: map-invalid-size
[382.559591] Subtest map-invalid-size: SUCCESS (0.000s)
[382.665653] [109/156] (641s left) kms_frontbuffer_tracking (psrhdr-shrfb-scaledprimary)
[382.769597] Starting subtest: psrhdr-shrfb-scaledprimary
[382.773854] Subtest psrhdr-shrfb-scaledprimary: SKIP (0.000s)
[382.857245] [110/156] (641s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[382.965898] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[382.970458] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[383.082668] [111/156] (641s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[383.140828] Starting subtest: invalid-multi-wait-unsubmitted
[383.143126] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[383.228419] [112/156] (641s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[383.342780] Starting subtest: 2x-long-cursor-vs-flip-atomic
[383.347268] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[383.485432] [113/156] (640s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-blt)
[383.583065] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-blt
[383.586413] Subtest hdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[383.680217] [114/156] (640s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite)
[383.778037] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite
[383.781407] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[383.900017] [115/156] (640s left) kms_fbcon_fbt (psr)
[383.957647] Starting subtest: psr
[391.472888] Subtest psr: SUCCESS (7.513s)
[391.549723] [116/156] (632s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[391.935618] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[392.777463] [117/156] (631s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[392.884487] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[392.886608] Starting dynamic subtest: pipe-A-eDP-1
[392.959116] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[392.976273] Starting dynamic subtest: pipe-B-eDP-1
[394.141844] Dynamic subtest pipe-B-eDP-1: SKIP (1.180s)
[394.146259] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.261s)
[395.394967] [118/156] (629s left) gem_mmap_gtt (close-race)
[395.444737] Subtest close-race: SKIP (0.000s)
[395.511447] [119/156] (629s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[395.605334] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[395.609558] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[395.730232] [120/156] (628s left) kms_flip (2x-flip-vs-panning)
[395.828489] Starting subtest: 2x-flip-vs-panning
[395.839971] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[395.923712] [121/156] (628s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[396.046313] Starting subtest: basic-busy-flip-before-cursor-atomic
[396.050808] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[396.204203] [122/156] (628s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move)
[396.312948] Starting subtest: hdr-2p-scndscrn-cur-indfb-move
[396.317196] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[396.431456] [123/156] (628s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[396.535659] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[401.962620] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.431s)
[403.111833] [124/156] (621s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[403.207734] Starting subtest: yf-tiled-64bpp-rotate-270
[403.211960] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[403.309337] [125/156] (621s left) gem_madvise (dontneed-before-exec)
[403.345473] Starting subtest: dontneed-before-exec
[403.360984] Subtest dontneed-before-exec: SKIP (0.014s)
[403.426682] [126/156] (621s left) kms_display_modes (extended-mode-basic)
[403.516352] Starting subtest: extended-mode-basic
[403.520664] Subtest extended-mode-basic: SKIP (0.000s)
[403.565678] [127/156] (621s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[403.664799] Starting subtest: 4-tiled-8bpp-rotate-180
[404.868871] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.203s)
[404.976332] [128/156] (620s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[405.058668] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[405.062049] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[405.134057] [129/156] (619s left) gem_softpin (evict-active-interruptible)
[405.192450] Starting subtest: evict-active-interruptible
[405.198544] Subtest evict-active-interruptible: SUCCESS (0.006s)
[405.317124] [130/156] (619s left) kms_lease (possible-crtcs-filtering)
[405.412616] Starting subtest: possible-crtcs-filtering
[405.416347] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[405.509918] [131/156] (619s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[405.607966] Starting subtest: pr-cursor-plane-update-sf
[405.611862] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[405.689220] [132/156] (619s left) sw_sync (sync_merge)
[405.721030] Starting subtest: sync_merge
[405.722513] Subtest sync_merge: SUCCESS (0.000s)
[405.773154] [133/156] (619s left) kms_content_protection (uevent)
[405.911455] Starting subtest: uevent
[405.915265] Subtest uevent: SKIP (0.000s)
[406.026092] [134/156] (619s left) kms_getfb (getfb-addfb-different-handles)
[406.112744] Starting subtest: getfb-addfb-different-handles
[406.114670] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[406.210669] [135/156] (619s left) gem_eio (create)
[406.425330] Starting subtest: create
[406.759877] Subtest create: SUCCESS (0.332s)
[406.914683] [136/156] (618s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[407.004177] Starting subtest: addfb25-y-tiled-legacy
[407.005799] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[407.089719] [137/156] (618s left) kms_force_connector_basic (force-load-detect)
[407.160498] Starting subtest: force-load-detect
[407.164284] Subtest force-load-detect: SKIP (0.000s)
[407.275070] [138/156] (618s left) syncobj_timeline (invalid-signal-bad-pad)
[407.322851] Starting subtest: invalid-signal-bad-pad
[407.324848] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[407.430851] [139/156] (618s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[407.518681] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[407.522295] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[407.617273] [140/156] (617s left) gem_lmem_swapping (massive-random)
[407.654582] Subtest massive-random: SKIP (0.000s)
[407.699121] [141/156] (617s left) kms_selftest (drm_plane_helper)
[407.736385] Starting subtest: drm_plane_helper
[407.781245] Starting dynamic subtest: drm_test_check_plane_state
[407.878158] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.096s)
[407.889194] Starting dynamic subtest: drm_test_check_invalid_plane_state
[407.980685] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.104s)
[407.982787] Subtest drm_plane_helper: SUCCESS (0.246s)
[408.147076] [142/156] (617s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[408.243733] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[408.247402] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[408.327802] [143/156] (617s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[408.432113] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[408.435597] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[408.537350] [144/156] (617s left) kms_invalid_mode (bad-vsync-start)
[408.633681] Starting subtest: bad-vsync-start
[408.635580] Starting dynamic subtest: pipe-A-eDP-1
[408.915584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[408.926876] Starting dynamic subtest: pipe-B-eDP-1
[408.928814] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[408.939491] Starting dynamic subtest: pipe-C-eDP-1
[408.941678] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[408.952202] Starting dynamic subtest: pipe-D-eDP-1
[408.954404] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[408.956618] Subtest bad-vsync-start: SUCCESS (0.288s)
[409.786716] [145/156] (615s left) kms_addfb_basic (unused-modifier)
[409.836398] Starting subtest: unused-modifier
[409.838312] Subtest unused-modifier: SUCCESS (0.000s)
[409.986146] [146/156] (615s left) gem_exec_flush (basic-wb-prw-default)
[410.051499] Starting subtest: basic-wb-prw-default
[415.511380] Subtest basic-wb-prw-default: SUCCESS (5.460s)
[415.714777] [147/156] (610s left) kms_flip (blocking-absolute-wf_vblank)
[415.818005] Starting subtest: blocking-absolute-wf_vblank
[415.820472] Starting dynamic subtest: A-eDP1
[424.525011] Dynamic subtest A-eDP1: SUCCESS (8.706s)
[424.541760] Starting dynamic subtest: B-eDP1
[433.223456] Dynamic subtest B-eDP1: SUCCESS (8.694s)
[433.238718] Starting dynamic subtest: C-eDP1
[441.905348] Dynamic subtest C-eDP1: SUCCESS (8.679s)
[441.918799] Starting dynamic subtest: D-eDP1
[450.601301] Dynamic subtest D-eDP1: SUCCESS (8.694s)
[450.606620] Subtest blocking-absolute-wf_vblank: SUCCESS (34.786s)
[451.794634] [148/156] (574s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[451.898895] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[451.903404] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[452.002019] [149/156] (573s left) kms_psr (fbc-psr-sprite-blt)
[452.092233] Starting subtest: fbc-psr-sprite-blt
[452.094506] Starting dynamic subtest: eDP-1
[452.098551] Dynamic subtest eDP-1: SKIP (0.000s)
[452.102654] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[452.170003] [150/156] (573s left) vgem_basic (dmabuf-export)
[452.217881] Starting subtest: dmabuf-export
[452.254979] Subtest dmabuf-export: SUCCESS (0.038s)
[452.357672] [151/156] (573s left) kms_chamelium_color (ctm-0-50)
[452.449599] Subtest ctm-0-50: SKIP (0.000s)
[452.496637] [152/156] (573s left) perf_pmu (busy-idle-check-all)
[452.532044] Starting subtest: busy-idle-check-all
[452.534335] Starting dynamic subtest: rcs0
[453.194930] Dynamic subtest rcs0: SUCCESS (0.662s)
[453.207937] Starting dynamic subtest: bcs0
[453.847867] Dynamic subtest bcs0: SUCCESS (0.651s)
[453.862069] Starting dynamic subtest: vcs0
[454.970989] Dynamic subtest vcs0: SUCCESS (1.103s)
[454.982191] Starting dynamic subtest: vcs1
[456.937691] Dynamic subtest vcs1: SUCCESS (1.982s)
[456.949324] Starting dynamic subtest: vecs0
[458.922246] Dynamic subtest vecs0: SUCCESS (1.982s)
[458.935905] Starting dynamic subtest: ccs0
[459.580720] Dynamic subtest ccs0: SUCCESS (0.657s)
[459.583363] Subtest busy-idle-check-all: SUCCESS (7.049s)
[459.710870] [153/156] (566s left) gem_exec_balancer (bonded-true-hang)
[459.969099] Starting subtest: bonded-true-hang
[459.973576] Subtest bonded-true-hang: SKIP (0.000s)
[460.081164] [154/156] (566s left) kms_cursor_crc (cursor-random-256x256)
[460.333090] Starting subtest: cursor-random-256x256
[460.337915] Starting dynamic subtest: pipe-A-eDP-1
[463.661193] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.322s)
[463.692573] Starting dynamic subtest: pipe-D-eDP-1
[467.653718] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.972s)
[467.656224] Subtest cursor-random-256x256: SUCCESS (7.320s)
[468.492615] [155/156] (557s left) kms_rotation_crc (primary-rotation-180)
[468.602992] Starting subtest: primary-rotation-180
[475.582370] Subtest primary-rotation-180: SUCCESS (6.981s)
[476.792243] [156/156] (549s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[476.914329] Starting subtest: flip-vs-cursor-busy-crc-atomic
[477.607090] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.692s)
[478.481628] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: i915_drm_fdinfo
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: i915_pm_rpm
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: kms_vrr
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: kms_pipe_crc_basic
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: gem_pipe_control_store_loop
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: gem_exec_whisper
results: parsing output: 28/ for test: gem_basic
results: parsing output: 29/ for test: kms_rotation_crc
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: gem_busy
results: parsing output: 32/ for test: kms_pipe_b_c_ivb
results: parsing output: 33/ for test: kms_force_connector_basic
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_balancer
results: parsing output: 36/ for test: kms_psr2_su
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: api_intel_allocator
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_mmap_wc
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_busy
results: parsing output: 48/ for test: gem_reg_read
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_cursor_edge_walk
results: parsing output: 51/ for test: sysfs_preempt_timeout
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: kms_color_pipeline
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: i915_drm_fdinfo
results: parsing output: 59/ for test: gem_softpin
results: parsing output: 60/ for test: kms_chamelium_frames
results: parsing output: 61/ for test: kms_pm_rpm
results: parsing output: 62/ for test: prime_busy
results: parsing output: 63/ for test: gem_mmap_offset
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gen7_exec_parse
results: parsing output: 67/ for test: kms_draw_crc
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_frontbuffer_tracking
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_properties
results: parsing output: 75/ for test: gem_render_copy
results: parsing output: 76/ for test: syncobj_basic
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_pxp
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_close_race
results: parsing output: 82/ for test: kms_vrr
results: parsing output: 83/ for test: prime_self_import
results: parsing output: 84/ for test: kms_atomic
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: i915_query
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: drm_read
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: api_intel_bb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: dumb_buffer
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_fbcon_fbt
results: parsing output: 115/ for test: kms_chamelium_hpd
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_madvise
results: parsing output: 125/ for test: kms_display_modes
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: gem_softpin
results: parsing output: 129/ for test: kms_lease
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: sw_sync
results: parsing output: 132/ for test: kms_content_protection
results: parsing output: 133/ for test: kms_getfb
results: parsing output: 134/ for test: gem_eio
results: parsing output: 135/ for test: kms_addfb_basic
results: parsing output: 136/ for test: kms_force_connector_basic
results: parsing output: 137/ for test: syncobj_timeline
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_lmem_swapping
results: parsing output: 140/ for test: kms_selftest
results: parsing output: 141/ for test: kms_flip_scaled_crc
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_invalid_mode
results: parsing output: 144/ for test: kms_addfb_basic
results: parsing output: 145/ for test: gem_exec_flush
results: parsing output: 146/ for test: kms_flip
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_psr
results: parsing output: 149/ for test: vgem_basic
results: parsing output: 150/ for test: kms_chamelium_color
results: parsing output: 151/ for test: perf_pmu
results: parsing output: 152/ for test: gem_exec_balancer
results: parsing output: 153/ for test: kms_cursor_crc
results: parsing output: 154/ for test: kms_rotation_crc
results: parsing output: 155/ for test: kms_cursor_legacy
Done.