[56.642748] Initializing watchdogs
[56.642806]   /dev/watchdog0
[56.657526] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.662103] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.664417] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.667940] [001/132] (960s left) gem_softpin (evict-snoop-interruptible)
[56.750705] Starting subtest: evict-snoop-interruptible
[56.755737] Subtest evict-snoop-interruptible: SKIP (0.000s)
[56.871946] [002/132] (960s left) kms_vblank (ts-continuation-modeset-hang)
[56.976723] Starting subtest: ts-continuation-modeset-hang
[56.979598] Starting dynamic subtest: pipe-A-eDP-1
[71.024327] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.110s)
[71.038471] Starting dynamic subtest: pipe-D-eDP-1
[96.059738] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.042s)
[96.062213] Subtest ts-continuation-modeset-hang: SUCCESS (39.156s)
[96.866857] [003/132] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[96.968808] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[104.007209] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (7.040s)
[104.156166] [004/132] (913s left) kms_flip (basic-plain-flip)
[104.253891] Starting subtest: basic-plain-flip
[104.256338] Starting dynamic subtest: A-eDP1
[106.026106] Dynamic subtest A-eDP1: SUCCESS (1.774s)
[106.038609] Starting dynamic subtest: B-eDP1
[107.749308] Dynamic subtest B-eDP1: SUCCESS (1.722s)
[107.761271] Starting dynamic subtest: C-eDP1
[109.374738] Dynamic subtest C-eDP1: SUCCESS (1.624s)
[109.386939] Starting dynamic subtest: D-eDP1
[111.007509] Dynamic subtest D-eDP1: SUCCESS (1.632s)
[111.009923] Subtest basic-plain-flip: SUCCESS (6.759s)
[112.171178] [005/132] (905s left) kms_tv_load_detect (load-detect)
[112.234079] Subtest load-detect: SKIP (0.000s)
[112.289741] [006/132] (905s left) kms_color (degamma)
[112.382143] Starting subtest: degamma
[112.384089] Starting dynamic subtest: pipe-A-eDP-1
[113.126287] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[113.135677] Starting dynamic subtest: pipe-B-eDP-1
[114.587782] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.461s)
[114.599344] Starting dynamic subtest: pipe-C-eDP-1
[115.975988] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s)
[115.986685] Starting dynamic subtest: pipe-D-eDP-1
[117.399773] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.421s)
[117.402020] Subtest degamma: SUCCESS (5.017s)
[118.201647] [007/132] (899s left) kms_psr (fbc-pr-primary-mmap-cpu)
[118.299578] Starting subtest: fbc-pr-primary-mmap-cpu
[118.304289] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[118.375605] [008/132] (899s left) perf (low-oa-exponent-permissions)
[118.509587] Starting subtest: low-oa-exponent-permissions
[118.549235] Subtest low-oa-exponent-permissions: SUCCESS (0.040s)
[118.595467] [009/132] (898s left) kms_flip (basic-flip-vs-dpms)
[118.696686] Starting subtest: basic-flip-vs-dpms
[118.699303] Starting dynamic subtest: A-eDP1
[121.317390] Dynamic subtest A-eDP1: SUCCESS (2.619s)
[121.331046] Starting dynamic subtest: B-eDP1
[123.573461] Dynamic subtest B-eDP1: SUCCESS (2.255s)
[123.582779] Starting dynamic subtest: C-eDP1
[125.649619] Dynamic subtest C-eDP1: SUCCESS (2.076s)
[125.659582] Starting dynamic subtest: D-eDP1
[127.723438] Dynamic subtest D-eDP1: SUCCESS (2.071s)
[127.725793] Subtest basic-flip-vs-dpms: SUCCESS (9.029s)
[128.522171] [010/132] (888s left) gem_exec_parallel (basic)
[128.581826] Starting subtest: basic
[128.584204] Starting dynamic subtest: rcs0
[129.999592] Dynamic subtest rcs0: SUCCESS (1.417s)
[130.011200] Starting dynamic subtest: bcs0
[131.497050] Dynamic subtest bcs0: SUCCESS (1.496s)
[131.508220] Starting dynamic subtest: vcs0
[133.310451] Dynamic subtest vcs0: SUCCESS (1.811s)
[133.322056] Starting dynamic subtest: vcs1
[135.295564] Dynamic subtest vcs1: SUCCESS (1.984s)
[135.307203] Starting dynamic subtest: vecs0
[137.214928] Dynamic subtest vecs0: SUCCESS (1.918s)
[137.226607] Starting dynamic subtest: ccs0
[138.675163] Dynamic subtest ccs0: SUCCESS (1.460s)
[138.677694] Subtest basic: SUCCESS (10.094s)
[138.869084] [011/132] (878s left) gem_lmem_swapping (random-engines)
[138.918480] Subtest random-engines: SKIP (0.000s)
[138.963741] [012/132] (878s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[139.073543] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[139.075779] Starting dynamic subtest: pipe-A-eDP-1
[139.160652] Dynamic subtest pipe-A-eDP-1: SKIP (0.090s)
[139.169713] Starting dynamic subtest: pipe-B-eDP-1
[140.290013] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[140.294594] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.220s)
[141.470184] [013/132] (876s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[141.562085] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[141.564390] Starting dynamic subtest: pipe-A-eDP-1
[141.622169] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[141.630362] Starting dynamic subtest: pipe-B-eDP-1
[141.686361] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[141.696154] Starting dynamic subtest: pipe-C-eDP-1
[141.753531] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[141.763644] Starting dynamic subtest: pipe-D-eDP-1
[141.818984] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[141.823122] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[143.826399] [014/132] (873s left) gem_userptr_blits (unsync-overlap)
[143.903112] Subtest unsync-overlap: SKIP (0.000s)
[144.027722] [015/132] (873s left) gem_exec_balancer (parallel-bb-first)
[144.281679] Starting subtest: parallel-bb-first
[145.254342] Subtest parallel-bb-first: SUCCESS (0.973s)
[146.339370] [016/132] (871s left) kms_invalid_mode (zero-hdisplay)
[146.438027] Starting subtest: zero-hdisplay
[146.440354] Starting dynamic subtest: pipe-A-eDP-1
[146.723749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[146.734555] Starting dynamic subtest: pipe-B-eDP-1
[146.736475] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[146.745705] Starting dynamic subtest: pipe-C-eDP-1
[146.748486] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[146.758873] Starting dynamic subtest: pipe-D-eDP-1
[146.761272] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[146.763555] Subtest zero-hdisplay: SUCCESS (0.291s)
[147.558864] [017/132] (870s left) i915_query (query-topology-matches-eu-total)
[147.613406] Starting subtest: query-topology-matches-eu-total
[147.615400] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[147.716908] [018/132] (870s left) gem_busy (semaphore)
[147.908907] Subtest semaphore: SKIP (0.000s)
[148.130193] [019/132] (869s left) kms_psr (fbc-pr-sprite-plane-onoff)
[148.224079] Starting subtest: fbc-pr-sprite-plane-onoff
[148.228140] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[148.293657] [020/132] (869s left) gem_ctx_sseu (mmap-args)
[148.344391] Subtest mmap-args: SKIP (0.000s)
[148.411413] [021/132] (869s left) kms_sequence (get-forked)
[148.508749] Starting subtest: get-forked
[148.511106] Starting dynamic subtest: pipe-A-eDP-1
[150.385756] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[150.395958] Starting dynamic subtest: pipe-B-eDP-1
[152.899055] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.512s)
[152.908540] Starting dynamic subtest: pipe-C-eDP-1
[155.405432] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.503s)
[155.414532] Starting dynamic subtest: pipe-D-eDP-1
[157.955650] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s)
[157.958019] Subtest get-forked: SUCCESS (9.448s)
[158.779294] [022/132] (859s left) gem_mmap_gtt (medium-copy-xy)
[158.831630] Subtest medium-copy-XY: SKIP (0.000s)
[158.893414] [023/132] (859s left) syncobj_timeline (etime-multi-wait-submitted)
[158.937837] Starting subtest: etime-multi-wait-submitted
[159.042970] Subtest etime-multi-wait-submitted: SUCCESS (0.103s)
[159.129324] [024/132] (858s left) api_intel_allocator (fork-simple-stress)
[159.190313] Starting subtest: fork-simple-stress
[164.586562] Subtest fork-simple-stress: SUCCESS (5.397s)
[164.717804] [025/132] (853s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[164.825166] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[164.850603] Starting dynamic subtest: pipe-A-plane-0
[165.217119] Dynamic subtest pipe-A-plane-0: SUCCESS (0.367s)
[165.226618] Starting dynamic subtest: pipe-A-plane-3
[165.550207] Dynamic subtest pipe-A-plane-3: SUCCESS (0.332s)
[166.660344] Starting dynamic subtest: pipe-B-plane-0
[167.038861] Dynamic subtest pipe-B-plane-0: SUCCESS (0.389s)
[167.048009] Starting dynamic subtest: pipe-B-plane-3
[167.383240] Dynamic subtest pipe-B-plane-3: SUCCESS (0.343s)
[167.709683] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (2.885s)
[168.539426] [026/132] (849s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[168.620320] Starting subtest: map-fixed-invalidate-overlap-busy
[168.624586] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[168.763375] [027/132] (849s left) perf (mi-rpc)
[168.865064] Starting subtest: mi-rpc
[168.869859] Subtest mi-rpc: SKIP (0.000s)
[168.917397] [028/132] (849s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[169.024508] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[169.028702] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[169.124061] [029/132] (849s left) kms_flip (basic-flip-vs-modeset)
[169.226365] Starting subtest: basic-flip-vs-modeset
[169.228640] Starting dynamic subtest: A-eDP1
[171.830729] Dynamic subtest A-eDP1: SUCCESS (2.604s)
[171.841268] Starting dynamic subtest: B-eDP1
[174.008074] Dynamic subtest B-eDP1: SUCCESS (2.176s)
[174.018063] Starting dynamic subtest: C-eDP1
[176.172745] Dynamic subtest C-eDP1: SUCCESS (2.165s)
[176.181659] Starting dynamic subtest: D-eDP1
[178.340451] Dynamic subtest D-eDP1: SUCCESS (2.167s)
[178.342824] Subtest basic-flip-vs-modeset: SUCCESS (9.119s)
[179.137782] [030/132] (839s left) gem_exec_whisper (basic-contexts-forked-all)
[179.205828] Starting subtest: basic-contexts-forked-all
[200.086058] Subtest basic-contexts-forked-all: SUCCESS (20.876s)
[200.267246] [031/132] (818s left) gem_ctx_persistence (legacy-engines-mixed-process)
[200.343763] Starting subtest: legacy-engines-mixed-process
[200.345876] Starting dynamic subtest: render
[202.290600] Dynamic subtest render: SUCCESS (1.948s)
[202.300294] Starting dynamic subtest: bsd1
[204.294079] Dynamic subtest bsd1: SUCCESS (2.002s)
[204.305246] Starting dynamic subtest: bsd2
[206.293835] Dynamic subtest bsd2: SUCCESS (1.997s)
[206.306344] Starting dynamic subtest: blt
[208.269297] Dynamic subtest blt: SUCCESS (1.973s)
[208.281623] Starting dynamic subtest: vebox
[210.287129] Dynamic subtest vebox: SUCCESS (2.014s)
[210.289471] Subtest legacy-engines-mixed-process: SUCCESS (9.944s)
[210.412881] [032/132] (807s left) kms_psr (psr2-suspend)
[210.512888] Starting subtest: psr2-suspend
[210.515711] Starting dynamic subtest: eDP-1
[228.527663] Dynamic subtest eDP-1: SUCCESS (3.007s)
[228.530612] Subtest psr2-suspend: SUCCESS (3.008s)
[229.398435] [033/132] (789s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[229.508669] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[233.950959] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.503s)
[235.141507] [034/132] (783s left) kms_hdmi_inject (inject-audio)
[235.500072] Starting subtest: inject-audio
[235.778681] Subtest inject-audio: SUCCESS (0.284s)
[236.386930] [035/132] (782s left) kms_psr (pr-suspend)
[236.485810] Starting subtest: pr-suspend
[236.490689] Subtest pr-suspend: SKIP (0.000s)
[236.555218] [036/132] (782s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[236.934525] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[237.727858] [037/132] (780s left) gem_mmap_gtt (basic-write-read)
[237.782266] Subtest basic-write-read: SKIP (0.000s)
[237.840227] [038/132] (780s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[237.942293] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[238.982504] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.046s)
[239.105793] [039/132] (779s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[239.203052] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[244.636764] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.457s)
[245.836116] [040/132] (772s left) gen9_exec_parse (allowed-single)
[245.885587] Subtest allowed-single: SKIP (0.000s)
[245.950395] [041/132] (772s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[246.034585] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[246.037101] Starting dynamic subtest: pipe-A-eDP-1
[246.064222] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[246.077062] Starting dynamic subtest: pipe-B-eDP-1
[246.102453] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[246.112431] Starting dynamic subtest: pipe-C-eDP-1
[246.137472] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.147263] Starting dynamic subtest: pipe-D-eDP-1
[246.172716] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.177774] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[248.307453] [042/132] (770s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[248.399661] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[248.404781] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[249.501819] [043/132] (769s left) kms_psr (psr-primary-mmap-gtt)
[249.599329] Starting subtest: psr-primary-mmap-gtt
[249.601760] Starting dynamic subtest: eDP-1
[251.080082] Dynamic subtest eDP-1: SKIP (1.481s)
[251.085795] Subtest psr-primary-mmap-gtt: SKIP (1.483s)
[251.248182] [044/132] (767s left) gem_exec_fence (basic-await)
[251.421768] Starting subtest: basic-await
[251.424594] Starting dynamic subtest: rcs0
[251.497807] Dynamic subtest rcs0: SUCCESS (0.075s)
[251.510854] Starting dynamic subtest: bcs0
[251.573033] Dynamic subtest bcs0: SUCCESS (0.073s)
[251.585371] Starting dynamic subtest: vcs0
[251.644771] Dynamic subtest vcs0: SUCCESS (0.071s)
[251.659379] Starting dynamic subtest: vcs1
[251.718976] Dynamic subtest vcs1: SUCCESS (0.072s)
[251.732352] Starting dynamic subtest: vecs0
[251.796314] Dynamic subtest vecs0: SUCCESS (0.075s)
[251.808700] Starting dynamic subtest: ccs0
[251.876360] Dynamic subtest ccs0: SUCCESS (0.078s)
[251.879358] Subtest basic-await: SUCCESS (0.456s)
[253.371996] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[253.376094] [045/132] (765s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[253.471877] Starting subtest: y-tiled-64bpp-rotate-90
[253.477235] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[253.556251] [046/132] (765s left) vgem_basic (bad-handle)
[253.594651] Starting subtest: bad-handle
[253.597789] Subtest bad-handle: SUCCESS (0.000s)
[253.662586] [047/132] (765s left) gem_exec_params (rs-invalid)
[253.720919] Starting subtest: rs-invalid
[253.726678] Subtest rs-invalid: SUCCESS (0.003s)
[253.844934] [048/132] (765s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[254.141634] Starting subtest: cursor-rapid-movement-512x170
[254.147452] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[254.299947] [049/132] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[254.389965] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[254.393276] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[254.494354] [050/132] (764s left) i915_hangman (engine-engine-hang)
[254.550208] Starting subtest: engine-engine-hang
[254.552546] Starting dynamic subtest: rcs0
[256.254771] Dynamic subtest rcs0: SUCCESS (1.705s)
[256.268288] Starting dynamic subtest: bcs0
[258.235710] Dynamic subtest bcs0: SUCCESS (1.980s)
[258.249797] Starting dynamic subtest: vcs0
[260.282703] Dynamic subtest vcs0: SUCCESS (2.044s)
[260.296615] Starting dynamic subtest: vcs1
[262.269678] Dynamic subtest vcs1: SUCCESS (1.983s)
[262.283034] Starting dynamic subtest: vecs0
[264.251009] Dynamic subtest vecs0: SUCCESS (1.978s)
[264.263788] Starting dynamic subtest: ccs0
[266.299227] Dynamic subtest ccs0: SUCCESS (2.045s)
[266.302335] Subtest engine-engine-hang: SUCCESS (11.751s)
[266.425657] [051/132] (752s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[266.526261] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[273.190788] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.669s)
[273.309046] [052/132] (745s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[273.365563] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[273.444122] [053/132] (745s left) gem_lmem_swapping (heavy-verify-random)
[273.483241] Subtest heavy-verify-random: SKIP (0.000s)
[273.529006] [054/132] (745s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[273.620723] Starting subtest: fb-8bpc-vs-panel-8bpc
[273.623482] Starting dynamic subtest: pipe-A-eDP-1
[275.035345] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.415s)
[275.038099] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.417s)
[275.902123] [055/132] (743s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[275.993785] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[276.006318] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[276.099061] [056/132] (743s left) syncobj_timeline (single-wait-signaled)
[276.151399] Starting subtest: single-wait-signaled
[276.153816] Subtest single-wait-signaled: SUCCESS (0.000s)
[276.274056] [057/132] (743s left) gem_sync (basic-store-each)
[276.356811] Starting subtest: basic-store-each
[278.853000] Subtest basic-store-each: SUCCESS (2.512s)
[279.044549] [058/132] (740s left) kms_addfb_basic (master-rmfb)
[279.095692] Starting subtest: master-rmfb
[279.098491] Subtest master-rmfb: SUCCESS (0.001s)
[279.235403] [059/132] (740s left) gem_mmap_offset (oob-read)
[279.291589] Starting subtest: oob-read
[279.294156] Subtest oob-read: SUCCESS (0.000s)
[279.403226] [060/132] (740s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[279.499442] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[279.501931] Starting dynamic subtest: pipe-A-default-mode
[282.194774] Dynamic subtest pipe-A-default-mode: SUCCESS (2.696s)
[282.197758] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.698s)
[282.996398] [061/132] (736s left) gem_create (create-ext-cpu-access-sanity-check)
[283.154751] Starting subtest: create-ext-cpu-access-sanity-check
[283.160313] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[283.232951] [062/132] (736s left) kms_addfb_basic (unused-pitches)
[283.286192] Starting subtest: unused-pitches
[283.288197] Subtest unused-pitches: SUCCESS (0.000s)
[283.422949] [063/132] (736s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[283.511180] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[283.513722] Starting dynamic subtest: pipe-A
[283.533892] Dynamic subtest pipe-A: SKIP (0.019s)
[283.546491] Starting dynamic subtest: pipe-B
[283.570456] Dynamic subtest pipe-B: SKIP (0.033s)
[283.581365] Starting dynamic subtest: pipe-C
[283.602660] Dynamic subtest pipe-C: SKIP (0.033s)
[283.614627] Starting dynamic subtest: pipe-D
[283.642550] Dynamic subtest pipe-D: SKIP (0.038s)
[283.647584] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.126s)
[283.724313] [064/132] (736s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[283.822480] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[284.856515] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.035s)
[284.972262] [065/132] (734s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[285.066529] Starting subtest: sprite-rotation-90-pos-100-0
[285.071633] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[285.144425] [066/132] (734s left) i915_drm_fdinfo (virtual-busy-hang)
[285.181559] Starting subtest: virtual-busy-hang
[285.186938] Subtest virtual-busy-hang: SKIP (0.000s)
[285.251257] [067/132] (734s left) gem_spin_batch (spin-all)
[285.303306] Starting subtest: spin-all
[285.311470] Subtest spin-all: SUCCESS (0.012s)
[287.364477] [068/132] (732s left) kms_draw_crc (draw-method-render)
[287.455777] Starting subtest: draw-method-render
[287.458490] Starting dynamic subtest: xrgb8888-untiled
[287.723313] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[287.734818] Starting dynamic subtest: rgb565-untiled
[287.966077] Dynamic subtest rgb565-untiled: SUCCESS (0.244s)
[287.981820] Starting dynamic subtest: xrgb2101010-untiled
[288.199767] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[288.210203] Starting dynamic subtest: xbgr16161616f-untiled
[288.443284] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[288.454270] Starting dynamic subtest: xrgb8888-xtiled
[288.576172] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[288.586831] Starting dynamic subtest: rgb565-xtiled
[288.698403] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[288.709242] Starting dynamic subtest: xrgb2101010-xtiled
[288.820148] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[288.831149] Starting dynamic subtest: xbgr16161616f-xtiled
[288.953352] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[288.968377] Starting dynamic subtest: xrgb8888-4tiled
[289.086616] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[289.097680] Starting dynamic subtest: rgb565-4tiled
[289.209219] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[289.225048] Starting dynamic subtest: xrgb2101010-4tiled
[289.331356] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[289.344566] Starting dynamic subtest: xbgr16161616f-4tiled
[289.463976] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[289.466014] Subtest draw-method-render: SUCCESS (2.012s)
[289.582195] [069/132] (730s left) i915_pm_rpm (sysfs-read)
[291.428349] Starting subtest: sysfs-read
[292.596946] Subtest sysfs-read: SUCCESS (1.170s)
[292.974285] [070/132] (727s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[293.073795] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[293.079164] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[293.167843] [071/132] (726s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[293.264994] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[293.269721] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[293.336042] [072/132] (726s left) drm_read (short-buffer-nonblock)
[293.471592] Starting subtest: short-buffer-nonblock
[293.474624] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[293.601969] [073/132] (726s left) kms_addfb_basic (bad-pitch-999)
[293.649799] Starting subtest: bad-pitch-999
[293.652430] Subtest bad-pitch-999: SUCCESS (0.000s)
[293.785857] [074/132] (726s left) gem_bad_reloc (negative-reloc-bltcopy)
[293.846562] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[293.932154] [075/132] (726s left) gem_exec_schedule (timeslicing)
[294.004428] Starting subtest: timeslicing
[294.006679] Starting dynamic subtest: rcs0
[294.015956] Dynamic subtest rcs0: SUCCESS (0.021s)
[294.028483] Starting dynamic subtest: bcs0
[294.037952] Dynamic subtest bcs0: SUCCESS (0.022s)
[294.048621] Starting dynamic subtest: vcs0
[294.061522] Dynamic subtest vcs0: SUCCESS (0.023s)
[294.072411] Starting dynamic subtest: vcs1
[294.083530] Dynamic subtest vcs1: SUCCESS (0.022s)
[294.095415] Starting dynamic subtest: vecs0
[294.105549] Dynamic subtest vecs0: SUCCESS (0.021s)
[294.117145] Starting dynamic subtest: ccs0
[294.126852] Dynamic subtest ccs0: SUCCESS (0.020s)
[294.129772] Subtest timeslicing: SUCCESS (0.132s)
[295.365437] [076/132] (724s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[295.426053] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[295.428763] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[295.533503] [077/132] (724s left) perf_pmu (init-busy)
[295.575050] Starting subtest: init-busy
[295.578053] Starting dynamic subtest: rcs0
[295.580566] Dynamic subtest rcs0: SUCCESS (0.001s)
[295.592439] Starting dynamic subtest: bcs0
[295.595251] Dynamic subtest bcs0: SUCCESS (0.001s)
[295.605612] Starting dynamic subtest: vcs0
[295.608332] Dynamic subtest vcs0: SUCCESS (0.001s)
[295.620625] Starting dynamic subtest: vcs1
[295.623499] Dynamic subtest vcs1: SUCCESS (0.001s)
[295.634989] Starting dynamic subtest: vecs0
[295.637833] Dynamic subtest vecs0: SUCCESS (0.001s)
[295.648609] Starting dynamic subtest: ccs0
[295.650832] Dynamic subtest ccs0: SUCCESS (0.001s)
[295.653251] Subtest init-busy: SUCCESS (0.009s)
[295.699661] [078/132] (724s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[295.816581] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[295.821819] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[295.928942] [079/132] (724s left) perf_pmu (busy-accuracy-2)
[295.973291] Starting subtest: busy-accuracy-2
[295.975491] Starting dynamic subtest: rcs0
[299.015267] Dynamic subtest rcs0: SUCCESS (3.041s)
[299.028879] Starting dynamic subtest: bcs0
[302.071792] Dynamic subtest bcs0: SUCCESS (3.055s)
[302.084576] Starting dynamic subtest: vcs0
[305.117412] Dynamic subtest vcs0: SUCCESS (3.044s)
[305.129846] Starting dynamic subtest: vcs1
[308.161263] Dynamic subtest vcs1: SUCCESS (3.044s)
[308.173099] Starting dynamic subtest: vecs0
[311.212359] Dynamic subtest vecs0: SUCCESS (3.050s)
[311.224360] Starting dynamic subtest: ccs0
[314.269414] Dynamic subtest ccs0: SUCCESS (3.056s)
[314.271954] Subtest busy-accuracy-2: SUCCESS (18.302s)
[314.386630] [080/132] (706s left) kms_flip (flip-vs-panning)
[314.486458] Starting subtest: flip-vs-panning
[314.489116] Starting dynamic subtest: A-eDP1
[323.176882] Dynamic subtest A-eDP1: SUCCESS (8.693s)
[323.190385] Starting dynamic subtest: B-eDP1
[331.861487] Dynamic subtest B-eDP1: SUCCESS (8.679s)
[331.872495] Starting dynamic subtest: C-eDP1
[340.554428] Dynamic subtest C-eDP1: SUCCESS (8.689s)
[340.565596] Starting dynamic subtest: D-eDP1
[349.248388] Dynamic subtest D-eDP1: SUCCESS (8.691s)
[349.250703] Subtest flip-vs-panning: SUCCESS (34.761s)
[350.491653] [081/132] (670s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[350.599288] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[351.712446] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.113s)
[351.859063] [082/132] (668s left) kms_addfb_basic (clobberred-modifier)
[351.916513] Starting subtest: clobberred-modifier
[351.920824] Subtest clobberred-modifier: SKIP (0.000s)
[352.051540] [083/132] (668s left) i915_query (query-regions-unallocated)
[352.101494] Starting subtest: query-regions-unallocated
[352.104024] Subtest query-regions-unallocated: SUCCESS (0.000s)
[352.207911] [084/132] (668s left) gem_pxp (reject-modify-context-protection-off-3)
[352.325446] Starting subtest: reject-modify-context-protection-off-3
[352.328243] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[352.456719] [085/132] (668s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[352.548551] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[352.550582] Starting dynamic subtest: pipe-A-eDP-1
[352.570944] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[352.582581] Starting dynamic subtest: pipe-B-eDP-1
[352.602769] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[352.613775] Starting dynamic subtest: pipe-C-eDP-1
[352.635454] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[352.645905] Starting dynamic subtest: pipe-D-eDP-1
[352.668784] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[352.672833] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[354.814096] [086/132] (666s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[354.916563] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[362.364656] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.452s)
[362.492936] [087/132] (658s left) gem_mmap_gtt (basic-read-write)
[362.556637] Subtest basic-read-write: SKIP (0.000s)
[362.622675] [088/132] (658s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[362.709791] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[362.715369] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[362.785594] [089/132] (658s left) gem_userptr_blits (stress-purge)
[362.849112] Starting subtest: stress-purge
[368.262252] Subtest stress-purge: SUCCESS (5.415s)
[368.402978] [090/132] (652s left) kms_cursor_edge_walk (256x256-left-edge)
[368.548794] Starting subtest: 256x256-left-edge
[368.551188] Starting dynamic subtest: pipe-A-eDP-1
[372.020635] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s)
[372.035809] Starting dynamic subtest: pipe-D-eDP-1
[375.218427] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.197s)
[375.220512] Subtest 256x256-left-edge: SUCCESS (6.670s)
[376.088773] [091/132] (644s left) kms_busy (extended-pageflip-hang-newfb)
[376.199611] Starting subtest: extended-pageflip-hang-newfb
[376.201847] Starting dynamic subtest: pipe-A
[402.090407] Dynamic subtest pipe-A: SUCCESS (25.896s)
[402.103950] Starting dynamic subtest: pipe-D
[417.066298] Dynamic subtest pipe-D: SUCCESS (14.977s)
[417.069086] Subtest extended-pageflip-hang-newfb: SUCCESS (40.878s)
[417.875399] [092/132] (603s left) gem_fence_thrash (bo-write-verify-y)
[417.912950] Starting subtest: bo-write-verify-y
[417.927586] Subtest bo-write-verify-y: SKIP (0.013s)
[417.993505] [093/132] (603s left) syncobj_basic (create-signaled)
[418.046221] Starting subtest: create-signaled
[418.048619] Subtest create-signaled: SUCCESS (0.000s)
[418.148095] [094/132] (603s left) kms_chamelium_color (ctm-negative)
[418.247604] Subtest ctm-negative: SKIP (0.000s)
[418.296459] [095/132] (602s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[418.402914] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[418.407572] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[418.492683] [096/132] (602s left) kms_content_protection (dp-mst-lic-type-0)
[418.637946] Starting subtest: dp-mst-lic-type-0
[418.643667] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[418.753941] [097/132] (602s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[418.860449] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[418.862577] Starting dynamic subtest: pipe-A
[420.120438] Dynamic subtest pipe-A: SUCCESS (1.263s)
[420.134701] Starting dynamic subtest: pipe-B
[422.404938] Dynamic subtest pipe-B: SUCCESS (2.284s)
[422.417011] Starting dynamic subtest: pipe-C
[423.606256] Dynamic subtest pipe-C: SUCCESS (1.199s)
[423.617945] Starting dynamic subtest: pipe-D
[424.793636] Dynamic subtest pipe-D: SUCCESS (1.187s)
[424.796588] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.938s)
[425.972911] [098/132] (595s left) gem_exec_create (forked)
[426.037798] Starting subtest: forked
[426.040611] Starting dynamic subtest: smem
[447.260955] Dynamic subtest smem: SUCCESS (21.230s)
[447.263803] Subtest forked: SUCCESS (21.232s)
[447.447094] [099/132] (573s left) gem_ctx_persistence (engines-persistence)
[447.505161] Starting subtest: engines-persistence
[447.507684] Starting dynamic subtest: rcs0
[448.282914] Dynamic subtest rcs0: SUCCESS (0.778s)
[448.297591] Starting dynamic subtest: bcs0
[449.027006] Dynamic subtest bcs0: SUCCESS (0.742s)
[449.040616] Starting dynamic subtest: vcs0
[449.796969] Dynamic subtest vcs0: SUCCESS (0.768s)
[449.810807] Starting dynamic subtest: vcs1
[450.579991] Dynamic subtest vcs1: SUCCESS (0.781s)
[450.594778] Starting dynamic subtest: vecs0
[451.353141] Dynamic subtest vecs0: SUCCESS (0.771s)
[451.368801] Starting dynamic subtest: ccs0
[452.118144] Dynamic subtest ccs0: SUCCESS (0.762s)
[452.121070] Subtest engines-persistence: SUCCESS (4.615s)
[452.203666] [100/132] (569s left) gem_render_tiled_blits (basic)
[452.273223] Subtest basic: SKIP (0.000s)
[452.353305] [101/132] (569s left) gem_exec_schedule (preempt-other-chain)
[452.429638] Starting subtest: preempt-other-chain
[452.432368] Starting dynamic subtest: rcs0
[452.576789] Dynamic subtest rcs0: SUCCESS (0.155s)
[452.592634] Starting dynamic subtest: bcs0
[452.712285] Dynamic subtest bcs0: SUCCESS (0.134s)
[452.730420] Starting dynamic subtest: vcs0
[452.846142] Dynamic subtest vcs0: SUCCESS (0.134s)
[452.860379] Starting dynamic subtest: vcs1
[452.986045] Dynamic subtest vcs1: SUCCESS (0.139s)
[453.000609] Starting dynamic subtest: vecs0
[453.123219] Dynamic subtest vecs0: SUCCESS (0.136s)
[453.137198] Starting dynamic subtest: ccs0
[453.262157] Dynamic subtest ccs0: SUCCESS (0.138s)
[453.264673] Subtest preempt-other-chain: SUCCESS (0.841s)
[454.381507] [102/132] (567s left) core_getstats (basic)
[454.432547] Starting subtest: basic
[454.434772] Subtest basic: SUCCESS (0.000s)
[454.529421] [103/132] (567s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[454.628537] Starting subtest: psr-rgb101010-draw-mmap-cpu
[461.955617] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.328s)
[462.073293] [104/132] (559s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[462.188119] Starting subtest: x-tiled-64bpp-rotate-180
[463.879455] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.691s)
[464.038462] [105/132] (557s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[464.140454] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[470.950402] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.811s)
[471.064895] [106/132] (550s left) kms_psr (fbc-psr-sprite-plane-move)
[471.166218] Starting subtest: fbc-psr-sprite-plane-move
[471.168523] Starting dynamic subtest: eDP-1
[471.172761] Dynamic subtest eDP-1: SKIP (0.000s)
[471.176895] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[471.241878] [107/132] (550s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[471.337514] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[478.151054] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.816s)
[478.318462] [108/132] (543s left) kms_lease (cursor-implicit-plane)
[478.410821] Starting subtest: cursor-implicit-plane
[478.413468] Starting dynamic subtest: pipe-A-eDP-1
[478.860383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.450s)
[478.873621] Starting dynamic subtest: pipe-B-eDP-1
[479.952596] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.091s)
[479.964710] Starting dynamic subtest: pipe-C-eDP-1
[481.040007] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.084s)
[481.053225] Starting dynamic subtest: pipe-D-eDP-1
[482.133673] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.095s)
[482.136449] Subtest cursor-implicit-plane: SUCCESS (3.724s)
[482.962882] [109/132] (538s left) kms_pm_backlight (brightness-with-dpms)
[483.069644] Starting subtest: brightness-with-dpms
[483.116490] Starting dynamic subtest: eDP-1
[485.534608] Dynamic subtest eDP-1: SUCCESS (2.416s)
[485.537561] Subtest brightness-with-dpms: SUCCESS (2.466s)
[486.370211] [110/132] (535s left) gem_exec_parallel (contexts)
[486.427399] Starting subtest: contexts
[486.430037] Starting dynamic subtest: rcs0
[489.434278] Dynamic subtest rcs0: SUCCESS (3.004s)
[489.449185] Starting dynamic subtest: bcs0
[493.575262] Dynamic subtest bcs0: SUCCESS (4.139s)
[493.588081] Starting dynamic subtest: vcs0
[497.775559] Dynamic subtest vcs0: SUCCESS (4.196s)
[497.788076] Starting dynamic subtest: vcs1
[503.609551] Dynamic subtest vcs1: SUCCESS (5.831s)
[503.622813] Starting dynamic subtest: vecs0
[507.876798] Dynamic subtest vecs0: SUCCESS (4.265s)
[507.889067] Starting dynamic subtest: ccs0
[512.340124] Dynamic subtest ccs0: SUCCESS (4.460s)
[512.343458] Subtest contexts: SUCCESS (25.910s)
[512.535004] [111/132] (509s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[512.643578] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[512.648259] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[512.743090] [112/132] (509s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[512.848760] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[512.853787] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[512.953375] [113/132] (509s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[513.008764] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[513.014300] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[513.199201] [114/132] (508s left) kms_pipe_crc_basic (suspend-read-crc)
[513.290504] Starting subtest: suspend-read-crc
[513.292634] Starting dynamic subtest: pipe-A-eDP-1
[533.300475] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.849s)
[533.314378] Starting dynamic subtest: pipe-B-eDP-1
[552.015548] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.184s)
[552.029082] Starting dynamic subtest: pipe-C-eDP-1
[569.980723] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.065s)
[569.994741] Starting dynamic subtest: pipe-D-eDP-1
[587.967858] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.085s)
[587.970152] Subtest suspend-read-crc: SUCCESS (14.190s)
[588.804136] [115/132] (433s left) prime_self_import (export-vs-gem_close-race)
[588.845931] Starting subtest: export-vs-gem_close-race
[593.931842] Subtest export-vs-gem_close-race: SUCCESS (5.143s)
[594.013685] [116/132] (428s left) syncobj_timeline (invalid-query-zero-handles)
[594.070377] Starting subtest: invalid-query-zero-handles
[594.072607] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[594.198972] [117/132] (428s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[594.301546] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[594.305775] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[594.377153] [118/132] (427s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[594.423862] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[594.528884] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[594.624368] [119/132] (427s left) gem_exec_fence (parallel)
[594.810195] Starting subtest: parallel
[594.812720] Starting dynamic subtest: rcs0
[596.944009] Dynamic subtest rcs0: SUCCESS (2.148s)
[596.957547] Starting dynamic subtest: bcs0
[599.085131] Dynamic subtest bcs0: SUCCESS (2.151s)
[599.099703] Starting dynamic subtest: vcs0
[601.229582] Dynamic subtest vcs0: SUCCESS (2.152s)
[601.242987] Starting dynamic subtest: vcs1
[603.378784] Dynamic subtest vcs1: SUCCESS (2.155s)
[603.392839] Starting dynamic subtest: vecs0
[605.528864] Dynamic subtest vecs0: SUCCESS (2.154s)
[605.542343] Starting dynamic subtest: ccs0
[607.677335] Dynamic subtest ccs0: SUCCESS (2.152s)
[607.679407] Subtest parallel: SUCCESS (12.916s)
[608.915935] [120/132] (413s left) kms_async_flips (test-cursor-atomic)
[609.016852] Starting subtest: test-cursor-atomic
[609.387744] Starting dynamic subtest: pipe-A-eDP-1
[610.134160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.748s)
[610.514219] Starting dynamic subtest: pipe-B-eDP-1
[611.329777] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.827s)
[611.713366] Starting dynamic subtest: pipe-C-eDP-1
[612.534808] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.836s)
[612.917023] Starting dynamic subtest: pipe-D-eDP-1
[613.733171] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.829s)
[613.735814] Subtest test-cursor-atomic: SUCCESS (4.725s)
[614.899432] [121/132] (407s left) kms_chamelium_edid (dp-edid-read)
[615.275974] Subtest dp-edid-read: SKIP (0.000s)
[616.054598] [122/132] (406s left) syncobj_timeline (multi-wait-for-submit-signaled)
[616.113494] Starting subtest: multi-wait-for-submit-signaled
[616.115891] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[616.207377] [123/132] (406s left) core_getversion (basic)
[616.251017] Starting subtest: basic
[616.255654] Subtest basic: SUCCESS (0.000s)
[616.319374] [124/132] (406s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[616.426497] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[616.430840] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[616.533564] [125/132] (406s left) gem_pxp (create-protected-buffer)
[616.646286] Starting subtest: create-protected-buffer
[616.648616] Subtest create-protected-buffer: SUCCESS (0.000s)
[616.766924] [126/132] (405s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[616.872045] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[616.876236] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[616.984877] [127/132] (405s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[617.081047] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[617.084689] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[617.185438] [128/132] (405s left) sriov_basic (enable-vfs-autoprobe-off)
[617.241886] Starting subtest: enable-vfs-autoprobe-off
[617.244266] Starting dynamic subtest: numvfs-1
[617.314374] Dynamic subtest numvfs-1: FAIL (0.027s)
[617.328300] Starting dynamic subtest: numvfs-2
[617.387771] Dynamic subtest numvfs-2: FAIL (0.004s)
[617.402446] Starting dynamic subtest: numvfs-3
[617.462104] Dynamic subtest numvfs-3: FAIL (0.004s)
[617.474606] Starting dynamic subtest: numvfs-4
[617.533906] Dynamic subtest numvfs-4: FAIL (0.004s)
[617.546219] Starting dynamic subtest: numvfs-5
[617.607789] Dynamic subtest numvfs-5: FAIL (0.004s)
[617.620768] Starting dynamic subtest: numvfs-6
[617.681297] Dynamic subtest numvfs-6: FAIL (0.004s)
[617.694976] Starting dynamic subtest: numvfs-7
[617.754547] Dynamic subtest numvfs-7: FAIL (0.004s)
[617.766705] Starting dynamic subtest: numvfs-random
[617.826009] Dynamic subtest numvfs-random: FAIL (0.004s)
[617.838613] Starting dynamic subtest: numvfs-all
[617.898471] Dynamic subtest numvfs-all: FAIL (0.004s)
[617.900438] Subtest enable-vfs-autoprobe-off: FAIL (0.064s)
[617.942527] [129/132] (404s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[618.036832] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[621.566273] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.530s)
[622.802590] [130/132] (400s left) gem_exec_reloc (basic-wc-cpu)
[622.866267] Subtest basic-wc-cpu: SKIP (0.000s)
[622.954625] [131/132] (399s left) kms_cursor_crc (cursor-random-128x128)
[623.170097] Starting subtest: cursor-random-128x128
[623.172729] Starting dynamic subtest: pipe-A-eDP-1
[626.517233] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.346s)
[626.552143] Starting dynamic subtest: pipe-D-eDP-1
[630.572265] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.029s)
[630.574171] Subtest cursor-random-128x128: SUCCESS (7.402s)
[631.374510] [132/132] (391s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[631.472986] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[638.159137] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.691s)
[638.283384] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_tv_load_detect
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: gem_exec_parallel
results: parsing output: 10/ for test: gem_lmem_swapping
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_userptr_blits
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_invalid_mode
results: parsing output: 16/ for test: i915_query
results: parsing output: 17/ for test: gem_busy
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gem_ctx_sseu
results: parsing output: 20/ for test: kms_sequence
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: api_intel_allocator
results: parsing output: 24/ for test: kms_plane
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: gem_exec_whisper
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_hdmi_inject
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gen9_exec_parse
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: vgem_basic
results: parsing output: 46/ for test: gem_exec_params
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: i915_hangman
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: gem_lmem_swapping
results: parsing output: 53/ for test: kms_dither
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_sync
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: gem_mmap_offset
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: gem_create
results: parsing output: 61/ for test: kms_addfb_basic
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: gem_spin_batch
results: parsing output: 67/ for test: kms_draw_crc
results: parsing output: 68/ for test: i915_pm_rpm
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: drm_read
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: gem_bad_reloc
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: i915_query
results: parsing output: 83/ for test: gem_pxp
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: kms_cursor_edge_walk
results: parsing output: 90/ for test: kms_busy
results: parsing output: 91/ for test: gem_fence_thrash
results: parsing output: 92/ for test: syncobj_basic
results: parsing output: 93/ for test: kms_chamelium_color
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: kms_plane_scaling
results: parsing output: 97/ for test: gem_exec_create
results: parsing output: 98/ for test: gem_ctx_persistence
results: parsing output: 99/ for test: gem_render_tiled_blits
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: core_getstats
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_lease
results: parsing output: 108/ for test: kms_pm_backlight
results: parsing output: 109/ for test: gem_exec_parallel
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_pipe_crc_basic
results: parsing output: 114/ for test: prime_self_import
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: gem_exec_fence
results: parsing output: 119/ for test: kms_async_flips
results: parsing output: 120/ for test: kms_chamelium_edid
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: core_getversion
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_pxp
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: sriov_basic
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.