[58.527858] Initializing watchdogs
[58.527905]   /dev/watchdog0
[58.542629] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.546892] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.549525] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.552781] [001/133] (960s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[58.684723] Starting subtest: 4-tiled-32bpp-rotate-180
[60.101275] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.425s)
[60.244841] [002/133] (958s left) gem_exec_reloc (basic-cpu-read)
[60.312516] Subtest basic-cpu-read: SKIP (0.000s)
[60.382153] [003/133] (958s left) fbdev (unaligned-read)
[60.416748] Starting subtest: unaligned-read
[60.431391] Subtest unaligned-read: SUCCESS (0.015s)
[60.482148] [004/133] (958s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[60.569082] Starting subtest: fbcpsr-rgb565-draw-blt
[68.160910] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.613s)
[68.328315] [005/133] (950s left) kms_content_protection (lic-type-0)
[68.477506] Starting subtest: lic-type-0
[68.482211] Subtest lic-type-0: SKIP (0.000s)
[68.592996] [006/133] (950s left) gem_pread (uncached)
[68.655750] Subtest uncached: SKIP (0.000s)
[68.711237] [007/133] (950s left) i915_drm_fdinfo (all-busy-check-all)
[68.759950] Starting subtest: all-busy-check-all
[68.766719] Subtest all-busy-check-all: SKIP (0.004s)
[68.848962] [008/133] (950s left) gem_tiled_blits (basic)
[68.906265] Subtest basic: SKIP (0.000s)
[68.976806] [009/133] (950s left) kms_lease (simple-lease)
[69.068828] Starting subtest: simple-lease
[69.071235] Starting dynamic subtest: pipe-A-eDP-1
[69.574346] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.503s)
[69.583436] Starting dynamic subtest: pipe-B-eDP-1
[71.050875] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.477s)
[71.060043] Starting dynamic subtest: pipe-C-eDP-1
[72.450848] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.400s)
[72.459272] Starting dynamic subtest: pipe-D-eDP-1
[73.854438] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.405s)
[73.856751] Subtest simple-lease: SUCCESS (4.789s)
[74.667784] [010/133] (944s left) kms_fbcon_fbt (fbc-suspend)
[74.731397] Starting subtest: fbc-suspend
[124.372440] Subtest fbc-suspend: SUCCESS (20.136s)
[125.717580] [011/133] (893s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[125.836373] Starting subtest: 2x-flip-vs-cursor-legacy
[125.841091] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[125.977193] [012/133] (893s left) gem_exec_whisper (basic-fds-all)
[126.034060] Starting subtest: basic-fds-all
[137.630684] Subtest basic-fds-all: SUCCESS (11.658s)
[137.814582] [013/133] (881s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[137.929775] Starting subtest: x-tiled-32bpp-rotate-180
[139.315163] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.390s)
[139.459539] [014/133] (880s left) kms_invalid_mode (bad-vsync-end)
[139.542148] Starting subtest: bad-vsync-end
[139.544113] Starting dynamic subtest: pipe-A-eDP-1
[139.825596] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[139.835605] Starting dynamic subtest: pipe-B-eDP-1
[139.837849] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[139.845888] Starting dynamic subtest: pipe-C-eDP-1
[139.848131] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[139.856123] Starting dynamic subtest: pipe-D-eDP-1
[139.858054] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[139.859971] Subtest bad-vsync-end: SUCCESS (0.290s)
[140.679604] [015/133] (878s left) kms_cursor_crc (cursor-onscreen-512x170)
[140.990139] Starting subtest: cursor-onscreen-512x170
[140.994380] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[141.120054] [016/133] (878s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[141.211673] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[141.215866] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[141.305673] [017/133] (878s left) kms_vblank (query-idle-hang)
[141.395284] Starting subtest: query-idle-hang
[141.397499] Starting dynamic subtest: pipe-A-eDP-1
[167.423813] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.037s)
[167.438257] Starting dynamic subtest: pipe-D-eDP-1
[182.392117] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.967s)
[182.394091] Subtest query-idle-hang: SUCCESS (41.008s)
[183.211357] [018/133] (836s left) gem_exec_params (invalid-flag)
[183.281251] Starting subtest: invalid-flag
[183.283298] Subtest invalid-flag: SUCCESS (0.000s)
[183.404926] [019/133] (836s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[183.501624] Starting subtest: psr-rgb101010-draw-mmap-wc
[190.582531] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.086s)
[190.680387] [020/133] (829s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[190.801288] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[195.623138] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.829s)
[196.757165] [021/133] (823s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[196.845198] Starting subtest: drrs-dirtyfb-ioctl
[196.858457] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[196.966300] [022/133] (822s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[197.064008] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[197.068473] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[197.150685] [023/133] (822s left) gem_ctx_create (basic)
[197.212211] Starting subtest: basic
[197.214602] Subtest basic: SUCCESS (0.000s)
[197.397462] [024/133] (822s left) syncobj_wait (multi-wait-for-submit-submitted)
[197.450520] Starting subtest: multi-wait-for-submit-submitted
[197.558048] Subtest multi-wait-for-submit-submitted: SUCCESS (0.106s)
[197.629868] [025/133] (822s left) gem_softpin (invalid)
[197.707768] Starting subtest: invalid
[197.721157] Subtest invalid: SUCCESS (0.014s)
[197.850290] [026/133] (822s left) perf_pmu (busy-accuracy-50)
[197.889461] Starting subtest: busy-accuracy-50
[197.891646] Starting dynamic subtest: rcs0
[199.425466] Dynamic subtest rcs0: SUCCESS (1.535s)
[199.436475] Starting dynamic subtest: bcs0
[200.969975] Dynamic subtest bcs0: SUCCESS (1.543s)
[200.981534] Starting dynamic subtest: vcs0
[202.510290] Dynamic subtest vcs0: SUCCESS (1.539s)
[202.521598] Starting dynamic subtest: vcs1
[204.054365] Dynamic subtest vcs1: SUCCESS (1.542s)
[204.065557] Starting dynamic subtest: vecs0
[205.597286] Dynamic subtest vecs0: SUCCESS (1.542s)
[205.607458] Starting dynamic subtest: ccs0
[207.141818] Dynamic subtest ccs0: SUCCESS (1.543s)
[207.144261] Subtest busy-accuracy-50: SUCCESS (9.255s)
[207.285339] [027/133] (812s left) kms_chamelium_edid (hdmi-edid-read)
[207.697463] Subtest hdmi-edid-read: SKIP (0.000s)
[208.471242] [028/133] (811s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[208.584166] Starting subtest: psr2-cursor-plane-update-sf
[208.586698] Starting dynamic subtest: pipe-A-eDP-1
[209.193595] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s)
[209.209226] Starting dynamic subtest: pipe-B-eDP-1
[210.467636] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.275s)
[210.470051] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.888s)
[211.356923] [029/133] (808s left) kms_plane_lowres (tiling-4)
[211.448673] Starting subtest: tiling-4
[211.450984] Starting dynamic subtest: pipe-A-eDP-1
[211.455559] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[211.752896] Starting dynamic subtest: pipe-B-eDP-1
[211.757669] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[211.766693] Starting dynamic subtest: pipe-C-eDP-1
[211.771343] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[211.780715] Starting dynamic subtest: pipe-D-eDP-1
[211.785262] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[211.789708] Subtest tiling-4: SKIP (0.299s)
[212.576647] [030/133] (807s left) sysfs_preempt_timeout (idempotent)
[212.636777] Starting subtest: idempotent
[212.639291] Starting dynamic subtest: vecs0
[212.641762] Dynamic subtest vecs0: SUCCESS (0.000s)
[212.652855] Starting dynamic subtest: ccs0
[212.655139] Dynamic subtest ccs0: SUCCESS (0.000s)
[212.664310] Starting dynamic subtest: vcs0
[212.666276] Dynamic subtest vcs0: SUCCESS (0.000s)
[212.675383] Starting dynamic subtest: bcs0
[212.677682] Dynamic subtest bcs0: SUCCESS (0.000s)
[212.686650] Starting dynamic subtest: rcs0
[212.688570] Dynamic subtest rcs0: SUCCESS (0.000s)
[212.696868] Starting dynamic subtest: vcs1
[212.698843] Dynamic subtest vcs1: SUCCESS (0.000s)
[212.700798] Subtest idempotent: SUCCESS (0.005s)
[212.737451] [031/133] (807s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[212.835534] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[212.839879] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[212.938215] [032/133] (807s left) kms_pipe_crc_basic (bad-source)
[213.039464] Starting subtest: bad-source
[213.041352] Subtest bad-source: SUCCESS (0.000s)
[213.110194] [033/133] (807s left) kms_plane (pixel-format-4-tiled-modifier)
[213.199436] Starting subtest: pixel-format-4-tiled-modifier
[213.225079] Starting dynamic subtest: pipe-A-plane-0
[213.835487] Dynamic subtest pipe-A-plane-0: SUCCESS (0.611s)
[213.853449] Starting dynamic subtest: pipe-A-plane-3
[214.246192] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[214.255668] Starting dynamic subtest: pipe-A-plane-5
[214.259172] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[215.370836] Starting dynamic subtest: pipe-B-plane-0
[216.051894] Dynamic subtest pipe-B-plane-0: SUCCESS (0.689s)
[216.061967] Starting dynamic subtest: pipe-B-plane-3
[216.440618] Dynamic subtest pipe-B-plane-3: SUCCESS (0.387s)
[216.449522] Starting dynamic subtest: pipe-B-plane-5
[216.452924] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[216.747450] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.550s)
[217.561265] [034/133] (802s left) kms_flip (2x-wf_vblank-ts-check)
[217.661733] Starting subtest: 2x-wf_vblank-ts-check
[217.672052] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[217.762582] [035/133] (802s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[217.827448] Starting subtest: etime-multi-wait-for-submit-submitted
[217.932686] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[218.018366] [036/133] (802s left) gem_exec_balancer (semaphore)
[218.072245] Starting subtest: semaphore
[219.643867] Subtest semaphore: SUCCESS (1.569s)
[219.955487] [037/133] (800s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[220.051753] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[224.359988] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.308s)
[225.554380] [038/133] (794s left) kms_cdclk (plane-scaling)
[225.647515] Starting subtest: plane-scaling
[225.649888] Starting dynamic subtest: pipe-A-eDP-1
[225.954327] Dynamic subtest pipe-A-eDP-1: SKIP (0.306s)
[225.964701] Starting dynamic subtest: pipe-B-eDP-1
[225.969303] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[225.978568] Starting dynamic subtest: pipe-C-eDP-1
[225.983172] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[225.992088] Starting dynamic subtest: pipe-D-eDP-1
[225.996233] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[226.000430] Subtest plane-scaling: SKIP (0.312s)
[226.781173] [039/133] (793s left) syncobj_timeline (signal-array)
[226.830428] Starting subtest: signal-array
[226.832859] Subtest signal-array: SUCCESS (0.000s)
[226.919296] [040/133] (793s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[226.970892] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[226.975298] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[227.156976] [041/133] (793s left) syncobj_wait (reset-multiple-signaled)
[227.213887] Starting subtest: reset-multiple-signaled
[227.216364] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[227.350324] [042/133] (793s left) i915_pm_rc6_residency (rc6-fence)
[227.406658] Starting subtest: rc6-fence
[227.431827] Starting dynamic subtest: gt0
[239.755431] Dynamic subtest gt0: SUCCESS (12.318s)
[239.767479] Starting dynamic subtest: gt1
[254.591727] Dynamic subtest gt1: SUCCESS (14.832s)
[254.594564] Subtest rc6-fence: SUCCESS (27.181s)
[254.666681] [043/133] (766s left) gem_ctx_param (basic)
[254.722957] Starting subtest: basic
[254.725347] Subtest basic: SUCCESS (0.001s)
[254.818720] [044/133] (765s left) kms_busy (basic)
[254.923374] Starting subtest: basic
[254.925776] Starting dynamic subtest: flip
[255.528035] Dynamic subtest flip: SUCCESS (0.604s)
[255.537604] Starting dynamic subtest: modeset
[258.943006] Dynamic subtest modeset: SUCCESS (3.413s)
[258.945275] Subtest basic: SUCCESS (4.019s)
[259.761487] [045/133] (761s left) kms_async_flips (test-cursor)
[259.862686] Starting subtest: test-cursor
[260.240555] Starting dynamic subtest: pipe-A-eDP-1
[261.034489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.795s)
[261.421492] Starting dynamic subtest: pipe-B-eDP-1
[262.172144] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.758s)
[262.567151] Starting dynamic subtest: pipe-C-eDP-1
[263.298254] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.738s)
[263.675763] Starting dynamic subtest: pipe-D-eDP-1
[264.436755] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[264.439273] Subtest test-cursor: SUCCESS (4.576s)
[265.601873] [046/133] (755s left) gem_ctx_exec (basic-invalid-context)
[265.660177] Starting subtest: basic-invalid-context
[265.664786] Subtest basic-invalid-context: SUCCESS (0.005s)
[265.792193] [047/133] (755s left) gem_userptr_blits (unsync-overlap)
[265.854621] Subtest unsync-overlap: SKIP (0.000s)
[265.982640] [048/133] (754s left) kms_getfb (getfb2-accept-nv12)
[266.073910] Starting subtest: getfb2-accept-nv12
[266.076085] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[266.181145] [049/133] (754s left) kms_flip (plain-flip-ts-check)
[266.270292] Starting subtest: plain-flip-ts-check
[266.272469] Starting dynamic subtest: A-eDP1
[275.114858] Dynamic subtest A-eDP1: SUCCESS (8.846s)
[275.130603] Starting dynamic subtest: B-eDP1
[284.047884] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[284.060693] Starting dynamic subtest: C-eDP1
[292.868581] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[292.881752] Starting dynamic subtest: D-eDP1
[301.697069] Dynamic subtest D-eDP1: SUCCESS (8.827s)
[301.702237] Subtest plain-flip-ts-check: SUCCESS (35.439s)
[302.868442] [050/133] (718s left) kms_mmap_write_crc (main)
[302.957021] Starting subtest: main
[302.959292] Starting dynamic subtest: pipe-A-eDP-1
[306.465796] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.505s)
[306.468081] Subtest main: SUCCESS (3.507s)
[307.299776] [051/133] (713s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[307.902147] Starting subtest: syncobj-timeline-multiple-ext-nodes
[307.905052] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[309.731234] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[309.734649] [052/133] (711s left) gem_flink_race (flink_close)
[309.779102] Starting subtest: flink_close
[314.859920] Subtest flink_close: SUCCESS (5.083s)
[314.940054] [053/133] (706s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[315.050791] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[315.053036] Starting dynamic subtest: pipe-A-default-mode
[317.740336] Dynamic subtest pipe-A-default-mode: SUCCESS (2.691s)
[317.742700] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.693s)
[318.599762] [054/133] (702s left) kms_rmfb (close-fd)
[318.696511] Starting subtest: close-fd
[318.698483] Starting dynamic subtest: pipe-A-eDP-1
[318.804816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[318.815390] Starting dynamic subtest: pipe-B-eDP-1
[319.952805] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s)
[319.963389] Starting dynamic subtest: pipe-C-eDP-1
[321.093516] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.138s)
[321.103124] Starting dynamic subtest: pipe-D-eDP-1
[322.222532] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[322.224868] Subtest close-fd: SUCCESS (3.529s)
[323.438285] [055/133] (697s left) prime_busy (hang)
[323.494729] Starting subtest: hang
[323.497156] Starting dynamic subtest: rcs0
[349.147720] Dynamic subtest rcs0: SUCCESS (25.652s)
[349.156563] Starting dynamic subtest: bcs0
[356.303694] Dynamic subtest bcs0: SUCCESS (7.154s)
[356.319430] Starting dynamic subtest: vcs0
[363.275111] Dynamic subtest vcs0: SUCCESS (6.969s)
[363.286898] Starting dynamic subtest: vcs1
[370.314214] Dynamic subtest vcs1: SUCCESS (7.036s)
[370.326493] Starting dynamic subtest: vecs0
[377.290790] Dynamic subtest vecs0: SUCCESS (6.974s)
[377.300610] Starting dynamic subtest: ccs0
[391.196833] Dynamic subtest ccs0: SUCCESS (13.900s)
[391.198853] Subtest hang: SUCCESS (67.692s)
[391.309191] [056/133] (629s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[391.368975] Starting subtest: multi-wait-all-for-submit-signaled
[391.371362] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[391.487344] [057/133] (629s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[391.588019] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[398.424180] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.837s)
[398.588262] [058/133] (622s left) kms_color (degamma)
[398.685228] Starting subtest: degamma
[398.687583] Starting dynamic subtest: pipe-A-eDP-1
[399.404249] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[399.414856] Starting dynamic subtest: pipe-B-eDP-1
[400.881562] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.474s)
[400.891663] Starting dynamic subtest: pipe-C-eDP-1
[402.252462] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[402.262463] Starting dynamic subtest: pipe-D-eDP-1
[403.592572] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[403.594712] Subtest degamma: SUCCESS (4.908s)
[404.397621] [059/133] (617s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[404.500246] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[404.502590] Starting dynamic subtest: pipe-A-eDP-1
[404.524983] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[404.536776] Starting dynamic subtest: pipe-B-eDP-1
[404.558168] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[404.567512] Starting dynamic subtest: pipe-C-eDP-1
[404.590051] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[404.599065] Starting dynamic subtest: pipe-D-eDP-1
[404.620942] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[404.625074] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[406.666329] [060/133] (614s left) gem_ctx_persistence (heartbeat-stop)
[406.732430] Starting subtest: heartbeat-stop
[406.736830] Subtest heartbeat-stop: SKIP (0.000s)
[406.860310] [061/133] (614s left) kms_plane (plane-panning-top-left)
[406.953915] Starting subtest: plane-panning-top-left
[406.956063] Starting dynamic subtest: pipe-A
[408.622493] Dynamic subtest pipe-A: SUCCESS (1.666s)
[408.632618] Starting dynamic subtest: pipe-B
[411.005464] Dynamic subtest pipe-B: SUCCESS (2.382s)
[411.007628] Subtest plane-panning-top-left: SUCCESS (4.051s)
[411.897886] [062/133] (609s left) kms_addfb_basic (invalid-set-prop)
[411.967768] Starting subtest: invalid-set-prop
[411.969991] Subtest invalid-set-prop: SUCCESS (0.000s)
[412.103417] [063/133] (609s left) gem_partial_pwrite_pread (write-uncached)
[412.163025] Subtest write-uncached: SKIP (0.000s)
[412.243331] [064/133] (609s left) kms_pm_dc (dc6-psr)
[413.341478] Starting subtest: dc6-psr
[416.221252] Subtest dc6-psr: SUCCESS (2.879s)
[417.020524] [065/133] (604s left) kms_prop_blob (invalid-set-prop)
[417.071985] Starting subtest: invalid-set-prop
[417.074248] Subtest invalid-set-prop: SUCCESS (0.000s)
[417.171010] [066/133] (604s left) core_getclient (basic)
[417.235509] Starting subtest: basic
[417.237541] Subtest basic: SUCCESS (0.000s)
[417.348352] [067/133] (604s left) kms_fb_coherency (memset-crc)
[417.446260] Starting subtest: memset-crc
[417.448544] Starting dynamic subtest: mmap-offset-wc
[417.833561] Dynamic subtest mmap-offset-wc: SUCCESS (0.387s)
[418.141737] Starting dynamic subtest: mmap-offset-uc
[424.204423] Dynamic subtest mmap-offset-uc: SUCCESS (6.072s)
[424.483431] Subtest memset-crc: SUCCESS (7.038s)
[425.285704] [068/133] (596s left) gem_ctx_isolation (preservation-reset)
[425.478952] Starting subtest: preservation-reset
[425.481531] Starting dynamic subtest: rcs0
[425.743326] Dynamic subtest rcs0: SUCCESS (0.269s)
[425.754133] Starting dynamic subtest: bcs0
[426.052989] Dynamic subtest bcs0: SUCCESS (0.308s)
[426.069064] Starting dynamic subtest: vcs0
[426.366305] Dynamic subtest vcs0: SUCCESS (0.312s)
[426.378749] Starting dynamic subtest: vcs1
[427.948696] Dynamic subtest vcs1: SUCCESS (1.581s)
[427.961375] Starting dynamic subtest: vecs0
[429.921069] Dynamic subtest vecs0: SUCCESS (1.971s)
[429.933461] Starting dynamic subtest: ccs0
[431.982020] Dynamic subtest ccs0: SUCCESS (2.060s)
[431.984472] Subtest preservation-reset: SUCCESS (6.510s)
[432.117836] [069/133] (589s left) gem_close_race (basic-threads)
[432.187099] Starting subtest: basic-threads
[433.538857] Subtest basic-threads: SUCCESS (1.352s)
[433.726644] [070/133] (588s left) gen7_exec_parse (batch-without-end)
[433.779471] Subtest batch-without-end: SKIP (0.000s)
[433.848221] [071/133] (588s left) i915_power (sanity)
[433.900584] Starting subtest: sanity
[433.905100] Subtest sanity: SKIP (0.000s)
[434.012383] [072/133] (587s left) gem_exec_schedule (implicit-boths)
[434.088414] Starting subtest: implicit-boths
[434.090375] Starting dynamic subtest: rcs0
[434.284046] Dynamic subtest rcs0: SUCCESS (0.203s)
[434.296551] Starting dynamic subtest: vcs0
[434.432700] Dynamic subtest vcs0: SUCCESS (0.150s)
[434.447424] Starting dynamic subtest: vcs1
[434.558975] Dynamic subtest vcs1: SUCCESS (0.122s)
[434.571720] Starting dynamic subtest: vecs0
[434.666648] Dynamic subtest vecs0: SUCCESS (0.107s)
[434.679998] Starting dynamic subtest: ccs0
[434.806821] Dynamic subtest ccs0: SUCCESS (0.139s)
[434.809166] Subtest implicit-boths: SUCCESS (0.728s)
[435.735085] [073/133] (586s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[435.843708] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[436.934328] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.090s)
[437.039672] [074/133] (585s left) syncobj_timeline (invalid-query-illegal-handle)
[437.089719] Starting subtest: invalid-query-illegal-handle
[437.091712] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[437.199739] [075/133] (584s left) gem_workarounds (reset)
[437.266872] Starting subtest: reset
[437.447863] Subtest reset: SUCCESS (0.181s)
[437.566113] [076/133] (584s left) gem_exec_whisper (basic-queues-forked)
[437.637489] Starting subtest: basic-queues-forked
[460.707344] Subtest basic-queues-forked: SUCCESS (23.069s)
[460.893387] [077/133] (561s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[461.000662] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[461.003079] Starting dynamic subtest: pipe-A-eDP-1
[461.136365] Dynamic subtest pipe-A-eDP-1: SKIP (0.137s)
[461.149123] Starting dynamic subtest: pipe-B-eDP-1
[462.357286] Dynamic subtest pipe-B-eDP-1: SKIP (1.218s)
[462.362013] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.359s)
[463.551475] [078/133] (558s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[463.664557] Starting subtest: y-tiled-16bpp-rotate-0
[463.668522] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[463.766919] [079/133] (558s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[463.867019] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[463.871023] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[463.988640] [080/133] (558s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[464.088338] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[464.923463] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[465.088951] [081/133] (557s left) gem_exec_flush (basic-wb-prw-default)
[465.163285] Starting subtest: basic-wb-prw-default
[470.623103] Subtest basic-wb-prw-default: SUCCESS (5.462s)
[470.816116] [082/133] (551s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[470.921502] Starting subtest: fbc-2p-pri-indfb-multidraw
[470.926160] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[471.017906] [083/133] (551s left) perf (disabled-read-error)
[471.128967] Starting subtest: disabled-read-error
[471.145966] Subtest disabled-read-error: SUCCESS (0.017s)
[471.190266] [084/133] (551s left) kms_pm_rpm (universal-planes-dpms)
[472.815489] Starting subtest: universal-planes-dpms
[472.817583] Starting dynamic subtest: plane-35
[481.121428] Dynamic subtest plane-35: SUCCESS (8.309s)
[481.134198] Starting dynamic subtest: plane-65
[489.434618] Dynamic subtest plane-65: SUCCESS (8.311s)
[489.447638] Starting dynamic subtest: plane-95
[497.769457] Dynamic subtest plane-95: SUCCESS (8.333s)
[497.782455] Starting dynamic subtest: plane-125
[506.261987] Dynamic subtest plane-125: SUCCESS (8.490s)
[506.276067] Starting dynamic subtest: plane-135
[514.906723] Dynamic subtest plane-135: SUCCESS (8.643s)
[514.921442] Starting dynamic subtest: plane-145
[523.504558] Dynamic subtest plane-145: SUCCESS (8.595s)
[523.507490] Subtest universal-planes-dpms: SUCCESS (50.701s)
[523.902318] [085/133] (498s left) kms_psr (psr-sprite-blt)
[523.994138] Starting subtest: psr-sprite-blt
[523.996493] Starting dynamic subtest: eDP-1
[525.723347] Dynamic subtest eDP-1: SUCCESS (1.730s)
[525.725921] Subtest psr-sprite-blt: SUCCESS (1.732s)
[526.547974] [086/133] (496s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[526.637877] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[526.640280] Starting dynamic subtest: pipe-A-default-mode
[527.816582] Dynamic subtest pipe-A-default-mode: SKIP (1.177s)
[527.820981] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.178s)
[527.961047] [087/133] (494s left) device_reset (cold-reset-bound)
[528.015847] Starting subtest: cold-reset-bound
[528.020314] Subtest cold-reset-bound: SKIP (0.000s)
[528.085833] [088/133] (494s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[528.155083] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[528.288822] [089/133] (494s left) gem_ctx_bad_destroy (invalid-default-ctx)
[528.341556] Starting subtest: invalid-default-ctx
[528.343938] Subtest invalid-default-ctx: SUCCESS (0.000s)
[528.420650] [090/133] (494s left) kms_cursor_crc (cursor-sliding-64x64)
[528.601658] Starting subtest: cursor-sliding-64x64
[528.606551] Starting dynamic subtest: pipe-A-eDP-1
[531.927961] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.322s)
[531.960881] Starting dynamic subtest: pipe-D-eDP-1
[535.902702] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.950s)
[535.904807] Subtest cursor-sliding-64x64: SUCCESS (7.301s)
[536.759372] [091/133] (486s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[536.829305] Starting subtest: x-tiled-to-vebox-y-tiled
[536.833488] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[537.015733] [092/133] (485s left) kms_plane_scaling (planes-scaler-unity-scaling)
[537.106283] Starting subtest: planes-scaler-unity-scaling
[537.108538] Starting dynamic subtest: pipe-A
[537.169046] Dynamic subtest pipe-A: SUCCESS (0.064s)
[537.181855] Starting dynamic subtest: pipe-B
[538.267456] Dynamic subtest pipe-B: SUCCESS (1.098s)
[538.280286] Starting dynamic subtest: pipe-C
[539.387967] Dynamic subtest pipe-C: SUCCESS (1.119s)
[539.399965] Starting dynamic subtest: pipe-D
[540.506627] Dynamic subtest pipe-D: SUCCESS (1.118s)
[540.508929] Subtest planes-scaler-unity-scaling: SUCCESS (3.403s)
[541.675523] [093/133] (481s left) gem_mmap_offset (perf)
[541.734626] Starting subtest: perf
[541.736793] Starting dynamic subtest: smem0
[542.060065] Dynamic subtest smem0: SUCCESS (0.324s)
[542.062488] Subtest perf: SUCCESS (0.325s)
[542.169813] [094/133] (480s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[542.267503] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[542.271554] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[542.368367] [095/133] (480s left) gem_mmap_wc (bad-offset)
[542.419748] Subtest bad-offset: SKIP (0.000s)
[542.474318] [096/133] (480s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[542.573681] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[549.382463] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.813s)
[549.511016] [097/133] (473s left) gem_exec_async (forked-writes)
[549.567159] Starting subtest: forked-writes
[549.569512] Starting dynamic subtest: rcs0
[549.597192] Dynamic subtest rcs0: SUCCESS (0.030s)
[549.610471] Starting dynamic subtest: bcs0
[549.622023] Dynamic subtest bcs0: SUCCESS (0.024s)
[549.632138] Starting dynamic subtest: vcs0
[549.645269] Dynamic subtest vcs0: SUCCESS (0.022s)
[549.655381] Starting dynamic subtest: vcs1
[549.669489] Dynamic subtest vcs1: SUCCESS (0.023s)
[549.679644] Starting dynamic subtest: vecs0
[549.693031] Dynamic subtest vecs0: SUCCESS (0.022s)
[549.703487] Starting dynamic subtest: ccs0
[549.716013] Dynamic subtest ccs0: SUCCESS (0.022s)
[549.718261] Subtest forked-writes: SUCCESS (0.149s)
[549.938468] [098/133] (473s left) kms_psr (fbc-psr-dpms)
[550.029249] Starting subtest: fbc-psr-dpms
[550.031531] Starting dynamic subtest: eDP-1
[550.035834] Dynamic subtest eDP-1: SKIP (0.000s)
[550.040073] Subtest fbc-psr-dpms: SKIP (0.001s)
[550.109234] [099/133] (473s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[550.217274] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[550.219540] Starting dynamic subtest: pipe-A-eDP-1
[550.228164] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[550.238379] Starting dynamic subtest: pipe-B-eDP-1
[550.247224] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[550.258457] Starting dynamic subtest: pipe-C-eDP-1
[550.266763] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[550.276369] Starting dynamic subtest: pipe-D-eDP-1
[550.284537] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[550.288700] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[552.474168] [100/133] (470s left) kms_chamelium_hpd (hdmi-hpd-fast)
[552.864564] Subtest hdmi-hpd-fast: SKIP (0.000s)
[553.691985] [101/133] (469s left) api_intel_bb (blit-reloc-keep-cache)
[553.746170] Starting subtest: blit-reloc-keep-cache
[553.750471] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[553.851175] [102/133] (469s left) kms_force_connector_basic (prune-stale-modes)
[553.926638] Starting subtest: prune-stale-modes
[554.389007] Subtest prune-stale-modes: SUCCESS (0.462s)
[554.532576] [103/133] (468s left) gem_exec_balancer (noheartbeat)
[554.794288] Starting subtest: noheartbeat
[554.799274] Subtest noheartbeat: SKIP (0.000s)
[554.896489] [104/133] (468s left) kms_sequence (get-busy)
[555.002712] Starting subtest: get-busy
[555.004932] Starting dynamic subtest: pipe-A-eDP-1
[556.939513] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[556.949938] Starting dynamic subtest: pipe-B-eDP-1
[559.506454] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.568s)
[559.516636] Starting dynamic subtest: pipe-C-eDP-1
[562.084734] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.577s)
[562.102263] Starting dynamic subtest: pipe-D-eDP-1
[564.682472] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.597s)
[564.684990] Subtest get-busy: SUCCESS (9.683s)
[565.535158] [105/133] (457s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[565.635330] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[565.737187] [106/133] (457s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[565.843605] Starting subtest: fbcpsr-2p-rte
[565.848026] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[565.941506] [107/133] (457s left) gem_exec_schedule (timeslicing)
[566.019988] Starting subtest: timeslicing
[566.022784] Starting dynamic subtest: rcs0
[566.029785] Dynamic subtest rcs0: SUCCESS (0.021s)
[566.041755] Starting dynamic subtest: bcs0
[566.050672] Dynamic subtest bcs0: SUCCESS (0.020s)
[566.060925] Starting dynamic subtest: vcs0
[566.070613] Dynamic subtest vcs0: SUCCESS (0.019s)
[566.080679] Starting dynamic subtest: vcs1
[566.091637] Dynamic subtest vcs1: SUCCESS (0.020s)
[566.101487] Starting dynamic subtest: vecs0
[566.110600] Dynamic subtest vecs0: SUCCESS (0.018s)
[566.120475] Starting dynamic subtest: ccs0
[566.132605] Dynamic subtest ccs0: SUCCESS (0.021s)
[566.134741] Subtest timeslicing: SUCCESS (0.126s)
[567.721054] [108/133] (455s left) kms_addfb_basic (basic)
[567.780954] Starting subtest: basic
[567.783427] Subtest basic: SUCCESS (0.000s)
[567.921441] [109/133] (455s left) kms_psr (psr2-cursor-mmap-cpu)
[568.017767] Starting subtest: psr2-cursor-mmap-cpu
[568.020191] Starting dynamic subtest: eDP-1
[569.783154] Dynamic subtest eDP-1: SUCCESS (1.765s)
[569.785379] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.766s)
[570.632392] [110/133] (453s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[570.717936] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[570.720075] Starting dynamic subtest: pipe-A-eDP-1
[570.741739] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[570.753374] Starting dynamic subtest: pipe-B-eDP-1
[570.774038] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[570.783223] Starting dynamic subtest: pipe-C-eDP-1
[570.803915] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[570.815955] Starting dynamic subtest: pipe-D-eDP-1
[570.837634] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[570.841977] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[572.933171] [111/133] (450s left) gem_eio (in-flight-contexts-immediate)
[573.171126] Starting subtest: in-flight-contexts-immediate
[584.657256] Subtest in-flight-contexts-immediate: SUCCESS (11.487s)
[584.776465] [112/133] (438s left) testdisplay
[585.080004] [113/133] (438s left) syncobj_wait (invalid-signal-illegal-handle)
[585.132307] Starting subtest: invalid-signal-illegal-handle
[585.134669] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[585.217432] [114/133] (438s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[585.316079] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[591.966550] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.655s)
[592.082798] [115/133] (431s left) kms_psr (pr-suspend)
[592.185444] Starting subtest: pr-suspend
[592.189968] Subtest pr-suspend: SKIP (0.000s)
[592.262727] [116/133] (431s left) kms_cursor_crc (cursor-random-256x256)
[592.506748] Starting subtest: cursor-random-256x256
[592.511679] Starting dynamic subtest: pipe-A-eDP-1
[595.853120] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.341s)
[595.883390] Starting dynamic subtest: pipe-D-eDP-1
[599.954122] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.079s)
[599.956067] Subtest cursor-random-256x256: SUCCESS (7.446s)
[600.840284] [117/133] (423s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[600.958530] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[600.962898] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[601.054915] [118/133] (422s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[601.181986] Starting subtest: cursor-vs-flip-atomic-transitions
[631.625866] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.423s)
[632.444627] [119/133] (391s left) syncobj_wait (wait-any-interrupted)
[632.512267] Starting subtest: wait-any-interrupted
[632.612350] Subtest wait-any-interrupted: SUCCESS (0.101s)
[632.691834] [120/133] (391s left) prime_vgem (fence-flip-hang)
[632.785636] Subtest fence-flip-hang: SKIP (0.000s)
[632.878319] [121/133] (391s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[632.986660] Starting subtest: yf-tiled-8bpp-rotate-180
[632.990983] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[633.071284] [122/133] (391s left) gem_mmap (bad-offset)
[633.140363] Subtest bad-offset: SKIP (0.000s)
[633.205673] [123/133] (390s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[633.337917] Starting subtest: cursorB-vs-flipB-legacy
[633.342567] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[633.483872] [124/133] (390s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[633.535746] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[633.644474] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[633.725020] [125/133] (390s left) perf_pmu (most-busy-idle-check-all)
[633.768609] Starting subtest: most-busy-idle-check-all
[633.770837] Starting dynamic subtest: rcs0
[635.648918] Dynamic subtest rcs0: SUCCESS (1.878s)
[635.661213] Starting dynamic subtest: bcs0
[637.633805] Dynamic subtest bcs0: SUCCESS (1.981s)
[637.648151] Starting dynamic subtest: vcs0
[639.680030] Dynamic subtest vcs0: SUCCESS (2.042s)
[639.693681] Starting dynamic subtest: vcs1
[641.664208] Dynamic subtest vcs1: SUCCESS (1.980s)
[641.677374] Starting dynamic subtest: vecs0
[643.646597] Dynamic subtest vecs0: SUCCESS (1.980s)
[643.660256] Starting dynamic subtest: ccs0
[645.633267] Dynamic subtest ccs0: SUCCESS (1.982s)
[645.636143] Subtest most-busy-idle-check-all: SUCCESS (11.861s)
[645.741516] [126/133] (378s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[645.856679] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[645.861415] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[645.958224] [127/133] (378s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[646.051661] Starting subtest: fbc-psr2-primary-mmap-gtt
[646.054024] Starting dynamic subtest: eDP-1
[646.058465] Dynamic subtest eDP-1: SKIP (0.000s)
[646.062838] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[646.127338] [128/133] (378s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[646.220016] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[646.224438] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[646.335143] [129/133] (378s left) gem_ctx_param (invalid-size-get)
[646.385299] Starting subtest: invalid-size-get
[646.387879] Subtest invalid-size-get: SUCCESS (0.001s)
[646.485560] [130/133] (378s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[646.577579] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[646.579879] Starting dynamic subtest: pipe-A-eDP-1
[646.600288] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[646.611924] Starting dynamic subtest: pipe-B-eDP-1
[646.630939] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[646.640386] Starting dynamic subtest: pipe-C-eDP-1
[646.659189] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[646.668238] Starting dynamic subtest: pipe-D-eDP-1
[646.684377] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[646.686025] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[648.841672] [131/133] (375s left) gem_softpin (allocator-basic)
[648.903029] Starting subtest: allocator-basic
[648.980499] Subtest allocator-basic: SUCCESS (0.077s)
[649.101757] [132/133] (375s left) i915_pciid
[649.244783] [133/133] (375s left) gem_exec_schedule (manyslice)
[649.324127] Starting subtest: manyslice
[649.326153] Starting dynamic subtest: rcs0
[654.459073] Dynamic subtest rcs0: SUCCESS (5.138s)
[654.473624] Starting dynamic subtest: bcs0
[660.574640] Dynamic subtest bcs0: SUCCESS (6.111s)
[660.587660] Starting dynamic subtest: vcs0
[665.646259] Dynamic subtest vcs0: SUCCESS (5.069s)
[665.659268] Starting dynamic subtest: vcs1
[671.724299] Dynamic subtest vcs1: SUCCESS (6.075s)
[671.740192] Starting dynamic subtest: vecs0
[677.800071] Dynamic subtest vecs0: SUCCESS (6.072s)
[677.813577] Starting dynamic subtest: ccs0
[683.981783] Dynamic subtest ccs0: SUCCESS (6.178s)
[683.984535] Subtest manyslice: SUCCESS (34.656s)
[684.299140] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: fbdev
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_content_protection
results: parsing output: 5/ for test: gem_pread
results: parsing output: 6/ for test: i915_drm_fdinfo
results: parsing output: 7/ for test: gem_tiled_blits
results: parsing output: 8/ for test: kms_lease
results: parsing output: 9/ for test: kms_fbcon_fbt
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: gem_exec_whisper
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_invalid_mode
results: parsing output: 14/ for test: kms_cursor_crc
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_vblank
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_dirtyfb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_ctx_create
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: gem_softpin
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: kms_chamelium_edid
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: kms_plane_lowres
results: parsing output: 29/ for test: sysfs_preempt_timeout
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_pipe_crc_basic
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: gem_exec_balancer
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_cdclk
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: i915_pm_rc6_residency
results: parsing output: 42/ for test: gem_ctx_param
results: parsing output: 43/ for test: kms_busy
results: parsing output: 44/ for test: kms_async_flips
results: parsing output: 45/ for test: gem_ctx_exec
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_getfb
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_mmap_write_crc
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: gem_flink_race
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_rmfb
results: parsing output: 54/ for test: prime_busy
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_color
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: kms_addfb_basic
results: parsing output: 62/ for test: gem_partial_pwrite_pread
results: parsing output: 63/ for test: kms_pm_dc
results: parsing output: 64/ for test: kms_prop_blob
results: parsing output: 65/ for test: core_getclient
results: parsing output: 66/ for test: kms_fb_coherency
results: parsing output: 67/ for test: gem_ctx_isolation
results: parsing output: 68/ for test: gem_close_race
results: parsing output: 69/ for test: gen7_exec_parse
results: parsing output: 70/ for test: i915_power
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: gem_workarounds
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_exec_flush
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: device_reset
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: gem_ctx_bad_destroy
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: gem_mmap_offset
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_mmap_wc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_async
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_chamelium_hpd
results: parsing output: 100/ for test: api_intel_bb
results: parsing output: 101/ for test: kms_force_connector_basic
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: kms_sequence
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_eio
results: parsing output: 111/ for test: testdisplay
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_mmap
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_ctx_param
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: gem_softpin
results: parsing output: 131/ for test: i915_pciid
results: parsing output: 132/ for test: gem_exec_schedule
Done.