[58.028508] Initializing watchdogs
[58.028552]   /dev/watchdog0
[58.042260] [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.046502] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.048906] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.052189] [001/133] (960s left) i915_pm_rpm (gem-execbuf)
[60.036285] Starting subtest: gem-execbuf
[60.038603] Starting dynamic subtest: smem0
[61.762701] Dynamic subtest smem0: SUCCESS (1.738s)
[61.765060] Subtest gem-execbuf: SUCCESS (1.739s)
[61.860662] [002/133] (956s left) sysfs_preempt_timeout (timeout)
[61.918707] Starting subtest: timeout
[61.921180] Starting dynamic subtest: vecs0
[71.890183] Dynamic subtest vecs0: SUCCESS (10.000s)
[71.899687] Starting dynamic subtest: ccs0
[73.011543] Dynamic subtest ccs0: SUCCESS (1.124s)
[73.024134] Starting dynamic subtest: vcs0
[82.897517] Dynamic subtest vcs0: SUCCESS (9.888s)
[82.909681] Starting dynamic subtest: bcs0
[84.042733] Dynamic subtest bcs0: SUCCESS (1.146s)
[84.053056] Starting dynamic subtest: rcs0
[85.218471] Dynamic subtest rcs0: SUCCESS (1.174s)
[85.228853] Starting dynamic subtest: vcs1
[94.930290] Dynamic subtest vcs1: SUCCESS (9.710s)
[94.932970] Subtest timeout: SUCCESS (33.048s)
[95.026267] [003/133] (923s left) kms_joiner (basic-big-joiner)
[95.139581] Starting subtest: basic-big-joiner
[95.143813] Subtest basic-big-joiner: SKIP (0.000s)
[95.203906] [004/133] (923s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[95.599811] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[96.374583] [005/133] (922s left) kms_flip (busy-flip)
[96.470653] Starting subtest: busy-flip
[96.473621] Starting dynamic subtest: A-eDP1
[98.217199] Dynamic subtest A-eDP1: SUCCESS (1.748s)
[98.227249] Starting dynamic subtest: B-eDP1
[99.850749] Dynamic subtest B-eDP1: SUCCESS (1.633s)
[99.859899] Starting dynamic subtest: C-eDP1
[101.562431] Dynamic subtest C-eDP1: SUCCESS (1.710s)
[101.572582] Starting dynamic subtest: D-eDP1
[103.198793] Dynamic subtest D-eDP1: SUCCESS (1.635s)
[103.204164] Subtest busy-flip: SUCCESS (6.736s)
[104.365253] [006/133] (914s left) gem_exec_schedule (pi-ringfull)
[104.544365] Starting subtest: pi-ringfull
[104.547054] Starting dynamic subtest: rcs0
[104.590030] Dynamic subtest rcs0: SUCCESS (0.049s)
[104.603739] Starting dynamic subtest: bcs0
[104.617321] Dynamic subtest bcs0: SUCCESS (0.027s)
[104.628503] Starting dynamic subtest: vcs0
[104.644564] Dynamic subtest vcs0: SUCCESS (0.027s)
[104.655595] Starting dynamic subtest: vcs1
[104.671352] Dynamic subtest vcs1: SUCCESS (0.026s)
[104.681891] Starting dynamic subtest: vecs0
[104.697790] Dynamic subtest vecs0: SUCCESS (0.026s)
[104.708575] Starting dynamic subtest: ccs0
[104.725346] Dynamic subtest ccs0: SUCCESS (0.027s)
[104.727602] Subtest pi-ringfull: SUCCESS (0.184s)
[104.945295] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[104.948995] [007/133] (913s left) kms_psr (psr-cursor-render)
[105.053057] Starting subtest: psr-cursor-render
[105.055770] Starting dynamic subtest: eDP-1
[106.766039] Dynamic subtest eDP-1: SUCCESS (1.712s)
[106.768068] Subtest psr-cursor-render: SUCCESS (1.713s)
[107.632115] [008/133] (911s left) gen7_exec_parse (basic-allowed)
[107.688233] Subtest basic-allowed: SKIP (0.000s)
[107.752813] [009/133] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[107.850554] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[107.855106] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[107.964709] [010/133] (910s left) kms_pm_rpm (modeset-non-lpsp)
[110.098912] Starting subtest: modeset-non-lpsp
[111.265895] Subtest modeset-non-lpsp: SKIP (1.168s)
[111.658735] [011/133] (907s left) gem_ctx_exec (basic)
[111.715995] Starting subtest: basic
[111.720896] Subtest basic: SUCCESS (0.005s)
[111.831654] [012/133] (907s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[111.883654] Starting subtest: invalid-bsd1-flag-on-vebox
[111.886038] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[111.983724] [013/133] (907s left) kms_dp_linktrain_fallback (dsc-fallback)
[112.077275] Starting subtest: dsc-fallback
[112.083964] Subtest dsc-fallback: SKIP (0.000s)
[112.149819] [014/133] (906s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[112.281879] Starting subtest: dp-mst-lic-type-0-hdcp14
[112.286528] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[112.420675] [015/133] (906s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[114.147699] Starting subtest: dpms-mode-unset-non-lpsp
[115.289491] Subtest dpms-mode-unset-non-lpsp: SKIP (1.144s)
[115.661915] [016/133] (903s left) gem_mmap_gtt (bad-object)
[115.725348] Subtest bad-object: SKIP (0.000s)
[115.785096] [017/133] (903s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[115.884692] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[115.969096] [018/133] (903s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[116.067897] Starting subtest: 4-tiled-8bpp-rotate-0
[117.236814] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.171s)
[117.361155] [019/133] (901s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[117.458337] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[117.462045] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[117.557879] [020/133] (901s left) syncobj_wait (wait-all-complex)
[117.614164] Starting subtest: wait-all-complex
[117.832459] Subtest wait-all-complex: SUCCESS (0.216s)
[117.906199] [021/133] (901s left) gem_render_tiled_blits (basic)
[117.961035] Subtest basic: SKIP (0.000s)
[118.041195] [022/133] (901s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[118.134422] Starting subtest: yf-tiled-32bpp-rotate-90
[118.138514] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[118.233860] [023/133] (901s left) kms_fence_pin_leak
[118.399652] [024/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[118.494457] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[125.501204] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.008s)
[125.610900] [025/133] (893s left) gem_exec_balancer (bonded-true-hang)
[125.882592] Starting subtest: bonded-true-hang
[125.887393] Subtest bonded-true-hang: SKIP (0.000s)
[125.985552] [026/133] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[126.076503] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[126.080968] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[126.187420] [027/133] (893s left) gem_ctx_isolation (nonpriv-switch)
[126.239050] Starting subtest: nonpriv-switch
[126.241388] Starting dynamic subtest: rcs0
[126.538032] Dynamic subtest rcs0: SUCCESS (0.299s)
[126.549197] Starting dynamic subtest: bcs0
[126.844144] Dynamic subtest bcs0: SUCCESS (0.306s)
[126.854344] Starting dynamic subtest: vcs0
[127.131577] Dynamic subtest vcs0: SUCCESS (0.287s)
[127.139981] Starting dynamic subtest: vcs1
[129.232782] Dynamic subtest vcs1: SUCCESS (2.100s)
[129.241281] Starting dynamic subtest: vecs0
[131.197182] Dynamic subtest vecs0: SUCCESS (1.964s)
[131.204805] Starting dynamic subtest: ccs0
[133.241992] Dynamic subtest ccs0: SUCCESS (2.044s)
[133.244469] Subtest nonpriv-switch: SUCCESS (7.003s)
[133.473320] [028/133] (886s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[133.561761] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[133.591642] Starting dynamic subtest: pipe-A-plane-0
[133.900865] Dynamic subtest pipe-A-plane-0: SUCCESS (0.311s)
[133.909233] Starting dynamic subtest: pipe-A-plane-3
[134.134467] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[135.251890] Starting dynamic subtest: pipe-B-plane-0
[135.544042] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[135.552141] Starting dynamic subtest: pipe-B-plane-3
[135.777266] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[136.097702] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.534s)
[136.922977] [029/133] (882s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[137.025945] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[137.030659] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[137.095743] [030/133] (882s left) i915_hangman (engine-engine-error)
[137.149367] Starting subtest: engine-engine-error
[137.151736] Starting dynamic subtest: rcs0
[138.870076] Dynamic subtest rcs0: SUCCESS (1.719s)
[138.881321] Starting dynamic subtest: bcs0
[140.850888] Dynamic subtest bcs0: SUCCESS (1.978s)
[140.863144] Starting dynamic subtest: vcs0
[142.900067] Dynamic subtest vcs0: SUCCESS (2.047s)
[142.911279] Starting dynamic subtest: vcs1
[144.883916] Dynamic subtest vcs1: SUCCESS (1.982s)
[144.896712] Starting dynamic subtest: vecs0
[146.867033] Dynamic subtest vecs0: SUCCESS (1.981s)
[146.878254] Starting dynamic subtest: ccs0
[148.915063] Dynamic subtest ccs0: SUCCESS (2.046s)
[148.918035] Subtest engine-engine-error: SUCCESS (11.764s)
[148.999938] [031/133] (870s left) gem_mmap_gtt (hang)
[149.059288] Subtest hang: SKIP (0.000s)
[149.130223] [032/133] (870s left) perf_pmu (invalid-open)
[149.174721] Starting subtest: invalid-open
[149.177090] Subtest invalid-open: SUCCESS (0.000s)
[149.284239] [033/133] (870s left) kms_properties (colorop-properties-atomic)
[149.391016] Starting subtest: colorop-properties-atomic
[149.393399] Starting dynamic subtest: pipe-A-eDP-1
[149.746218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.356s)
[149.761875] Starting dynamic subtest: pipe-B-eDP-1
[150.767845] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.018s)
[150.784598] Starting dynamic subtest: pipe-C-eDP-1
[151.806513] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.037s)
[151.815863] Starting dynamic subtest: pipe-D-eDP-1
[152.844703] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.039s)
[152.847366] Subtest colorop-properties-atomic: SUCCESS (3.455s)
[153.652316] [034/133] (866s left) kms_cursor_crc (cursor-onscreen-256x85)
[153.894410] Starting subtest: cursor-onscreen-256x85
[153.939484] Subtest cursor-onscreen-256x85: SKIP (0.040s)
[154.105266] [035/133] (865s left) gem_exec_balancer (waits)
[154.171048] Starting subtest: waits
[160.656608] Subtest waits: SUCCESS (6.485s)
[160.978375] [036/133] (859s left) gem_ctx_persistence (hang)
[161.039133] Starting subtest: hang
[161.043880] Subtest hang: SKIP (0.000s)
[161.134861] [037/133] (858s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[161.252350] Starting subtest: 2x-long-cursor-vs-flip-legacy
[161.256919] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[161.401681] [038/133] (858s left) gem_exec_fence (nb-await)
[161.582968] Starting subtest: nb-await
[161.585618] Starting dynamic subtest: rcs0
[161.649329] Dynamic subtest rcs0: SUCCESS (0.067s)
[161.659900] Starting dynamic subtest: bcs0
[161.707776] Dynamic subtest bcs0: SUCCESS (0.057s)
[161.720556] Starting dynamic subtest: vcs0
[161.768387] Dynamic subtest vcs0: SUCCESS (0.059s)
[161.779218] Starting dynamic subtest: vcs1
[161.829501] Dynamic subtest vcs1: SUCCESS (0.060s)
[161.839683] Starting dynamic subtest: vecs0
[161.888590] Dynamic subtest vecs0: SUCCESS (0.058s)
[161.899640] Starting dynamic subtest: ccs0
[161.948269] Dynamic subtest ccs0: SUCCESS (0.058s)
[161.951066] Subtest nb-await: SUCCESS (0.366s)
[164.017567] [039/133] (856s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[164.111515] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[164.115615] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[164.210035] [040/133] (855s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[164.305855] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[164.308190] Starting dynamic subtest: pipe-A-eDP-1
[164.367657] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[164.374823] Starting dynamic subtest: pipe-B-eDP-1
[164.430362] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[164.439771] Starting dynamic subtest: pipe-C-eDP-1
[164.496496] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[164.505645] Starting dynamic subtest: pipe-D-eDP-1
[164.562602] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[164.566894] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[166.524295] [041/133] (853s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[166.634281] Starting subtest: basic-flip-after-cursor-legacy
[167.555258] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.920s)
[168.359926] [042/133] (851s left) kms_cursor_crc (cursor-sliding-64x21)
[168.559974] Starting subtest: cursor-sliding-64x21
[168.606601] Subtest cursor-sliding-64x21: SKIP (0.042s)
[168.838982] [043/133] (851s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[168.934717] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[168.938992] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[169.004634] [044/133] (851s left) perf (sysctl-defaults)
[169.089032] Starting subtest: sysctl-defaults
[169.091685] Subtest sysctl-defaults: SUCCESS (0.000s)
[169.181758] [045/133] (851s left) gem_exec_schedule (preempt-self)
[169.261704] Starting subtest: preempt-self
[169.263926] Starting dynamic subtest: rcs0
[169.276304] Dynamic subtest rcs0: SUCCESS (0.020s)
[169.285525] Starting dynamic subtest: bcs0
[169.294674] Dynamic subtest bcs0: SUCCESS (0.018s)
[169.302377] Starting dynamic subtest: vcs0
[169.313266] Dynamic subtest vcs0: SUCCESS (0.018s)
[169.320487] Starting dynamic subtest: vcs1
[169.334242] Dynamic subtest vcs1: SUCCESS (0.020s)
[169.347959] Starting dynamic subtest: vecs0
[169.355862] Dynamic subtest vecs0: SUCCESS (0.021s)
[169.365778] Starting dynamic subtest: ccs0
[169.378378] Dynamic subtest ccs0: SUCCESS (0.022s)
[169.380246] Subtest preempt-self: SUCCESS (0.123s)
[171.005467] [046/133] (849s left) gem_eio (throttle)
[171.232486] Starting subtest: throttle
[171.571426] Subtest throttle: SUCCESS (0.340s)
[171.685279] [047/133] (848s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[171.779215] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[171.783316] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[171.870237] [048/133] (848s left) gem_exec_whisper (basic-sync-all)
[171.944177] Starting subtest: basic-sync-all
[179.583640] Subtest basic-sync-all: SUCCESS (7.637s)
[179.781856] [049/133] (840s left) i915_query (query-topology-coherent-slice-mask)
[179.848982] Starting subtest: query-topology-coherent-slice-mask
[179.853582] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[179.966941] [050/133] (840s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[180.080020] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[180.084424] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[180.175334] [051/133] (840s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[180.272744] Starting subtest: fbc-tiling-linear
[184.008666] Subtest fbc-tiling-linear: SUCCESS (3.739s)
[185.185697] [052/133] (835s left) gem_exec_schedule (fairslice)
[185.263011] Starting subtest: fairslice
[185.265427] Starting dynamic subtest: rcs0
[187.275693] Dynamic subtest rcs0: SUCCESS (2.018s)
[187.290466] Starting dynamic subtest: bcs0
[189.292497] Dynamic subtest bcs0: SUCCESS (2.017s)
[189.305066] Starting dynamic subtest: vcs0
[191.312347] Dynamic subtest vcs0: SUCCESS (2.019s)
[191.322841] Starting dynamic subtest: vcs1
[193.331435] Dynamic subtest vcs1: SUCCESS (2.017s)
[193.341961] Starting dynamic subtest: vecs0
[195.350256] Dynamic subtest vecs0: SUCCESS (2.020s)
[195.360014] Starting dynamic subtest: ccs0
[197.375841] Dynamic subtest ccs0: SUCCESS (2.024s)
[197.377920] Subtest fairslice: SUCCESS (12.119s)
[197.676716] [053/133] (823s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[197.769662] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[201.709821] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.943s)
[202.891893] [054/133] (817s left) i915_drm_fdinfo (virtual-busy-hang-all)
[202.939301] Starting subtest: virtual-busy-hang-all
[202.943969] Subtest virtual-busy-hang-all: SKIP (0.000s)
[203.000204] [055/133] (817s left) kms_chamelium_audio (dp-audio-edid)
[203.383642] Subtest dp-audio-edid: SKIP (0.000s)
[204.194008] [056/133] (816s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[204.297508] Starting subtest: psr-rgb565-draw-mmap-cpu
[211.140441] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.847s)
[211.259796] [057/133] (809s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[211.385513] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[211.390170] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[211.549546] [058/133] (809s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[211.645809] Starting subtest: plane-upscale-20x20-with-modifiers
[211.648187] Starting dynamic subtest: pipe-A
[211.981912] Dynamic subtest pipe-A: SUCCESS (0.338s)
[211.997284] Starting dynamic subtest: pipe-B
[213.424938] Dynamic subtest pipe-B: SUCCESS (1.442s)
[213.434422] Starting dynamic subtest: pipe-C
[214.858492] Dynamic subtest pipe-C: SUCCESS (1.432s)
[214.866802] Starting dynamic subtest: pipe-D
[216.293298] Dynamic subtest pipe-D: SUCCESS (1.433s)
[216.295624] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.649s)
[217.476720] [059/133] (803s left) kms_chamelium_edid (dp-edid-read)
[217.863269] Subtest dp-edid-read: SKIP (0.000s)
[218.670148] [060/133] (802s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[218.770945] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[218.773221] Starting dynamic subtest: pipe-A-eDP-1
[218.795244] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[218.805301] Starting dynamic subtest: pipe-B-eDP-1
[218.826020] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[218.833836] Starting dynamic subtest: pipe-C-eDP-1
[218.854465] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[218.862591] Starting dynamic subtest: pipe-D-eDP-1
[218.883219] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[218.887276] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[220.967738] [061/133] (800s left) gem_exec_parallel (fds)
[221.040177] Starting subtest: fds
[221.042536] Starting dynamic subtest: rcs0
[223.636401] Dynamic subtest rcs0: SUCCESS (2.593s)
[223.649026] Starting dynamic subtest: bcs0
[227.571847] Dynamic subtest bcs0: SUCCESS (3.934s)
[227.583863] Starting dynamic subtest: vcs0
[231.206392] Dynamic subtest vcs0: SUCCESS (3.631s)
[231.217426] Starting dynamic subtest: vcs1
[235.148388] Dynamic subtest vcs1: SUCCESS (3.939s)
[235.157056] Starting dynamic subtest: vecs0
[239.228363] Dynamic subtest vecs0: SUCCESS (4.080s)
[239.239873] Starting dynamic subtest: ccs0
[243.186911] Dynamic subtest ccs0: SUCCESS (3.956s)
[243.189368] Subtest fds: SUCCESS (22.144s)
[243.397686] [062/133] (777s left) gem_mmap_gtt (flink-race)
[243.454480] Subtest flink-race: SKIP (0.000s)
[243.507670] [063/133] (777s left) syncobj_timeline (invalid-query-bad-pad)
[243.558232] Starting subtest: invalid-query-bad-pad
[243.560469] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[243.666548] [064/133] (777s left) kms_selftest (drm_dp_mst_helper)
[243.705591] Starting subtest: drm_dp_mst_helper
[243.766785] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[243.899783] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.133s)
[243.910433] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[244.011017] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.109s)
[244.020695] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[244.105774] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.096s)
[244.107975] Subtest drm_dp_mst_helper: SUCCESS (0.404s)
[244.282463] [065/133] (776s left) sriov_basic (enable-vfs-autoprobe-on)
[244.333108] Starting subtest: enable-vfs-autoprobe-on
[244.335465] Starting dynamic subtest: numvfs-1
[244.410613] Dynamic subtest numvfs-1: FAIL (0.017s)
[244.424136] Starting dynamic subtest: numvfs-2
[244.499950] Dynamic subtest numvfs-2: FAIL (0.003s)
[244.513194] Starting dynamic subtest: numvfs-3
[244.586961] Dynamic subtest numvfs-3: FAIL (0.004s)
[244.597041] Starting dynamic subtest: numvfs-4
[244.670736] Dynamic subtest numvfs-4: FAIL (0.004s)
[244.681209] Starting dynamic subtest: numvfs-5
[244.757061] Dynamic subtest numvfs-5: FAIL (0.003s)
[244.767810] Starting dynamic subtest: numvfs-6
[244.841497] Dynamic subtest numvfs-6: FAIL (0.003s)
[244.851063] Starting dynamic subtest: numvfs-7
[244.924801] Dynamic subtest numvfs-7: FAIL (0.003s)
[244.933559] Starting dynamic subtest: numvfs-random
[244.989840] Dynamic subtest numvfs-random: FAIL (0.003s)
[244.997914] Starting dynamic subtest: numvfs-all
[245.056732] Dynamic subtest numvfs-all: FAIL (0.527s)
[245.058737] Subtest enable-vfs-autoprobe-on: FAIL (0.575s)
[245.095449] [066/133] (776s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[245.151058] Starting subtest: multi-wait-available-unsubmitted-submitted
[245.153197] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[245.265900] [067/133] (776s left) dmabuf_sync_file (import-multiple-read-write)
[245.306652] Starting subtest: import-multiple-read-write
[245.308733] Subtest import-multiple-read-write: SUCCESS (0.003s)
[245.364704] [068/133] (775s left) kms_mmap_write_crc (main)
[245.460915] Starting subtest: main
[245.463382] Starting dynamic subtest: pipe-A-eDP-1
[248.967292] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.503s)
[248.969626] Subtest main: SUCCESS (3.504s)
[249.791449] [069/133] (771s left) api_intel_bb (reset-flags)
[249.859293] Starting subtest: reset-flags
[249.866130] Subtest reset-flags: SUCCESS (0.009s)
[250.006907] [070/133] (771s left) gem_exec_params (rsvd2-dirt)
[250.057759] Starting subtest: rsvd2-dirt
[250.062078] Subtest rsvd2-dirt: SKIP (0.000s)
[250.155842] [071/133] (771s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[250.282434] Starting subtest: cursor-vs-flip-atomic-transitions
[280.442681] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.157s)
[281.312193] [072/133] (740s left) api_intel_allocator (simple-allocator)
[281.373415] Starting subtest: simple-allocator
[281.375891] Starting dynamic subtest: basic
[281.378305] Dynamic subtest basic: SUCCESS (0.003s)
[281.390744] Starting dynamic subtest: parallel-one
[281.570257] Dynamic subtest parallel-one: SUCCESS (0.192s)
[281.582084] Starting dynamic subtest: print
[281.584272] Dynamic subtest print: SUCCESS (0.000s)
[281.593315] Starting dynamic subtest: reuse
[281.595437] Dynamic subtest reuse: SUCCESS (0.000s)
[281.604138] Starting dynamic subtest: reserve
[281.606270] Dynamic subtest reserve: SUCCESS (0.000s)
[281.614784] Starting dynamic subtest: fork-reopen-allocator
[281.616970] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[281.619171] Subtest simple-allocator: SUCCESS (0.211s)
[281.719026] [073/133] (739s left) prime_vgem (fence-read-hang)
[281.794199] Subtest fence-read-hang: SKIP (0.000s)
[281.911280] [074/133] (739s left) kms_psr (psr-sprite-blt)
[282.008957] Starting subtest: psr-sprite-blt
[282.011193] Starting dynamic subtest: eDP-1
[283.735350] Dynamic subtest eDP-1: SUCCESS (1.726s)
[283.737695] Subtest psr-sprite-blt: SUCCESS (1.727s)
[284.571203] [075/133] (737s left) sw_sync (sync_busy_fork_unixsocket)
[284.614066] Starting subtest: sync_busy_fork_unixsocket
[284.620368] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[284.669473] [076/133] (736s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[284.770107] Starting subtest: bad-aux-stride-yf-tiled-ccs
[284.772406] Starting dynamic subtest: pipe-A-eDP-1
[284.795163] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[284.805141] Starting dynamic subtest: pipe-B-eDP-1
[284.826176] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[284.834629] Starting dynamic subtest: pipe-C-eDP-1
[284.855463] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[284.863978] Starting dynamic subtest: pipe-D-eDP-1
[284.885205] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[284.889058] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[287.041568] [077/133] (734s left) prime_mmap (test_refcounting)
[287.110311] Starting subtest: test_refcounting
[287.112259] Starting dynamic subtest: test_refcounting-smem
[287.143906] Dynamic subtest test_refcounting-smem: SUCCESS (0.035s)
[287.146340] Subtest test_refcounting: SUCCESS (0.036s)
[287.243064] [078/133] (734s left) kms_color (ctm-blue-to-red)
[287.331986] Starting subtest: ctm-blue-to-red
[287.333896] Starting dynamic subtest: pipe-A-eDP-1
[288.006522] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.676s)
[288.017817] Starting dynamic subtest: pipe-B-eDP-1
[289.412960] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.403s)
[289.432418] Starting dynamic subtest: pipe-C-eDP-1
[290.770372] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[290.780114] Starting dynamic subtest: pipe-D-eDP-1
[292.111467] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[292.113822] Subtest ctm-blue-to-red: SUCCESS (4.779s)
[292.952930] [079/133] (728s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[293.036141] Starting subtest: fbc-psr-sprite-mmap-cpu
[293.038481] Starting dynamic subtest: eDP-1
[293.042528] Dynamic subtest eDP-1: SKIP (0.000s)
[293.046632] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[293.108854] [080/133] (728s left) gem_exec_whisper (basic-contexts)
[293.165865] Starting subtest: basic-contexts
[300.033450] Subtest basic-contexts: SUCCESS (6.866s)
[300.214775] [081/133] (721s left) kms_psr (fbc-psr-suspend)
[300.319932] Starting subtest: fbc-psr-suspend
[300.322156] Starting dynamic subtest: eDP-1
[300.326155] Dynamic subtest eDP-1: SKIP (0.000s)
[300.330190] Subtest fbc-psr-suspend: SKIP (0.001s)
[300.406349] [082/133] (721s left) gen9_exec_parse (bb-start-param)
[300.470289] Subtest bb-start-param: SKIP (0.000s)
[300.537045] [083/133] (721s left) syncobj_wait (single-wait-all-for-submit-signaled)
[300.592575] Starting subtest: single-wait-all-for-submit-signaled
[300.594562] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[300.702077] [084/133] (721s left) gem_exec_async (concurrent-writes)
[300.773686] Starting subtest: concurrent-writes
[300.776215] Starting dynamic subtest: rcs0
[300.791916] Dynamic subtest rcs0: SUCCESS (0.018s)
[300.801993] Starting dynamic subtest: bcs0
[300.804382] Dynamic subtest bcs0: SUCCESS (0.007s)
[300.813962] Starting dynamic subtest: vcs0
[300.815874] Dynamic subtest vcs0: SUCCESS (0.006s)
[300.825593] Starting dynamic subtest: vcs1
[300.827973] Dynamic subtest vcs1: SUCCESS (0.010s)
[300.836611] Starting dynamic subtest: vecs0
[300.838871] Dynamic subtest vecs0: SUCCESS (0.006s)
[300.847182] Starting dynamic subtest: ccs0
[300.849300] Dynamic subtest ccs0: SUCCESS (0.007s)
[300.851422] Subtest concurrent-writes: SUCCESS (0.059s)
[301.059910] [085/133] (720s left) gem_userptr_blits (stress-mm)
[301.137765] Starting subtest: stress-mm
[306.505579] Subtest stress-mm: SUCCESS (5.370s)
[306.634971] [086/133] (715s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[306.739145] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[306.741548] Starting dynamic subtest: pipe-A-eDP-1
[312.637709] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.904s)
[312.648165] Starting dynamic subtest: pipe-B-eDP-1
[319.284076] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.645s)
[319.286453] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.552s)
[320.156228] [087/133] (701s left) kms_flip (flip-vs-suspend-interruptible)
[320.251119] Starting subtest: flip-vs-suspend-interruptible
[320.253361] Starting dynamic subtest: A-eDP1
[353.483596] Dynamic subtest A-eDP1: SUCCESS (4.345s)
[353.499912] Starting dynamic subtest: B-eDP1
[402.461039] Dynamic subtest B-eDP1: SUCCESS (4.526s)
[402.472031] Starting dynamic subtest: C-eDP1
[451.440592] Dynamic subtest C-eDP1: SUCCESS (4.603s)
[451.452385] Starting dynamic subtest: D-eDP1
[500.482178] Dynamic subtest D-eDP1: SUCCESS (4.591s)
[500.488559] Subtest flip-vs-suspend-interruptible: SUCCESS (18.078s)
[501.689197] [088/133] (520s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[501.794007] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[502.958291] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.190s)
[503.082086] [089/133] (519s left) gem_exec_reloc (basic-cpu-read-noreloc)
[503.136311] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[503.202562] [090/133] (519s left) kms_vrr (lobf)
[503.285397] Starting subtest: lobf
[503.289574] Subtest lobf: SKIP (0.000s)
[503.358807] [091/133] (518s left) kms_vrr (flip-basic)
[503.445576] Starting subtest: flip-basic
[503.452392] Subtest flip-basic: SKIP (0.000s)
[503.518659] [092/133] (518s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[503.572649] Starting subtest: x-tiled-to-vebox-y-tiled
[503.577282] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[503.756164] [093/133] (518s left) perf (invalid-oa-metric-set-id)
[503.863343] Starting subtest: invalid-oa-metric-set-id
[503.876638] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[503.917839] [094/133] (518s left) kms_big_fb (linear-16bpp-rotate-270)
[504.027931] Starting subtest: linear-16bpp-rotate-270
[504.045183] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[504.157400] [095/133] (518s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[504.247975] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[504.252645] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[504.344816] [096/133] (518s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[504.397320] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[504.403214] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[504.591400] [097/133] (517s left) syncobj_eventfd (binary-wait-signaled)
[504.647829] Starting subtest: binary-wait-signaled
[504.650128] Subtest binary-wait-signaled: SUCCESS (0.000s)
[504.753288] [098/133] (517s left) kms_plane_alpha_blend (constant-alpha-max)
[504.846942] Starting subtest: constant-alpha-max
[505.130121] Starting dynamic subtest: pipe-A-eDP-1
[506.216742] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.099s)
[506.227669] Starting dynamic subtest: pipe-D-eDP-1
[507.826475] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.627s)
[507.829136] Subtest constant-alpha-max: SUCCESS (3.018s)
[508.639187] [099/133] (513s left) kms_flip (2x-flip-vs-dpms)
[508.740172] Starting subtest: 2x-flip-vs-dpms
[508.749789] Subtest 2x-flip-vs-dpms: SKIP (0.012s)
[508.832655] [100/133] (513s left) gem_userptr_blits (readonly-unsync)
[508.904394] Subtest readonly-unsync: SKIP (0.000s)
[509.030088] [101/133] (513s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[509.122749] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[516.115397] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.035s)
[516.244065] [102/133] (506s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[516.344227] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[516.349590] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[516.426383] [103/133] (506s left) i915_power (sanity)
[516.480971] Starting subtest: sanity
[520.532000] Subtest sanity: SUCCESS (4.057s)
[522.576108] [104/133] (500s left) kms_draw_crc (draw-method-mmap-gtt)
[522.686646] Starting subtest: draw-method-mmap-gtt
[522.692250] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[522.793674] [105/133] (500s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[522.898361] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[522.903948] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[523.002453] [106/133] (499s left) sw_sync (sync_merge_invalid)
[523.045879] Starting subtest: sync_merge_invalid
[523.072706] Subtest sync_merge_invalid: SUCCESS (0.025s)
[523.143912] [107/133] (499s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[523.241079] Starting subtest: y-tiled-16bpp-rotate-180
[523.246317] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[523.337690] [108/133] (499s left) kms_flip (2x-plain-flip-interruptible)
[523.431770] Starting subtest: 2x-plain-flip-interruptible
[523.443597] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[523.517459] [109/133] (499s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[523.615224] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[523.617553] Starting dynamic subtest: pipe-A-eDP-1
[523.638564] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[523.651241] Starting dynamic subtest: pipe-B-eDP-1
[523.671941] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[523.681365] Starting dynamic subtest: pipe-C-eDP-1
[523.702138] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[523.711698] Starting dynamic subtest: pipe-D-eDP-1
[523.733923] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[523.738111] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[525.776048] [110/133] (497s left) kms_async_flips (invalid-async-flip)
[525.880218] Starting subtest: invalid-async-flip
[526.257138] Starting dynamic subtest: pipe-A-eDP-1
[527.103716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.849s)
[527.462150] Starting dynamic subtest: pipe-B-eDP-1
[528.240836] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.787s)
[528.596197] Starting dynamic subtest: pipe-C-eDP-1
[529.356373] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[529.710256] Starting dynamic subtest: pipe-D-eDP-1
[530.495821] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.796s)
[530.498385] Subtest invalid-async-flip: SUCCESS (4.625s)
[531.644819] [111/133] (491s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[531.755084] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[538.297214] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.605s)
[538.425261] [112/133] (484s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[538.483283] Starting subtest: invalid-bsd1-flag-on-blt
[538.485618] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[538.560854] [113/133] (484s left) kms_plane_multiple (2x-tiling-none)
[538.654353] Starting subtest: 2x-tiling-none
[538.659420] Subtest 2x-tiling-none: SKIP (0.000s)
[538.741240] [114/133] (484s left) gem_create (busy-create)
[538.794242] Starting subtest: busy-create
[538.796989] Starting dynamic subtest: smem0
[572.494988] Dynamic subtest smem0: SUCCESS (33.744s)
[572.497922] Subtest busy-create: SUCCESS (33.746s)
[572.702450] [115/133] (450s left) syncobj_timeline (single-wait-available-signaled)
[572.776427] Starting subtest: single-wait-available-signaled
[572.779256] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[572.876274] [116/133] (450s left) syncobj_timeline (host-signal-points)
[572.938074] Starting subtest: host-signal-points
[572.940268] Subtest host-signal-points: SUCCESS (0.004s)
[573.035175] [117/133] (450s left) gem_mmap_wc (bad-object)
[573.103233] Subtest bad-object: SKIP (0.000s)
[573.162541] [118/133] (450s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[573.284077] Starting subtest: cursorA-vs-flipA-toggle
[584.419766] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.136s)
[585.302522] [119/133] (438s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[585.404009] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[585.409132] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[585.488752] [120/133] (437s left) gem_spin_batch (engines)
[585.545631] Starting subtest: engines
[585.548224] Starting dynamic subtest: rcs0
[588.784359] Dynamic subtest rcs0: SUCCESS (3.234s)
[588.797368] Starting dynamic subtest: bcs0
[592.021296] Dynamic subtest bcs0: SUCCESS (3.235s)
[592.032847] Starting dynamic subtest: vcs0
[595.257737] Dynamic subtest vcs0: SUCCESS (3.234s)
[595.271252] Starting dynamic subtest: vcs1
[598.495779] Dynamic subtest vcs1: SUCCESS (3.235s)
[598.509644] Starting dynamic subtest: vecs0
[601.731483] Dynamic subtest vecs0: SUCCESS (3.234s)
[601.744635] Starting dynamic subtest: ccs0
[604.969072] Dynamic subtest ccs0: SUCCESS (3.235s)
[604.971966] Subtest engines: SUCCESS (19.425s)
[605.211840] [121/133] (418s left) gem_close (basic)
[605.275169] Starting subtest: basic
[605.278201] Subtest basic: SUCCESS (0.000s)
[605.371131] [122/133] (418s left) gem_basic (multigpu-create-close)
[605.438270] Starting subtest: multigpu-create-close
[605.443373] Subtest multigpu-create-close: SKIP (0.000s)
[605.554455] [123/133] (418s left) kms_flip (blocking-wf_vblank)
[605.660992] Starting subtest: blocking-wf_vblank
[605.663378] Starting dynamic subtest: A-eDP1
[614.652385] Dynamic subtest A-eDP1: SUCCESS (8.994s)
[614.662653] Starting dynamic subtest: B-eDP1
[623.581881] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[623.595863] Starting dynamic subtest: C-eDP1
[632.499321] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[632.514196] Starting dynamic subtest: D-eDP1
[641.437529] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[641.440416] Subtest blocking-wf_vblank: SUCCESS (35.779s)
[642.685142] [124/133] (380s left) syncobj_wait (wait-all-for-submit-complex)
[642.743457] Starting subtest: wait-all-for-submit-complex
[642.958641] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[643.037362] [125/133] (380s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[643.134402] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[643.139951] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[643.239526] [126/133] (380s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[643.347471] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[650.690318] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.346s)
[650.801770] [127/133] (372s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[650.901392] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[650.904049] Starting dynamic subtest: pipe-A-eDP-1
[651.743986] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s)
[651.754832] Starting dynamic subtest: pipe-B-eDP-1
[653.320118] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.568s)
[653.344030] Starting dynamic subtest: pipe-C-eDP-1
[654.820297] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.499s)
[654.833305] Starting dynamic subtest: pipe-D-eDP-1
[656.278045] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.455s)
[656.280714] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.364s)
[657.441240] [128/133] (366s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[657.545727] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[661.248353] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.707s)
[662.464702] [129/133] (361s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[662.563390] Starting subtest: fbc-psr2-sprite-mmap-cpu
[662.566250] Starting dynamic subtest: eDP-1
[662.571814] Dynamic subtest eDP-1: SKIP (0.000s)
[662.577152] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[662.636549] [130/133] (361s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[662.735097] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[666.836359] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.105s)
[668.063711] [131/133] (355s left) kms_properties (get_properties-sanity-atomic)
[668.165304] Starting subtest: get_properties-sanity-atomic
[668.168215] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[668.252630] [132/133] (355s left) kms_plane (plane-panning-top-left)
[668.342391] Starting subtest: plane-panning-top-left
[668.345226] Starting dynamic subtest: pipe-A
[670.011098] Dynamic subtest pipe-A: SUCCESS (1.671s)
[670.022406] Starting dynamic subtest: pipe-B
[672.366860] Dynamic subtest pipe-B: SUCCESS (2.354s)
[672.369550] Subtest plane-panning-top-left: SUCCESS (4.027s)
[673.184399] [133/133] (350s left) kms_cursor_crc (cursor-random-max-size)
[673.477180] Starting subtest: cursor-random-max-size
[673.484654] Subtest cursor-random-max-size: SKIP (0.000s)
[673.582086] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rpm
results: parsing output: 1/ for test: sysfs_preempt_timeout
results: parsing output: 2/ for test: kms_joiner
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: gen7_exec_parse
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: gem_ctx_exec
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: kms_dp_linktrain_fallback
results: parsing output: 13/ for test: kms_content_protection
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: gem_render_tiled_blits
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_fence_pin_leak
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_ctx_isolation
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: i915_hangman
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: gem_eio
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_whisper
results: parsing output: 48/ for test: i915_query
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: i915_drm_fdinfo
results: parsing output: 54/ for test: kms_chamelium_audio
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: kms_chamelium_edid
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: gem_exec_parallel
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_selftest
results: parsing output: 64/ for test: sriov_basic
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: dmabuf_sync_file
results: parsing output: 67/ for test: kms_mmap_write_crc
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: api_intel_allocator
results: parsing output: 72/ for test: prime_vgem
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: prime_mmap
results: parsing output: 77/ for test: kms_color
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: gen9_exec_parse
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: gem_exec_async
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: kms_vrr
results: parsing output: 90/ for test: kms_vrr
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: perf
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: syncobj_eventfd
results: parsing output: 97/ for test: kms_plane_alpha_blend
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: i915_power
results: parsing output: 103/ for test: kms_draw_crc
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: sw_sync
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_async_flips
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_params
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: gem_create
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_mmap_wc
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_spin_batch
results: parsing output: 120/ for test: gem_close
results: parsing output: 121/ for test: gem_basic
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_properties
results: parsing output: 131/ for test: kms_plane
results: parsing output: 132/ for test: kms_cursor_crc
Done.