[71.914949] Initializing watchdogs
[71.914994]   /dev/watchdog0
[71.930192] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[71.934130] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.936250] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.940119] [001/154] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[72.046197] Starting subtest: fbcpsrhdr-tiling-4
[72.050403] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[72.147087] [002/154] (960s left) prime_self_import (basic-with_one_bo_two_files)
[72.185900] Starting subtest: basic-with_one_bo_two_files
[72.223759] Subtest basic-with_one_bo_two_files: SUCCESS (0.041s)
[72.460917] [003/154] (960s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[72.577575] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[72.582450] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[72.949769] [004/154] (959s left) kms_color (ctm-0-75)
[73.033710] Starting subtest: ctm-0-75
[73.036087] Starting dynamic subtest: pipe-A-eDP-1
[78.062074] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.034s)
[78.070546] Starting dynamic subtest: pipe-B-eDP-1
[83.771189] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.714s)
[83.779511] Starting dynamic subtest: pipe-C-eDP-1
[89.142061] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.368s)
[89.151844] Starting dynamic subtest: pipe-D-eDP-1
[94.453801] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.313s)
[94.456178] Subtest ctm-0-75: SUCCESS (21.430s)
[95.293969] [005/154] (937s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[95.354132] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[95.458784] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[95.535912] [006/154] (937s left) gem_exec_schedule (preempt-queue-contexts-chain)
[95.616443] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[95.898821] [007/154] (936s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-blt)
[95.982174] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-blt
[95.986184] Subtest fbchdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[96.080014] [008/154] (936s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[96.169223] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[96.837318] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.670s)
[97.021115] [009/154] (935s left) kms_psr (psr2-sprite-blt)
[97.098339] Starting subtest: psr2-sprite-blt
[97.100608] Starting dynamic subtest: eDP-1
[98.884666] Dynamic subtest eDP-1: SUCCESS (1.784s)
[98.886576] Subtest psr2-sprite-blt: SUCCESS (1.784s)
[99.739254] [010/154] (933s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[99.837663] Starting subtest: cursorA-vs-flipA-atomic-transitions
[111.023068] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.183s)
[111.867358] [011/154] (920s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[111.945953] Starting subtest: fbc-psr2-cursor-plane-onoff
[111.948278] Starting dynamic subtest: eDP-1
[111.952212] Dynamic subtest eDP-1: SKIP (0.000s)
[111.956191] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[112.016755] [012/154] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[112.102446] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[115.989910] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.894s)
[117.189897] [013/154] (915s left) prime_self_import (export-vs-gem_close-race)
[117.225544] Starting subtest: export-vs-gem_close-race
[122.308365] Subtest export-vs-gem_close-race: SUCCESS (5.082s)
[122.383463] [014/154] (910s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[122.456797] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[122.461064] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[122.527803] [015/154] (910s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[122.613839] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[122.618448] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[122.733788] [016/154] (910s left) kms_frontbuffer_tracking (psrhdr-modesetfrombusy)
[122.819015] Starting subtest: psrhdr-modesetfrombusy
[122.823198] Subtest psrhdr-modesetfrombusy: SKIP (0.000s)
[122.914645] [017/154] (910s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[122.998096] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[123.625093] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.625s)
[123.803154] [018/154] (909s left) kms_pm_rpm (drm-resources-equal)
[125.397788] Starting subtest: drm-resources-equal
[130.656651] Subtest drm-resources-equal: SUCCESS (5.257s)
[130.774560] [019/154] (902s left) kms_psr (fbc-pr-primary-mmap-cpu)
[130.850978] Starting subtest: fbc-pr-primary-mmap-cpu
[130.855538] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[130.919547] [020/154] (902s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[130.995474] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[130.999740] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[131.094042] [021/154] (902s left) gem_mmap_wc (read)
[131.149433] Subtest read: SKIP (0.000s)
[131.199460] [022/154] (902s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[131.282201] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[131.286302] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[131.371983] [023/154] (901s left) gem_create (create-massive)
[131.420035] Starting subtest: create-massive
[131.421936] Subtest create-massive: SUCCESS (0.000s)
[131.600264] [024/154] (901s left) kms_rotation_crc (exhaust-fences)
[131.678991] Starting subtest: exhaust-fences
[131.683520] Subtest exhaust-fences: SKIP (0.000s)
[131.762754] [025/154] (901s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[131.844747] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[132.623962] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.781s)
[132.757257] [026/154] (900s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[132.839317] Starting subtest: y-tiled-32bpp-rotate-90
[132.844033] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[132.946409] [027/154] (900s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[133.020918] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[133.023213] Starting dynamic subtest: pipe-A-eDP-1
[133.079900] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[133.087538] Starting dynamic subtest: pipe-B-eDP-1
[133.145073] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[133.155328] Starting dynamic subtest: pipe-C-eDP-1
[133.212822] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[133.222259] Starting dynamic subtest: pipe-D-eDP-1
[133.280189] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[133.284782] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[135.376376] [028/154] (898s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render)
[135.473210] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render
[135.477141] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[135.576920] [029/154] (897s left) gem_ctx_persistence (heartbeat-close)
[135.628547] Starting subtest: heartbeat-close
[135.632942] Subtest heartbeat-close: SKIP (0.000s)
[135.727888] [030/154] (897s left) gem_exec_whisper (basic-fds-forked)
[135.789500] Starting subtest: basic-fds-forked
[159.899328] Subtest basic-fds-forked: SUCCESS (24.076s)
[160.056474] [031/154] (873s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[160.111278] Starting subtest: etime-multi-wait-all-submitted-signaled
[160.218605] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[160.291544] [032/154] (873s left) gem_ctx_param (non-root-set)
[160.338068] Starting subtest: non-root-set
[160.353390] Subtest non-root-set: SUCCESS (0.015s)
[160.440578] [033/154] (873s left) kms_flip (2x-plain-flip-interruptible)
[160.529061] Starting subtest: 2x-plain-flip-interruptible
[160.537652] Subtest 2x-plain-flip-interruptible: SKIP (0.008s)
[160.610531] [034/154] (873s left) kms_atomic_transition (plane-all-transition-fencing)
[160.694586] Starting subtest: plane-all-transition-fencing
[160.696867] Starting dynamic subtest: pipe-A-eDP-1
[163.191434] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[163.510592] Starting dynamic subtest: pipe-B-eDP-1
[166.724714] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.223s)
[167.026527] Subtest plane-all-transition-fencing: SUCCESS (6.330s)
[167.866073] [035/154] (865s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[167.953642] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[167.958253] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[168.051713] [036/154] (865s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-move)
[168.140671] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-move
[168.145072] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[168.233739] [037/154] (865s left) gem_exec_fence (syncobj-channel)
[168.714635] Starting subtest: syncobj-channel
[169.737763] Subtest syncobj-channel: SUCCESS (1.019s)
[170.312599] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[170.316181] [038/154] (863s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[170.391479] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[174.794706] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.408s)
[175.942532] [039/154] (858s left) kms_frontbuffer_tracking (fbchdr-tiling-y)
[176.018101] Starting subtest: fbchdr-tiling-y
[176.022292] Subtest fbchdr-tiling-y: SKIP (0.000s)
[176.132166] [040/154] (857s left) kms_dp_linktrain_fallback (dp-fallback)
[176.204266] Starting subtest: dp-fallback
[176.211070] Subtest dp-fallback: SKIP (0.000s)
[176.280514] [041/154] (857s left) perf_pmu (interrupts)
[176.321755] Starting subtest: interrupts
[177.396418] Subtest interrupts: SUCCESS (1.072s)
[177.513322] [042/154] (856s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[177.608938] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[177.613378] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[177.759999] [043/154] (856s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-render)
[177.841239] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-render
[177.845285] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[177.966938] [044/154] (856s left) kms_addfb_basic (bad-pitch-0)
[178.026977] Starting subtest: bad-pitch-0
[178.029235] Subtest bad-pitch-0: SUCCESS (0.000s)
[178.138318] [045/154] (856s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[178.216582] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[178.218859] Starting dynamic subtest: pipe-A-eDP-1
[178.241831] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[178.253369] Starting dynamic subtest: pipe-B-eDP-1
[178.275369] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[178.284076] Starting dynamic subtest: pipe-C-eDP-1
[178.305981] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[178.314478] Starting dynamic subtest: pipe-D-eDP-1
[178.336712] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[178.340794] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[180.512094] [046/154] (853s left) kms_hdr (static-swap)
[180.580205] Starting subtest: static-swap
[180.582507] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[180.586986] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[180.598416] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[180.602475] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[180.606749] Subtest static-swap: SKIP (0.003s)
[180.651926] [047/154] (853s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[180.737705] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[180.741886] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[180.833141] [048/154] (853s left) api_intel_bb (intel-bb-blit-x)
[180.883927] Starting subtest: intel-bb-blit-x
[184.470893] Subtest intel-bb-blit-x: SUCCESS (3.585s)
[184.585103] [049/154] (849s left) kms_scaling_modes (scaling-mode-none)
[184.669132] Starting subtest: scaling-mode-none
[184.670961] Starting dynamic subtest: pipe-A-eDP-1
[184.765783] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s)
[184.775944] Starting dynamic subtest: pipe-B-eDP-1
[184.798470] Dynamic subtest pipe-B-eDP-1: SKIP (0.031s)
[184.808151] Starting dynamic subtest: pipe-C-eDP-1
[184.830384] Dynamic subtest pipe-C-eDP-1: SKIP (0.031s)
[184.840253] Starting dynamic subtest: pipe-D-eDP-1
[184.862329] Dynamic subtest pipe-D-eDP-1: SKIP (0.031s)
[184.866678] Subtest scaling-mode-none: SKIP (0.193s)
[184.966360] [050/154] (849s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[185.041809] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[185.044100] Starting dynamic subtest: pipe-A-eDP-1
[185.066814] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[185.076788] Starting dynamic subtest: pipe-B-eDP-1
[185.098807] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[185.108228] Starting dynamic subtest: pipe-C-eDP-1
[185.130084] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[185.138691] Starting dynamic subtest: pipe-D-eDP-1
[185.160990] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[185.165118] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[187.360919] [051/154] (847s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[187.454598] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[187.458688] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[187.547441] [052/154] (846s left) syncobj_wait (invalid-signal-one-illegal-handle)
[187.611522] Starting subtest: invalid-signal-one-illegal-handle
[187.614030] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[187.706322] [053/154] (846s left) kms_addfb_basic (bad-pitch-256)
[187.757108] Starting subtest: bad-pitch-256
[187.759036] Subtest bad-pitch-256: SUCCESS (0.000s)
[187.876412] [054/154] (846s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[187.962894] Starting subtest: dsc-fractional-bpp-with-bpc
[187.992952] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[188.052259] [055/154] (846s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[188.416419] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[189.285696] [056/154] (845s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[189.503842] Starting subtest: cursor-rapid-movement-256x256
[189.506523] Starting dynamic subtest: pipe-A-eDP-1
[190.061973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[190.091205] Starting dynamic subtest: pipe-D-eDP-1
[191.304742] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[191.307384] Subtest cursor-rapid-movement-256x256: SUCCESS (1.803s)
[192.166336] [057/154] (842s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[192.246661] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[192.250790] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[192.352635] [058/154] (842s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[192.401481] Starting subtest: multi-wait-available-unsubmitted-signaled
[192.403726] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[192.499540] [059/154] (842s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[192.565837] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[192.570423] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[192.668103] [060/154] (842s left) kms_flip (nonexisting-fb)
[192.738106] Starting subtest: nonexisting-fb
[192.740471] Starting dynamic subtest: A-eDP1
[193.950275] Dynamic subtest A-eDP1: SUCCESS (1.213s)
[193.959237] Starting dynamic subtest: B-eDP1
[195.080417] Dynamic subtest B-eDP1: SUCCESS (1.129s)
[195.089796] Starting dynamic subtest: C-eDP1
[196.219845] Dynamic subtest C-eDP1: SUCCESS (1.138s)
[196.230035] Starting dynamic subtest: D-eDP1
[197.349280] Dynamic subtest D-eDP1: SUCCESS (1.128s)
[197.351686] Subtest nonexisting-fb: SUCCESS (4.616s)
[198.514317] [061/154] (836s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[198.614809] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[198.618800] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[198.719037] [062/154] (836s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt)
[198.791287] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt
[198.795496] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[198.881190] [063/154] (836s left) perf (enable-disable)
[199.013046] Starting subtest: enable-disable
[199.015255] Starting dynamic subtest: 0-rcs0
[201.281766] Dynamic subtest 0-rcs0: SUCCESS (2.268s)
[201.292403] Starting dynamic subtest: 1-vcs0
[205.773340] Dynamic subtest 1-vcs0: SUCCESS (4.490s)
[205.775669] Subtest enable-disable: SUCCESS (6.760s)
[205.821859] [064/154] (829s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[205.908450] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[205.910770] Starting dynamic subtest: pipe-A-default-mode
[208.675994] Dynamic subtest pipe-A-default-mode: SUCCESS (2.764s)
[208.678717] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.765s)
[209.530054] [065/154] (825s left) kms_psr (pr-cursor-render)
[209.615217] Starting subtest: pr-cursor-render
[209.619301] Subtest pr-cursor-render: SKIP (0.000s)
[209.686071] [066/154] (825s left) prime_mmap (test_errors)
[209.736212] Starting subtest: test_errors
[209.738420] Starting dynamic subtest: test_errors-smem
[209.828589] Dynamic subtest test_errors-smem: SUCCESS (0.093s)
[209.831050] Subtest test_errors: SUCCESS (0.094s)
[209.912438] [067/154] (825s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[209.993198] Starting subtest: addfb25-y-tiled-legacy
[209.995110] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[210.085566] [068/154] (825s left) gem_mmap_gtt (medium-copy-odd)
[210.135374] Subtest medium-copy-odd: SKIP (0.000s)
[210.192263] [069/154] (824s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[210.266054] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[216.920218] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.661s)
[217.051230] [070/154] (818s left) gen7_exec_parse (basic-offset)
[217.103151] Subtest basic-offset: SKIP (0.000s)
[217.167362] [071/154] (818s left) i915_pm_rc6_residency (rc6-fence)
[217.221316] Starting subtest: rc6-fence
[217.243724] Starting dynamic subtest: gt0
[229.561050] Dynamic subtest gt0: SUCCESS (12.316s)
[229.573530] Starting dynamic subtest: gt1
[244.159028] Dynamic subtest gt1: SUCCESS (14.593s)
[244.162061] Subtest rc6-fence: SUCCESS (26.939s)
[244.236476] [072/154] (791s left) gem_lmem_swapping (massive-random)
[244.280285] Subtest massive-random: SKIP (0.000s)
[244.322496] [073/154] (791s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[244.411726] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[251.811792] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.404s)
[251.958428] [074/154] (783s left) syncobj_timeline (wait-zero-handles)
[252.025864] Starting subtest: wait-zero-handles
[252.028190] Subtest wait-zero-handles: SUCCESS (0.000s)
[252.130407] [075/154] (783s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[252.210286] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[252.214185] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[252.309324] [076/154] (783s left) kms_cursor_crc (cursor-random-128x128)
[252.491355] Starting subtest: cursor-random-128x128
[252.496390] Starting dynamic subtest: pipe-A-eDP-1
[255.805404] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.309s)
[255.834979] Starting dynamic subtest: pipe-D-eDP-1
[259.844368] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.014s)
[259.846702] Subtest cursor-random-128x128: SUCCESS (7.351s)
[260.708358] [077/154] (774s left) gem_ctx_shared (exec-shared-gtt)
[260.773736] Starting subtest: exec-shared-gtt
[260.776254] Starting dynamic subtest: rcs0
[260.781692] Dynamic subtest rcs0: SUCCESS (0.007s)
[260.792301] Starting dynamic subtest: bcs0
[260.794127] Dynamic subtest bcs0: SUCCESS (0.007s)
[260.804653] Starting dynamic subtest: vcs0
[260.806739] Dynamic subtest vcs0: SUCCESS (0.007s)
[260.816584] Starting dynamic subtest: vcs1
[260.818799] Dynamic subtest vcs1: SUCCESS (0.007s)
[260.827826] Starting dynamic subtest: vecs0
[260.830022] Dynamic subtest vecs0: SUCCESS (0.005s)
[260.839076] Starting dynamic subtest: ccs0
[260.841161] Dynamic subtest ccs0: SUCCESS (0.005s)
[260.843213] Subtest exec-shared-gtt: SUCCESS (0.042s)
[261.000138] [078/154] (774s left) gem_pread (self)
[261.058562] Subtest self: SKIP (0.000s)
[261.123768] [079/154] (774s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[261.202890] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[261.206877] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[261.309496] [080/154] (774s left) kms_flip (flip-vs-expired-vblank)
[261.374924] Starting subtest: flip-vs-expired-vblank
[261.376816] Starting dynamic subtest: A-eDP1
[270.032359] Dynamic subtest A-eDP1: SUCCESS (8.658s)
[270.042620] Starting dynamic subtest: B-eDP1
[278.675591] Dynamic subtest B-eDP1: SUCCESS (8.642s)
[278.684984] Starting dynamic subtest: C-eDP1
[287.402979] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[287.413983] Starting dynamic subtest: D-eDP1
[296.035752] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[296.037913] Subtest flip-vs-expired-vblank: SUCCESS (34.665s)
[297.202252] [081/154] (738s left) sw_sync (timeline_closed_signaled)
[297.233641] Starting subtest: timeline_closed_signaled
[297.235847] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[297.289355] [082/154] (738s left) perf (non-sampling-read-error)
[297.385341] Starting subtest: non-sampling-read-error
[297.391427] Subtest non-sampling-read-error: SUCCESS (0.007s)
[297.435333] [083/154] (738s left) api_intel_allocator (reopen-fork)
[297.483464] Starting subtest: reopen-fork
[300.830209] Subtest reopen-fork: SUCCESS (3.348s)
[300.904015] [084/154] (734s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[300.978642] Starting subtest: plane-upscale-20x20-with-rotation
[300.980992] Starting dynamic subtest: pipe-A
[301.202770] Dynamic subtest pipe-A: SUCCESS (0.226s)
[301.212590] Starting dynamic subtest: pipe-B
[302.487511] Dynamic subtest pipe-B: SUCCESS (1.284s)
[302.497982] Starting dynamic subtest: pipe-C
[303.816679] Dynamic subtest pipe-C: SUCCESS (1.328s)
[303.828655] Starting dynamic subtest: pipe-D
[305.144377] Dynamic subtest pipe-D: SUCCESS (1.327s)
[305.146716] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.169s)
[306.339145] [085/154] (729s left) syncobj_timeline (invalid-transfer-non-existent-point)
[306.397963] Starting subtest: invalid-transfer-non-existent-point
[306.400410] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[306.486063] [086/154] (729s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[306.562599] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[306.566823] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[306.680773] [087/154] (729s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[306.757400] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[306.761744] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[306.858610] [088/154] (729s left) prime_vgem (coherency-gtt)
[306.931612] Starting subtest: coherency-gtt
[306.936175] Subtest coherency-gtt: SKIP (0.000s)
[307.025280] [089/154] (728s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[307.100443] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[307.104764] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[307.214400] [090/154] (728s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[307.294720] Starting subtest: pr-cursor-plane-move-continuous-sf
[307.298201] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[307.368423] [091/154] (728s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[307.416932] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[307.418970] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[307.512700] [092/154] (728s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[307.565213] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[307.568698] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[307.752206] [093/154] (728s left) kms_psr (fbc-psr-basic)
[307.824228] Starting subtest: fbc-psr-basic
[307.826581] Starting dynamic subtest: eDP-1
[307.831141] Dynamic subtest eDP-1: SKIP (0.000s)
[307.835800] Subtest fbc-psr-basic: SKIP (0.002s)
[307.913585] [094/154] (728s left) gem_exec_fence (expired-history)
[308.348860] Starting subtest: expired-history
[315.945059] Subtest expired-history: SUCCESS (7.597s)
[317.441450] [095/154] (718s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[317.529984] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[317.534288] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[317.622570] [096/154] (718s left) kms_addfb_basic (bad-pitch-32)
[317.673739] Starting subtest: bad-pitch-32
[317.675824] Subtest bad-pitch-32: SUCCESS (0.000s)
[317.801361] [097/154] (718s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[317.887385] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[322.969307] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (5.088s)
[323.072703] [098/154] (713s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[323.446855] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[324.270402] [099/154] (712s left) kms_async_flips (invalid-async-flip)
[324.347973] Starting subtest: invalid-async-flip
[324.731793] Starting dynamic subtest: pipe-A-eDP-1
[325.520455] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.789s)
[325.880568] Starting dynamic subtest: pipe-B-eDP-1
[326.746318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.872s)
[327.110907] Starting dynamic subtest: pipe-C-eDP-1
[327.889940] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.786s)
[328.250297] Starting dynamic subtest: pipe-D-eDP-1
[329.025657] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.782s)
[329.028181] Subtest invalid-async-flip: SUCCESS (4.676s)
[330.181714] [100/154] (706s left) prime_busy (before-wait)
[330.233620] Starting subtest: before-wait
[330.238145] Starting dynamic subtest: rcs0
[330.270431] Dynamic subtest rcs0: SUCCESS (0.034s)
[330.279996] Starting dynamic subtest: bcs0
[330.310601] Dynamic subtest bcs0: SUCCESS (0.039s)
[330.320083] Starting dynamic subtest: vcs0
[330.350802] Dynamic subtest vcs0: SUCCESS (0.039s)
[330.362039] Starting dynamic subtest: vcs1
[330.391330] Dynamic subtest vcs1: SUCCESS (0.039s)
[330.401048] Starting dynamic subtest: vecs0
[330.432731] Dynamic subtest vecs0: SUCCESS (0.040s)
[330.442762] Starting dynamic subtest: ccs0
[330.474976] Dynamic subtest ccs0: SUCCESS (0.041s)
[330.583809] Subtest before-wait: SUCCESS (0.348s)
[330.659083] [101/154] (705s left) kms_vrr (flip-basic)
[330.738210] Starting subtest: flip-basic
[330.744369] Subtest flip-basic: SKIP (0.000s)
[330.810950] [102/154] (705s left) kms_cursor_edge_walk (64x64-top-edge)
[330.879501] Starting subtest: 64x64-top-edge
[330.881838] Starting dynamic subtest: pipe-A-eDP-1
[334.331501] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[334.341650] Starting dynamic subtest: pipe-D-eDP-1
[337.453806] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[337.455994] Subtest 64x64-top-edge: SUCCESS (6.577s)
[338.269845] [103/154] (698s left) gem_ctx_isolation (preservation-reset)
[338.434717] Starting subtest: preservation-reset
[338.437312] Starting dynamic subtest: rcs0
[338.700468] Dynamic subtest rcs0: SUCCESS (0.267s)
[338.710721] Starting dynamic subtest: bcs0
[339.006385] Dynamic subtest bcs0: SUCCESS (0.304s)
[339.016823] Starting dynamic subtest: vcs0
[339.306245] Dynamic subtest vcs0: SUCCESS (0.298s)
[339.317427] Starting dynamic subtest: vcs1
[340.497744] Dynamic subtest vcs1: SUCCESS (1.191s)
[340.508213] Starting dynamic subtest: vecs0
[342.487542] Dynamic subtest vecs0: SUCCESS (1.988s)
[342.499370] Starting dynamic subtest: ccs0
[344.558826] Dynamic subtest ccs0: SUCCESS (2.070s)
[344.561630] Subtest preservation-reset: SUCCESS (6.126s)
[344.685123] [104/154] (691s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[344.777556] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-wc
[344.781619] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[344.882533] [105/154] (691s left) gem_mmap_offset (basic-uaf)
[344.932027] Starting subtest: basic-uaf
[344.934360] Subtest basic-uaf: SUCCESS (0.001s)
[345.047205] [106/154] (691s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-blt)
[345.125260] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-blt
[345.129224] Subtest hdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[345.228368] [107/154] (691s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[345.303524] Starting subtest: map-fixed-invalidate-overlap-busy
[345.306861] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[345.424081] [108/154] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[345.509358] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[345.512711] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[345.634411] [109/154] (691s left) perf (gen12-unprivileged-single-ctx-counters)
[345.721179] Starting subtest: gen12-unprivileged-single-ctx-counters
[345.723147] Starting dynamic subtest: rcs0
[345.862835] Dynamic subtest rcs0: SUCCESS (0.142s)
[345.864797] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.143s)
[345.914187] [110/154] (690s left) gem_exec_reloc (basic-wc-active)
[345.975771] Subtest basic-wc-active: SKIP (0.000s)
[346.047086] [111/154] (690s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[346.128533] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[346.132076] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[346.214444] [112/154] (690s left) core_getversion (basic)
[346.248672] Starting subtest: basic
[346.252152] Subtest basic: SUCCESS (0.000s)
[346.321908] [113/154] (690s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[346.394959] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[346.398397] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[346.519156] [114/154] (690s left) i915_query (engine-info)
[346.568101] Starting subtest: engine-info
[346.570102] Subtest engine-info: SUCCESS (0.004s)
[346.688465] [115/154] (690s left) kms_content_protection (lic-type-1)
[346.806616] Starting subtest: lic-type-1
[346.810652] Subtest lic-type-1: SKIP (0.000s)
[346.942117] [116/154] (690s left) kms_plane (plane-position-hole-dpms)
[347.016285] Starting subtest: plane-position-hole-dpms
[347.517970] Starting dynamic subtest: pipe-A-plane-1
[349.905525] Dynamic subtest pipe-A-plane-1: SUCCESS (2.386s)
[349.915645] Starting dynamic subtest: pipe-A-plane-2
[352.275493] Dynamic subtest pipe-A-plane-2: SUCCESS (2.371s)
[352.285845] Starting dynamic subtest: pipe-A-plane-3
[354.629932] Dynamic subtest pipe-A-plane-3: SUCCESS (2.352s)
[354.640768] Starting dynamic subtest: pipe-A-plane-4
[356.985064] Dynamic subtest pipe-A-plane-4: SUCCESS (2.352s)
[356.995211] Starting dynamic subtest: pipe-A-plane-5
[357.008649] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[358.164177] Starting dynamic subtest: pipe-B-plane-1
[360.488947] Dynamic subtest pipe-B-plane-1: SUCCESS (2.333s)
[360.499911] Starting dynamic subtest: pipe-B-plane-2
[362.773462] Dynamic subtest pipe-B-plane-2: SUCCESS (2.282s)
[362.783767] Starting dynamic subtest: pipe-B-plane-3
[365.129982] Dynamic subtest pipe-B-plane-3: SUCCESS (2.356s)
[365.139692] Starting dynamic subtest: pipe-B-plane-4
[367.387591] Dynamic subtest pipe-B-plane-4: SUCCESS (2.257s)
[367.397673] Starting dynamic subtest: pipe-B-plane-5
[367.413234] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[367.415507] Subtest plane-position-hole-dpms: SUCCESS (20.396s)
[368.210690] [117/154] (668s left) gem_exec_schedule (u-lateslice)
[368.297284] Starting subtest: u-lateslice
[368.299667] Starting dynamic subtest: rcs0
[368.306428] Dynamic subtest rcs0: SUCCESS (0.020s)
[368.317329] Starting dynamic subtest: bcs0
[368.323805] Dynamic subtest bcs0: SUCCESS (0.017s)
[368.334577] Starting dynamic subtest: vcs0
[368.341105] Dynamic subtest vcs0: SUCCESS (0.017s)
[368.350409] Starting dynamic subtest: vcs1
[368.358894] Dynamic subtest vcs1: SUCCESS (0.017s)
[368.368072] Starting dynamic subtest: vecs0
[368.376367] Dynamic subtest vecs0: SUCCESS (0.016s)
[368.385699] Starting dynamic subtest: ccs0
[368.394328] Dynamic subtest ccs0: SUCCESS (0.018s)
[368.396632] Subtest u-lateslice: SUCCESS (0.108s)
[370.315690] [118/154] (666s left) kms_plane (pixel-format-x-tiled-modifier)
[370.385240] Starting subtest: pixel-format-x-tiled-modifier
[370.411761] Starting dynamic subtest: pipe-A-plane-0
[370.810921] Dynamic subtest pipe-A-plane-0: SUCCESS (0.400s)
[370.821147] Starting dynamic subtest: pipe-A-plane-3
[371.111267] Dynamic subtest pipe-A-plane-3: SUCCESS (0.299s)
[371.121742] Starting dynamic subtest: pipe-A-plane-5
[371.126311] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[372.195547] Starting dynamic subtest: pipe-B-plane-0
[372.620153] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[372.630082] Starting dynamic subtest: pipe-B-plane-3
[372.942497] Dynamic subtest pipe-B-plane-3: SUCCESS (0.321s)
[372.952208] Starting dynamic subtest: pipe-B-plane-5
[372.956758] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[373.254930] Subtest pixel-format-x-tiled-modifier: SUCCESS (2.868s)
[374.066999] [119/154] (663s left) gem_softpin (evict-snoop)
[374.128792] Starting subtest: evict-snoop
[374.133237] Subtest evict-snoop: SKIP (0.000s)
[374.234505] [120/154] (662s left) perf_pmu (busy-start)
[374.276757] Starting subtest: busy-start
[374.278603] Starting dynamic subtest: rcs0
[376.825322] Dynamic subtest rcs0: SUCCESS (2.550s)
[376.835695] Starting dynamic subtest: bcs0
[379.374228] Dynamic subtest bcs0: SUCCESS (2.547s)
[379.389979] Starting dynamic subtest: vcs0
[383.230279] Dynamic subtest vcs0: SUCCESS (3.851s)
[383.243550] Starting dynamic subtest: vcs1
[387.198077] Dynamic subtest vcs1: SUCCESS (3.965s)
[387.210911] Starting dynamic subtest: vecs0
[391.230346] Dynamic subtest vecs0: SUCCESS (4.029s)
[391.242187] Starting dynamic subtest: ccs0
[393.778865] Dynamic subtest ccs0: SUCCESS (2.547s)
[393.781443] Subtest busy-start: SUCCESS (19.505s)
[393.896542] [121/154] (643s left) gem_ccs (block-copy-uncompressed)
[393.945572] Starting subtest: block-copy-uncompressed
[393.947877] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[393.969864] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s)
[393.980578] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[393.989366] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[393.998461] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[394.008669] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[394.019213] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[394.027095] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[394.029649] Subtest block-copy-uncompressed: SUCCESS (0.082s)
[394.149619] [122/154] (643s left) gem_partial_pwrite_pread (reads)
[394.212053] Subtest reads: SKIP (0.000s)
[394.275314] [123/154] (643s left) kms_lease (atomic-implicit-crtc)
[394.350454] Starting subtest: atomic-implicit-crtc
[394.352784] Starting dynamic subtest: pipe-A-eDP-1
[394.364061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[394.379065] Starting dynamic subtest: pipe-B-eDP-1
[394.390305] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[394.399288] Starting dynamic subtest: pipe-C-eDP-1
[394.410085] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[394.418885] Starting dynamic subtest: pipe-D-eDP-1
[394.429643] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[394.431580] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[394.502353] [124/154] (642s left) kms_flip (flip-vs-dpms-on-nop)
[394.569053] Starting subtest: flip-vs-dpms-on-nop
[394.571860] Starting dynamic subtest: A-eDP1
[396.467967] Dynamic subtest A-eDP1: SUCCESS (1.900s)
[396.478753] Starting dynamic subtest: B-eDP1
[398.307983] Dynamic subtest B-eDP1: SUCCESS (1.838s)
[398.318213] Starting dynamic subtest: C-eDP1
[400.125530] Dynamic subtest C-eDP1: SUCCESS (1.816s)
[400.137724] Starting dynamic subtest: D-eDP1
[401.954877] Dynamic subtest D-eDP1: SUCCESS (1.828s)
[401.960138] Subtest flip-vs-dpms-on-nop: SUCCESS (7.392s)
[403.132657] [125/154] (634s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[403.218878] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[403.221264] Starting dynamic subtest: pipe-A-eDP-1
[403.291869] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[403.303427] Starting dynamic subtest: pipe-B-eDP-1
[404.418199] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[404.422466] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.204s)
[405.613159] [126/154] (631s left) gen9_exec_parse (bb-oversize)
[405.670289] Subtest bb-oversize: SKIP (0.000s)
[405.736767] [127/154] (631s left) kms_panel_fitting (atomic-fastset)
[405.818096] Starting subtest: atomic-fastset
[405.820421] Starting dynamic subtest: pipe-A-eDP-1
[405.955690] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[405.966794] Starting dynamic subtest: pipe-B-eDP-1
[407.171907] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.215s)
[407.185137] Starting dynamic subtest: pipe-C-eDP-1
[408.349915] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.176s)
[408.360435] Starting dynamic subtest: pipe-D-eDP-1
[409.491344] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[409.493755] Subtest atomic-fastset: SUCCESS (3.675s)
[410.651163] [128/154] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[410.734757] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[410.739430] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[410.832471] [129/154] (626s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[410.879831] Starting subtest: x-tiled-to-vebox-yf-tiled
[410.884356] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[411.066418] [130/154] (626s left) syncobj_timeline (wait-all-for-submit-complex)
[411.120697] Starting subtest: wait-all-for-submit-complex
[411.334662] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[411.420763] [131/154] (626s left) i915_drm_fdinfo (memory-info-resident)
[411.462697] Starting subtest: memory-info-resident
[411.465163] Starting dynamic subtest: smem0
[414.095504] Dynamic subtest smem0: SUCCESS (2.634s)
[414.097679] Subtest memory-info-resident: SUCCESS (2.636s)
[414.184980] [132/154] (623s left) gem_lmem_swapping (verify-ccs)
[414.222319] Subtest verify-ccs: SKIP (0.000s)
[414.268620] [133/154] (623s left) i915_getparams_basic (basic-subslice-total)
[414.314908] Starting subtest: basic-subslice-total
[414.318435] Subtest basic-subslice-total: SUCCESS (0.000s)
[414.404724] [134/154] (623s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[414.473862] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[414.475500] Starting dynamic subtest: pipe-A-eDP-1
[415.315880] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.836s)
[415.325141] Starting dynamic subtest: pipe-B-eDP-1
[416.917163] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.598s)
[416.930183] Starting dynamic subtest: pipe-C-eDP-1
[418.466092] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.547s)
[418.476265] Starting dynamic subtest: pipe-D-eDP-1
[419.991369] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.525s)
[419.993692] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.511s)
[421.174548] [135/154] (616s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[421.253140] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[421.257417] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[421.331703] [136/154] (616s left) kms_sequence (get-busy)
[421.401210] Starting subtest: get-busy
[421.403535] Starting dynamic subtest: pipe-A-eDP-1
[423.324585] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s)
[423.335581] Starting dynamic subtest: pipe-B-eDP-1
[425.964651] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.637s)
[425.974779] Starting dynamic subtest: pipe-C-eDP-1
[428.580055] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.617s)
[428.590189] Starting dynamic subtest: pipe-D-eDP-1
[431.193592] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.609s)
[431.195917] Subtest get-busy: SUCCESS (9.791s)
[432.079277] [137/154] (605s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[432.158626] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[432.162826] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[432.244852] [138/154] (605s left) kms_flip (flip-vs-expired-vblank-interruptible)
[432.321919] Starting subtest: flip-vs-expired-vblank-interruptible
[432.324428] Starting dynamic subtest: A-eDP1
[440.979407] Dynamic subtest A-eDP1: SUCCESS (8.658s)
[440.992758] Starting dynamic subtest: B-eDP1
[449.609791] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[449.622065] Starting dynamic subtest: C-eDP1
[458.226814] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[458.237859] Starting dynamic subtest: D-eDP1
[466.857836] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[466.862884] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.541s)
[468.028419] [139/154] (569s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[468.103199] Starting subtest: psr-2p-primscrn-cur-indfb-move
[468.107203] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[468.207969] [140/154] (569s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[468.290226] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[468.294236] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[468.379721] [141/154] (569s left) gem_softpin (evict-prime)
[468.425379] Starting subtest: evict-prime
[468.427774] Starting dynamic subtest: rcs0
[469.574057] Dynamic subtest rcs0: SUCCESS (1.148s)
[469.587749] Starting dynamic subtest: bcs0
[470.694829] Dynamic subtest bcs0: SUCCESS (1.118s)
[470.707746] Starting dynamic subtest: vcs0
[472.261057] Dynamic subtest vcs0: SUCCESS (1.564s)
[472.273302] Starting dynamic subtest: vcs1
[474.242520] Dynamic subtest vcs1: SUCCESS (1.979s)
[474.256916] Starting dynamic subtest: vecs0
[476.215098] Dynamic subtest vecs0: SUCCESS (1.971s)
[476.228044] Starting dynamic subtest: ccs0
[477.350798] Dynamic subtest ccs0: SUCCESS (1.134s)
[477.362389] Starting dynamic subtest: all
[479.231171] Dynamic subtest all: SUCCESS (1.877s)
[479.233676] Subtest evict-prime: SUCCESS (10.805s)
[479.310717] [142/154] (558s left) gem_exec_balancer (hog)
[479.366715] Starting subtest: hog
[479.371078] Subtest hog: SKIP (0.000s)
[479.669734] [143/154] (558s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[479.748781] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[486.348704] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.604s)
[486.479578] [144/154] (551s left) kms_chamelium_audio (dp-audio)
[486.848693] Subtest dp-audio: SKIP (0.000s)
[487.655196] [145/154] (550s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[487.746650] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[487.750972] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[487.822924] [146/154] (550s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[487.911816] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[487.916111] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[488.002232] [147/154] (550s left) kms_plane_alpha_blend (alpha-7efc)
[488.075687] Starting subtest: alpha-7efc
[488.361690] Starting dynamic subtest: pipe-A-eDP-1
[488.987881] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.623s)
[489.015878] Starting dynamic subtest: pipe-D-eDP-1
[490.310357] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.304s)
[490.312920] Subtest alpha-7efc: SUCCESS (2.236s)
[491.160819] [148/154] (547s left) kms_flip (plain-flip-ts-check-interruptible)
[491.238897] Starting subtest: plain-flip-ts-check-interruptible
[491.241069] Starting dynamic subtest: A-eDP1
[500.138119] Dynamic subtest A-eDP1: SUCCESS (8.897s)
[500.151353] Starting dynamic subtest: B-eDP1
[508.972480] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[508.986714] Starting dynamic subtest: C-eDP1
[517.803976] Dynamic subtest C-eDP1: SUCCESS (8.827s)
[517.814093] Starting dynamic subtest: D-eDP1
[526.637818] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[526.642826] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.402s)
[527.818317] [149/154] (510s left) gem_exec_flush (basic-uc-prw-default)
[527.885968] Starting subtest: basic-uc-prw-default
[533.343695] Subtest basic-uc-prw-default: SUCCESS (5.458s)
[533.543174] [150/154] (504s left) syncobj_wait (multi-wait-all-submitted-signaled)
[533.602019] Starting subtest: multi-wait-all-submitted-signaled
[533.706833] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[533.784087] [151/154] (504s left) gem_caching (writes)
[533.836621] Subtest writes: SKIP (0.000s)
[533.909240] [152/154] (504s left) gem_ctx_param (set-priority-range)
[533.956723] Starting subtest: set-priority-range
[533.970271] Subtest set-priority-range: SUCCESS (0.013s)
[534.071103] [153/154] (504s left) kms_lease (lessee-list)
[534.139072] Starting subtest: lessee-list
[534.141325] Starting dynamic subtest: pipe-A-eDP-1
[534.143673] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[534.156937] Starting dynamic subtest: pipe-B-eDP-1
[534.159504] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[534.168825] Starting dynamic subtest: pipe-C-eDP-1
[534.171079] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[534.180373] Starting dynamic subtest: pipe-D-eDP-1
[534.182595] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[534.184809] Subtest lessee-list: SUCCESS (0.009s)
[534.246042] [154/154] (504s left) gem_exec_fence (syncobj-unused-fence)
[534.697375] Starting subtest: syncobj-unused-fence
[534.704373] Subtest syncobj-unused-fence: SUCCESS (0.007s)
[536.329966] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: prime_self_import
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_color
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: prime_self_import
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_create
results: parsing output: 23/ for test: kms_rotation_crc
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: gem_exec_whisper
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_ctx_param
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_atomic_transition
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_dp_linktrain_fallback
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_addfb_basic
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_hdr
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: api_intel_bb
results: parsing output: 48/ for test: kms_scaling_modes
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: kms_dsc
results: parsing output: 54/ for test: kms_chamelium_frames
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: prime_mmap
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gen7_exec_parse
results: parsing output: 70/ for test: i915_pm_rc6_residency
results: parsing output: 71/ for test: gem_lmem_swapping
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: gem_ctx_shared
results: parsing output: 77/ for test: gem_pread
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: api_intel_allocator
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: prime_vgem
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: kms_async_flips
results: parsing output: 99/ for test: prime_busy
results: parsing output: 100/ for test: kms_vrr
results: parsing output: 101/ for test: kms_cursor_edge_walk
results: parsing output: 102/ for test: gem_ctx_isolation
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_mmap_offset
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: core_getversion
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: i915_query
results: parsing output: 114/ for test: kms_content_protection
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: gem_softpin
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_ccs
results: parsing output: 121/ for test: gem_partial_pwrite_pread
results: parsing output: 122/ for test: kms_lease
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: gen9_exec_parse
results: parsing output: 126/ for test: kms_panel_fitting
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: i915_drm_fdinfo
results: parsing output: 131/ for test: gem_lmem_swapping
results: parsing output: 132/ for test: i915_getparams_basic
results: parsing output: 133/ for test: kms_ccs
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_sequence
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_flip
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: gem_softpin
results: parsing output: 141/ for test: gem_exec_balancer
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_chamelium_audio
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_plane_alpha_blend
results: parsing output: 147/ for test: kms_flip
results: parsing output: 148/ for test: gem_exec_flush
results: parsing output: 149/ for test: syncobj_wait
results: parsing output: 150/ for test: gem_caching
results: parsing output: 151/ for test: gem_ctx_param
results: parsing output: 152/ for test: kms_lease
results: parsing output: 153/ for test: gem_exec_fence
Done.