[61.350594] Initializing watchdogs
[61.350642]   /dev/watchdog0
[61.365378] [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]
[61.370320] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.372595] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.375060] [001/132] (960s left) gem_pread (bench)
[61.432952] Subtest bench: SKIP (0.000s)
[61.492708] [002/132] (960s left) kms_vblank (wait-busy-hang)
[61.590977] Starting subtest: wait-busy-hang
[61.592073] Starting dynamic subtest: pipe-A-eDP-1
[87.713210] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.122s)
[87.722127] Starting dynamic subtest: pipe-D-eDP-1
[102.748338] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.027s)
[102.749209] Subtest wait-busy-hang: SUCCESS (41.153s)
[103.590275] [003/132] (918s left) gem_softpin (noreloc)
[103.649626] Starting subtest: noreloc
[109.120642] Subtest noreloc: SUCCESS (5.425s)
[109.210638] [004/132] (912s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[109.309678] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[109.311413] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[109.400526] [005/132] (912s left) kms_feature_discovery (display-2x)
[109.485576] Starting subtest: display-2x
[109.487594] Subtest display-2x: SKIP (0.000s)
[109.547293] [006/132] (912s left) kms_addfb_basic (legacy-format)
[109.595029] Starting subtest: legacy-format
[109.617219] Subtest legacy-format: SUCCESS (0.020s)
[109.761401] [007/132] (912s left) kms_cursor_crc (cursor-offscreen-32x10)
[109.931529] Starting subtest: cursor-offscreen-32x10
[109.976899] Subtest cursor-offscreen-32x10: SKIP (0.044s)
[110.246075] [008/132] (911s left) gem_reg_read (timestamp-monotonic)
[110.298911] Starting subtest: timestamp-monotonic
[115.262802] Subtest timestamp-monotonic: SUCCESS (4.919s)
[115.291852] [009/132] (906s left) syncobj_wait (invalid-reset-bad-pad)
[115.347268] Starting subtest: invalid-reset-bad-pad
[115.348073] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[115.453840] [010/132] (906s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[115.557420] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[120.091815] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.534s)
[121.287380] [011/132] (900s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[121.377815] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[130.301714] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.925s)
[130.399553] [012/132] (891s left) gem_mmap_gtt (basic-small-copy-xy)
[130.446532] Subtest basic-small-copy-XY: SKIP (0.000s)
[130.492963] [013/132] (891s left) kms_atomic_transition (plane-all-transition-nonblocking)
[130.575389] Starting subtest: plane-all-transition-nonblocking
[130.576330] Starting dynamic subtest: pipe-A-eDP-1
[133.074259] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[133.378809] Starting dynamic subtest: pipe-B-eDP-1
[136.644478] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.271s)
[136.941731] Subtest plane-all-transition-nonblocking: SUCCESS (6.366s)
[137.776965] [014/132] (884s left) gem_userptr_blits (dmabuf-sync)
[137.858478] Starting subtest: dmabuf-sync
[137.861340] Subtest dmabuf-sync: SKIP (0.002s)
[137.985345] [015/132] (884s left) gem_mmap_gtt (ptrace)
[138.048876] Subtest ptrace: SKIP (0.000s)
[138.096080] [016/132] (884s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[138.134061] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[138.240303] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[138.308254] [017/132] (884s left) gem_exec_params (rs-invalid)
[138.358705] Starting subtest: rs-invalid
[138.362881] Subtest rs-invalid: SUCCESS (0.004s)
[138.477341] [018/132] (883s left) syncobj_timeline (multi-wait-all-signaled)
[138.526316] Starting subtest: multi-wait-all-signaled
[138.527204] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[138.614875] [019/132] (883s left) gem_render_copy (yf-tiled)
[138.663744] Starting subtest: yf-tiled
[138.666059] Subtest yf-tiled: SKIP (0.000s)
[138.838672] [020/132] (883s left) gem_busy (parallel)
[139.031675] Starting subtest: parallel
[139.032688] Starting dynamic subtest: rcs0
[140.895929] Dynamic subtest rcs0: SUCCESS (1.860s)
[140.904556] Starting dynamic subtest: bcs0
[142.942460] Dynamic subtest bcs0: SUCCESS (2.044s)
[142.949642] Starting dynamic subtest: vcs0
[144.926218] Dynamic subtest vcs0: SUCCESS (1.981s)
[144.935379] Starting dynamic subtest: vcs1
[146.911743] Dynamic subtest vcs1: SUCCESS (1.982s)
[146.920786] Starting dynamic subtest: vecs0
[148.895617] Dynamic subtest vecs0: SUCCESS (1.982s)
[148.905272] Starting dynamic subtest: ccs0
[150.942025] Dynamic subtest ccs0: SUCCESS (2.044s)
[150.943203] Subtest parallel: SUCCESS (11.907s)
[151.162646] [021/132] (871s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[151.261437] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[151.908733] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[152.052388] [022/132] (870s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[152.135085] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[152.147072] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[152.219188] [023/132] (870s left) kms_psr (fbc-psr2-cursor-plane-move)
[152.299347] Starting subtest: fbc-psr2-cursor-plane-move
[152.300141] Starting dynamic subtest: eDP-1
[152.301963] Dynamic subtest eDP-1: SKIP (0.000s)
[152.303857] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[152.368879] [024/132] (870s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[152.450584] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[152.451492] Starting dynamic subtest: pipe-A-default-mode
[155.239315] Dynamic subtest pipe-A-default-mode: SUCCESS (2.785s)
[155.240244] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.786s)
[156.095292] [025/132] (866s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[156.154747] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[156.210530] [026/132] (866s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[156.316851] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[156.318687] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[156.411290] [027/132] (866s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[156.505397] Starting subtest: 4-tiled-32bpp-rotate-90
[156.525121] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[156.648502] [028/132] (866s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[156.736360] Starting subtest: psr2-overlay-plane-move-continuous-sf
[156.737261] Starting dynamic subtest: pipe-A-eDP-1
[162.724883] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.987s)
[162.732509] Starting dynamic subtest: pipe-B-eDP-1
[169.382799] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.656s)
[169.383720] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.646s)
[170.246485] [029/132] (852s left) gen9_exec_parse (unaligned-jump)
[170.296709] Subtest unaligned-jump: SKIP (0.000s)
[170.348672] [030/132] (852s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[170.439369] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[170.440252] Starting dynamic subtest: pipe-A-eDP-1
[170.448332] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[170.455401] Starting dynamic subtest: pipe-B-eDP-1
[170.464091] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[170.470342] Starting dynamic subtest: pipe-C-eDP-1
[170.478374] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[170.484250] Starting dynamic subtest: pipe-D-eDP-1
[170.492996] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[170.494864] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[172.705221] [031/132] (850s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[172.764707] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[172.826692] [032/132] (850s left) kms_atomic_interruptible (legacy-dpms)
[172.917450] Starting subtest: legacy-dpms
[172.918263] Starting dynamic subtest: pipe-A-eDP-1
[180.356188] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.437s)
[180.356925] Subtest legacy-dpms: SUCCESS (7.438s)
[181.164380] [033/132] (841s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[181.249647] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[181.250737] Starting dynamic subtest: pipe-A-eDP-1
[182.174130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.923s)
[182.180411] Starting dynamic subtest: pipe-B-eDP-1
[183.809154] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.633s)
[183.820463] Starting dynamic subtest: pipe-C-eDP-1
[185.316184] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.505s)
[185.325060] Starting dynamic subtest: pipe-D-eDP-1
[186.869383] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.553s)
[186.870136] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.619s)
[188.012097] [034/132] (834s left) perf_pmu (busy-idle-no-semaphores)
[188.056191] Starting subtest: busy-idle-no-semaphores
[188.057039] Starting dynamic subtest: rcs0
[188.714381] Dynamic subtest rcs0: SUCCESS (0.648s)
[188.723624] Starting dynamic subtest: bcs0
[189.367031] Dynamic subtest bcs0: SUCCESS (0.650s)
[189.377882] Starting dynamic subtest: vcs0
[190.019379] Dynamic subtest vcs0: SUCCESS (0.650s)
[190.030373] Starting dynamic subtest: vcs1
[191.558775] Dynamic subtest vcs1: SUCCESS (1.537s)
[191.568079] Starting dynamic subtest: vecs0
[193.540854] Dynamic subtest vecs0: SUCCESS (1.981s)
[193.550131] Starting dynamic subtest: ccs0
[195.525804] Dynamic subtest ccs0: SUCCESS (1.982s)
[195.526974] Subtest busy-idle-no-semaphores: SUCCESS (7.463s)
[195.628621] [035/132] (827s left) kms_chamelium_color (ctm-negative)
[195.720939] Subtest ctm-negative: SKIP (0.000s)
[195.758617] [036/132] (827s left) syncobj_wait (wait-any-snapshot)
[195.811504] Starting subtest: wait-any-snapshot
[195.893438] Subtest wait-any-snapshot: SUCCESS (0.081s)
[195.967662] [037/132] (827s left) api_intel_allocator (alloc-simple)
[196.023121] Starting subtest: alloc-simple
[196.024375] Subtest alloc-simple: SUCCESS (0.003s)
[196.140108] [038/132] (826s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[196.188146] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[196.189022] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[196.275761] [039/132] (826s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[196.362211] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[196.363817] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[196.448422] [040/132] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[196.541361] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[196.543027] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[196.634824] [041/132] (826s left) sw_sync (sync_random_merge)
[196.667250] Starting subtest: sync_random_merge
[196.716901] Subtest sync_random_merge: SUCCESS (0.050s)
[196.773141] [042/132] (826s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[196.885487] Starting subtest: 2x-long-flip-vs-cursor-atomic
[196.888489] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[197.022110] [043/132] (826s left) gem_ctx_shared (q-smoketest)
[197.077212] Starting subtest: Q-smoketest
[197.078411] Starting dynamic subtest: rcs0
[202.648477] Dynamic subtest rcs0: SUCCESS (5.507s)
[202.660549] Starting dynamic subtest: bcs0
[208.152942] Dynamic subtest bcs0: SUCCESS (5.501s)
[208.165244] Starting dynamic subtest: vcs0
[213.632086] Dynamic subtest vcs0: SUCCESS (5.480s)
[213.640176] Starting dynamic subtest: vcs1
[219.098368] Dynamic subtest vcs1: SUCCESS (5.464s)
[219.105770] Starting dynamic subtest: vecs0
[224.578766] Dynamic subtest vecs0: SUCCESS (5.481s)
[224.586904] Starting dynamic subtest: ccs0
[230.059093] Dynamic subtest ccs0: SUCCESS (5.514s)
[230.059861] Subtest Q-smoketest: SUCCESS (32.956s)
[230.229496] [044/132] (793s left) syncobj_wait (invalid-wait-bad-flags)
[230.284410] Starting subtest: invalid-wait-bad-flags
[230.285235] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[230.367489] [045/132] (792s left) kms_legacy_colorkey (invalid-plane)
[230.464140] Starting subtest: invalid-plane
[230.465255] Starting dynamic subtest: zero-id
[230.466216] Dynamic subtest zero-id: SUCCESS (0.000s)
[230.474376] Starting dynamic subtest: outrange-id
[230.475228] Dynamic subtest outrange-id: SUCCESS (0.000s)
[230.476036] Subtest invalid-plane: SUCCESS (0.001s)
[230.545785] [046/132] (792s left) gem_eio (in-flight-contexts-immediate)
[230.778071] Starting subtest: in-flight-contexts-immediate
[243.937814] Subtest in-flight-contexts-immediate: SUCCESS (13.160s)
[244.100753] [047/132] (779s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[244.210746] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[245.201157] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.990s)
[245.328144] [048/132] (778s left) kms_psr (psr2-cursor-plane-onoff)
[245.412217] Starting subtest: psr2-cursor-plane-onoff
[245.413048] Starting dynamic subtest: eDP-1
[247.084535] Dynamic subtest eDP-1: SUCCESS (1.671s)
[247.085426] Subtest psr2-cursor-plane-onoff: SUCCESS (1.672s)
[247.868071] [049/132] (775s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[247.955765] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[247.957511] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[248.044714] [050/132] (775s left) kms_chamelium_frames (hdmi-crc-single)
[248.422735] Subtest hdmi-crc-single: SKIP (0.000s)
[249.191831] [051/132] (774s left) syncobj_basic (bad-pad-fd-to-handle)
[249.242154] Starting subtest: bad-pad-fd-to-handle
[249.243030] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[249.329977] [052/132] (774s left) api_intel_bb (intel-bb-blit-x)
[249.376260] Starting subtest: intel-bb-blit-x
[252.980507] Subtest intel-bb-blit-x: SUCCESS (3.595s)
[253.085562] [053/132] (770s left) gem_wait (await)
[253.143526] Starting subtest: await
[253.144617] Starting dynamic subtest: all-engines
[254.323295] Dynamic subtest all-engines: SUCCESS (1.179s)
[254.341632] Starting dynamic subtest: rcs0
[255.383226] Dynamic subtest rcs0: SUCCESS (1.056s)
[255.399643] Starting dynamic subtest: bcs0
[256.439982] Dynamic subtest bcs0: SUCCESS (1.055s)
[256.457486] Starting dynamic subtest: vcs0
[257.495224] Dynamic subtest vcs0: SUCCESS (1.053s)
[257.512246] Starting dynamic subtest: vcs1
[258.548904] Dynamic subtest vcs1: SUCCESS (1.052s)
[258.564730] Starting dynamic subtest: vecs0
[259.602134] Dynamic subtest vecs0: SUCCESS (1.051s)
[259.617728] Starting dynamic subtest: ccs0
[260.658264] Dynamic subtest ccs0: SUCCESS (1.054s)
[260.659764] Subtest await: SUCCESS (7.515s)
[260.862330] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[260.864933] [054/132] (762s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[260.952169] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[260.953155] Starting dynamic subtest: pipe-A-eDP-1
[260.962306] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[260.970230] Starting dynamic subtest: pipe-B-eDP-1
[260.978785] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[260.986145] Starting dynamic subtest: pipe-C-eDP-1
[260.993774] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[261.000796] Starting dynamic subtest: pipe-D-eDP-1
[261.008116] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[261.008986] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[263.186783] [055/132] (760s left) kms_addfb_basic (invalid-set-prop-any)
[263.244919] Starting subtest: invalid-set-prop-any
[263.245864] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[263.387911] [056/132] (760s left) i915_pm_rpm (gem-evict-pwrite)
[265.126579] Starting subtest: gem-evict-pwrite
[265.129166] Subtest gem-evict-pwrite: SKIP (0.000s)
[265.632555] [057/132] (758s left) gem_exercise_blt (fast-copy-emit)
[265.687818] Starting subtest: fast-copy-emit
[265.688978] Starting dynamic subtest: linear-smem-smem-emit
[265.709887] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s)
[265.718492] Starting dynamic subtest: xmajor-smem-smem-emit
[265.727124] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[265.734348] Starting dynamic subtest: tile4-smem-smem-emit
[265.745399] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s)
[265.752276] Starting dynamic subtest: tile64-smem-smem-emit
[265.762450] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[265.763552] Subtest fast-copy-emit: SUCCESS (0.075s)
[265.874828] [058/132] (757s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[265.977849] Starting subtest: y-tiled-32bpp-rotate-0
[265.979652] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[266.071768] [059/132] (757s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[266.175042] Starting subtest: x-tiled-64bpp-rotate-180
[267.720886] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.546s)
[267.896770] [060/132] (755s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[267.990441] Starting subtest: yf-tiled-32bpp-rotate-90
[267.992213] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[268.088897] [061/132] (755s left) gem_exec_params (rsvd2-dirt)
[268.140412] Starting subtest: rsvd2-dirt
[268.142069] Subtest rsvd2-dirt: SKIP (0.000s)
[268.230484] [062/132] (755s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[268.312322] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[268.313152] Starting dynamic subtest: pipe-A-eDP-1
[285.356706] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.906s)
[285.365082] Starting dynamic subtest: pipe-B-eDP-1
[303.348480] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.742s)
[303.361953] Starting dynamic subtest: pipe-C-eDP-1
[321.316906] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.700s)
[321.324910] Starting dynamic subtest: pipe-D-eDP-1
[339.306378] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.746s)
[339.307247] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.100s)
[346.469662] [063/132] (683s left) gem_ctx_engines (independent)
[346.519492] Starting subtest: independent
[346.520329] Starting dynamic subtest: rcs0
[346.769362] Dynamic subtest rcs0: SUCCESS (0.240s)
[346.779073] Starting dynamic subtest: bcs0
[347.033421] Dynamic subtest bcs0: SUCCESS (0.263s)
[347.043828] Starting dynamic subtest: vcs0
[347.232827] Dynamic subtest vcs0: SUCCESS (0.198s)
[347.240666] Starting dynamic subtest: vcs1
[347.468179] Dynamic subtest vcs1: SUCCESS (0.234s)
[347.476038] Starting dynamic subtest: vecs0
[347.689772] Dynamic subtest vecs0: SUCCESS (0.220s)
[347.700625] Starting dynamic subtest: ccs0
[348.097668] Dynamic subtest ccs0: SUCCESS (0.406s)
[348.106710] Starting dynamic subtest: all-engines
[349.064090] Dynamic subtest all-engines: SUCCESS (0.964s)
[349.065220] Subtest independent: SUCCESS (2.534s)
[350.823677] [064/132] (679s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[350.949322] Starting subtest: cursor-vs-flip-legacy
[380.426966] Subtest cursor-vs-flip-legacy: SUCCESS (29.469s)
[381.290404] [065/132] (648s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[381.387609] Starting subtest: drrs-dirtyfb-ioctl
[381.392374] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[381.486048] [066/132] (648s left) kms_color (ctm-signed)
[381.585022] Starting subtest: ctm-signed
[381.585942] Starting dynamic subtest: pipe-A-eDP-1
[383.676588] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.091s)
[383.684872] Starting dynamic subtest: pipe-B-eDP-1
[386.549758] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.873s)
[386.558280] Starting dynamic subtest: pipe-C-eDP-1
[389.264739] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.714s)
[389.273313] Starting dynamic subtest: pipe-D-eDP-1
[391.936793] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.670s)
[391.937624] Subtest ctm-signed: SUCCESS (10.351s)
[392.758806] [067/132] (637s left) gem_pipe_control_store_loop (fresh-buffer)
[392.824551] Starting subtest: fresh-buffer
[395.022743] Subtest fresh-buffer: SUCCESS (2.152s)
[395.081348] [068/132] (634s left) i915_hangman (gt-engine-hang)
[395.141088] Starting subtest: gt-engine-hang
[395.141981] Starting dynamic subtest: rcs0
[396.762852] Dynamic subtest rcs0: SUCCESS (1.612s)
[396.774253] Starting dynamic subtest: bcs0
[398.747046] Dynamic subtest bcs0: SUCCESS (1.981s)
[398.758385] Starting dynamic subtest: vcs0
[400.793834] Dynamic subtest vcs0: SUCCESS (2.044s)
[400.805584] Starting dynamic subtest: vcs1
[402.778295] Dynamic subtest vcs1: SUCCESS (1.981s)
[402.795998] Starting dynamic subtest: vecs0
[404.762207] Dynamic subtest vecs0: SUCCESS (1.980s)
[404.774001] Starting dynamic subtest: ccs0
[406.745753] Dynamic subtest ccs0: SUCCESS (1.981s)
[406.746903] Subtest gt-engine-hang: SUCCESS (11.595s)
[406.874461] [069/132] (623s left) kms_properties (connector-properties-legacy)
[406.990710] Starting subtest: connector-properties-legacy
[406.991594] Starting dynamic subtest: pipe-A-eDP-1
[414.864722] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.871s)
[414.873107] Starting dynamic subtest: pipe-None-DP-1
[414.874953] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[414.883031] Starting dynamic subtest: pipe-None-HDMI-A-1
[414.884687] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[414.892917] Starting dynamic subtest: pipe-None-DP-2
[414.894588] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[414.902540] Starting dynamic subtest: pipe-None-HDMI-A-2
[414.904208] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[414.912511] Starting dynamic subtest: pipe-None-DP-3
[414.914136] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[414.922280] Starting dynamic subtest: pipe-None-DP-4
[414.924120] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[414.925042] Subtest connector-properties-legacy: SUCCESS (7.883s)
[415.725343] [070/132] (614s left) prime_vgem (basic-write)
[415.808906] Starting subtest: basic-write
[415.826607] Subtest basic-write: SKIP (0.017s)
[415.935864] [071/132] (614s left) prime_busy (after)
[416.005226] Starting subtest: after
[416.008672] Starting dynamic subtest: rcs0
[416.046164] Dynamic subtest rcs0: SUCCESS (0.037s)
[416.056783] Starting dynamic subtest: bcs0
[416.100075] Dynamic subtest bcs0: SUCCESS (0.053s)
[416.109641] Starting dynamic subtest: vcs0
[416.140805] Dynamic subtest vcs0: SUCCESS (0.040s)
[416.149669] Starting dynamic subtest: vcs1
[416.181904] Dynamic subtest vcs1: SUCCESS (0.040s)
[416.191188] Starting dynamic subtest: vecs0
[416.222567] Dynamic subtest vecs0: SUCCESS (0.040s)
[416.231109] Starting dynamic subtest: ccs0
[416.264798] Dynamic subtest ccs0: SUCCESS (0.041s)
[416.372364] Subtest after: SUCCESS (0.366s)
[416.486780] [072/132] (613s left) gem_spin_batch (resubmit-new-all)
[416.538857] Starting subtest: resubmit-new-all
[416.539965] Starting dynamic subtest: rcs0
[416.552896] Dynamic subtest rcs0: SUCCESS (0.014s)
[416.563792] Starting dynamic subtest: bcs0
[416.564727] Dynamic subtest bcs0: SUCCESS (0.011s)
[416.573288] Starting dynamic subtest: vcs0
[416.575522] Dynamic subtest vcs0: SUCCESS (0.010s)
[416.583600] Starting dynamic subtest: vcs1
[416.585633] Dynamic subtest vcs1: SUCCESS (0.009s)
[416.594011] Starting dynamic subtest: vecs0
[416.594982] Dynamic subtest vecs0: SUCCESS (0.009s)
[416.603189] Starting dynamic subtest: ccs0
[416.605494] Dynamic subtest ccs0: SUCCESS (0.009s)
[416.606509] Subtest resubmit-new-all: SUCCESS (0.067s)
[417.816194] [073/132] (612s left) kms_getfb (getfb-handle-valid)
[417.903015] Starting subtest: getfb-handle-valid
[417.904011] Subtest getfb-handle-valid: SUCCESS (0.000s)
[417.994829] [074/132] (612s left) gem_ctx_param (set-priority-not-supported)
[418.043051] Starting subtest: set-priority-not-supported
[418.045461] Subtest set-priority-not-supported: SKIP (0.000s)
[418.114704] [075/132] (612s left) kms_flip (2x-plain-flip-fb-recreate)
[418.213723] Starting subtest: 2x-plain-flip-fb-recreate
[418.223641] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[418.300630] [076/132] (612s left) kms_plane (plane-position-hole-dpms)
[418.391026] Starting subtest: plane-position-hole-dpms
[418.929993] Starting dynamic subtest: pipe-A-plane-1
[421.307017] Dynamic subtest pipe-A-plane-1: SUCCESS (2.377s)
[421.315579] Starting dynamic subtest: pipe-A-plane-2
[423.580644] Dynamic subtest pipe-A-plane-2: SUCCESS (2.272s)
[423.589447] Starting dynamic subtest: pipe-A-plane-3
[425.958467] Dynamic subtest pipe-A-plane-3: SUCCESS (2.377s)
[425.967260] Starting dynamic subtest: pipe-A-plane-4
[428.312253] Dynamic subtest pipe-A-plane-4: SUCCESS (2.352s)
[428.321040] Starting dynamic subtest: pipe-A-plane-5
[428.336944] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[429.495856] Starting dynamic subtest: pipe-B-plane-1
[431.939751] Dynamic subtest pipe-B-plane-1: SUCCESS (2.452s)
[431.948098] Starting dynamic subtest: pipe-B-plane-2
[434.274382] Dynamic subtest pipe-B-plane-2: SUCCESS (2.332s)
[434.282778] Starting dynamic subtest: pipe-B-plane-3
[436.647631] Dynamic subtest pipe-B-plane-3: SUCCESS (2.373s)
[436.656491] Starting dynamic subtest: pipe-B-plane-4
[439.011526] Dynamic subtest pipe-B-plane-4: SUCCESS (2.363s)
[439.020127] Starting dynamic subtest: pipe-B-plane-5
[439.038571] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[439.039359] Subtest plane-position-hole-dpms: SUCCESS (20.646s)
[439.805096] [077/132] (590s left) syncobj_wait (wait-for-submit-delayed-submit)
[439.861726] Starting subtest: wait-for-submit-delayed-submit
[439.965239] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[440.052328] [078/132] (590s left) syncobj_timeline (single-wait-for-submit-signaled)
[440.097756] Starting subtest: single-wait-for-submit-signaled
[440.098604] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[440.207033] [079/132] (590s left) kms_cursor_edge_walk (256x256-left-edge)
[440.301705] Starting subtest: 256x256-left-edge
[440.302559] Starting dynamic subtest: pipe-A-eDP-1
[443.786785] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.485s)
[443.796580] Starting dynamic subtest: pipe-D-eDP-1
[446.926206] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[446.927114] Subtest 256x256-left-edge: SUCCESS (6.620s)
[447.731836] [080/132] (582s left) gem_exec_reloc (basic-wc)
[447.803528] Subtest basic-wc: SKIP (0.000s)
[447.879614] [081/132] (582s left) dmabuf_sync_file (export-multiwait)
[447.926885] Starting subtest: export-multiwait
[447.927884] Subtest export-multiwait: SUCCESS (0.001s)
[447.981274] [082/132] (582s left) gem_ctx_persistence (legacy-engines-hang)
[448.042660] Starting subtest: legacy-engines-hang
[448.043676] Starting dynamic subtest: render
[448.124636] Dynamic subtest render: SUCCESS (0.081s)
[448.136946] Starting dynamic subtest: bsd1
[448.214189] Dynamic subtest bsd1: SUCCESS (0.086s)
[448.226414] Starting dynamic subtest: bsd2
[448.283856] Dynamic subtest bsd2: SUCCESS (0.067s)
[448.294502] Starting dynamic subtest: blt
[448.403301] Dynamic subtest blt: SUCCESS (0.118s)
[448.415252] Starting dynamic subtest: vebox
[448.511240] Dynamic subtest vebox: SUCCESS (0.105s)
[448.512651] Subtest legacy-engines-hang: SUCCESS (0.469s)
[448.599214] [083/132] (582s left) kms_pm_rpm (cursor-dpms)
[450.121790] Starting subtest: cursor-dpms
[450.125172] Subtest cursor-dpms: SKIP (0.000s)
[450.866030] [084/132] (579s left) gem_ctx_persistence (engines-hang)
[450.918608] Starting subtest: engines-hang
[450.919514] Starting dynamic subtest: rcs0
[451.047325] Dynamic subtest rcs0: SUCCESS (0.128s)
[451.060727] Starting dynamic subtest: bcs0
[451.131172] Dynamic subtest bcs0: SUCCESS (0.082s)
[451.142612] Starting dynamic subtest: vcs0
[451.236182] Dynamic subtest vcs0: SUCCESS (0.103s)
[451.248181] Starting dynamic subtest: vcs1
[451.337900] Dynamic subtest vcs1: SUCCESS (0.100s)
[451.350986] Starting dynamic subtest: vecs0
[451.442301] Dynamic subtest vecs0: SUCCESS (0.102s)
[451.455920] Starting dynamic subtest: ccs0
[451.535212] Dynamic subtest ccs0: SUCCESS (0.091s)
[451.537006] Subtest engines-hang: SUCCESS (0.618s)
[451.609891] [085/132] (579s left) kms_scaling_modes (scaling-mode-full-aspect)
[451.695228] Starting subtest: scaling-mode-full-aspect
[451.696272] Starting dynamic subtest: pipe-A-eDP-1
[451.787820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[451.799463] Starting dynamic subtest: pipe-B-eDP-1
[452.988460] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.197s)
[453.001005] Starting dynamic subtest: pipe-C-eDP-1
[454.098039] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[454.109167] Starting dynamic subtest: pipe-D-eDP-1
[455.226047] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[455.227029] Subtest scaling-mode-full-aspect: SUCCESS (3.533s)
[456.380693] [086/132] (574s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[456.478860] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[456.480533] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[456.575100] [087/132] (574s left) gem_exec_fence (submit-chain)
[456.757154] Starting subtest: submit-chain
[456.767783] Subtest submit-chain: SUCCESS (0.017s)
[458.882011] [088/132] (571s left) kms_hdr (invalid-metadata-sizes)
[458.970733] Starting subtest: invalid-metadata-sizes
[458.973217] Subtest invalid-metadata-sizes: SKIP (0.000s)
[459.055746] [089/132] (571s left) gen9_exec_parse (bb-start-far)
[459.106870] Subtest bb-start-far: SKIP (0.000s)
[459.174048] [090/132] (571s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[459.268848] Starting subtest: coverage-vs-premult-vs-constant
[459.571398] Starting dynamic subtest: pipe-A-eDP-1
[460.170837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[460.180538] Starting dynamic subtest: pipe-D-eDP-1
[461.513490] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[461.514294] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.244s)
[462.356415] [091/132] (568s left) gem_exec_reloc (basic-gtt-active)
[462.417204] Subtest basic-gtt-active: SKIP (0.000s)
[462.478503] [092/132] (568s left) gem_exec_store (cachelines)
[462.539070] Starting subtest: cachelines
[462.539978] Starting dynamic subtest: rcs0
[462.612121] Dynamic subtest rcs0: SUCCESS (0.072s)
[462.624848] Starting dynamic subtest: bcs0
[462.666262] Dynamic subtest bcs0: SUCCESS (0.051s)
[462.676908] Starting dynamic subtest: vcs0
[462.720462] Dynamic subtest vcs0: SUCCESS (0.053s)
[462.731643] Starting dynamic subtest: vcs1
[462.773740] Dynamic subtest vcs1: SUCCESS (0.051s)
[462.786120] Starting dynamic subtest: vecs0
[462.827731] Dynamic subtest vecs0: SUCCESS (0.052s)
[462.839698] Starting dynamic subtest: ccs0
[462.884844] Dynamic subtest ccs0: SUCCESS (0.055s)
[462.885945] Subtest cachelines: SUCCESS (0.347s)
[463.072026] [093/132] (567s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[463.161781] Starting subtest: bad-aux-stride-y-tiled-ccs
[463.162635] Starting dynamic subtest: pipe-A-eDP-1
[463.170817] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[463.179325] Starting dynamic subtest: pipe-B-eDP-1
[463.187717] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[463.196385] Starting dynamic subtest: pipe-C-eDP-1
[463.204547] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[463.212515] Starting dynamic subtest: pipe-D-eDP-1
[463.220583] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[463.222129] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[465.414049] [094/132] (565s left) i915_suspend (sysfs-reader)
[465.473335] Starting subtest: sysfs-reader
[484.152367] Subtest sysfs-reader: SUCCESS (3.523s)
[489.275983] [095/132] (546s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[489.379880] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[489.381587] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[489.472183] [096/132] (546s left) gem_exec_schedule (u-fairslice-all)
[489.529174] Starting subtest: u-fairslice-all
[491.596217] Subtest u-fairslice-all: SUCCESS (2.065s)
[492.941705] [097/132] (543s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[493.039672] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[493.041598] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[493.126004] [098/132] (543s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[493.207225] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[493.209065] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[493.288811] [099/132] (542s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[493.389820] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[497.605186] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.221s)
[498.768842] [100/132] (537s left) kms_content_protection (lic-type-1)
[498.912792] Starting subtest: lic-type-1
[498.914637] Subtest lic-type-1: SKIP (0.000s)
[499.030030] [101/132] (537s left) gem_userptr_blits (unsync-unmap)
[499.093378] Subtest unsync-unmap: SKIP (0.000s)
[499.204441] [102/132] (537s left) gem_exec_balancer (bonded-semaphore)
[499.259515] Starting subtest: bonded-semaphore
[499.261200] Subtest bonded-semaphore: SKIP (0.000s)
[499.575561] [103/132] (536s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[499.656909] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[499.657936] Starting dynamic subtest: pipe-A
[499.676860] Dynamic subtest pipe-A: SKIP (0.018s)
[499.686021] Starting dynamic subtest: pipe-B
[499.707561] Dynamic subtest pipe-B: SKIP (0.031s)
[499.716566] Starting dynamic subtest: pipe-C
[499.740402] Dynamic subtest pipe-C: SKIP (0.031s)
[499.749389] Starting dynamic subtest: pipe-D
[499.772063] Dynamic subtest pipe-D: SKIP (0.031s)
[499.773753] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.114s)
[499.889204] [104/132] (536s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[499.988096] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[499.989839] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[500.078313] [105/132] (536s left) gem_exec_schedule (lateslice)
[500.140156] Starting subtest: lateslice
[500.141339] Starting dynamic subtest: rcs0
[500.162526] Dynamic subtest rcs0: SUCCESS (0.022s)
[500.174660] Starting dynamic subtest: bcs0
[500.180097] Dynamic subtest bcs0: SUCCESS (0.017s)
[500.189364] Starting dynamic subtest: vcs0
[500.205416] Dynamic subtest vcs0: SUCCESS (0.025s)
[500.214535] Starting dynamic subtest: vcs1
[500.224493] Dynamic subtest vcs1: SUCCESS (0.018s)
[500.233302] Starting dynamic subtest: vecs0
[500.239502] Dynamic subtest vecs0: SUCCESS (0.014s)
[500.248181] Starting dynamic subtest: ccs0
[500.255701] Dynamic subtest ccs0: SUCCESS (0.015s)
[500.256609] Subtest lateslice: SUCCESS (0.116s)
[502.002220] [106/132] (534s left) kms_plane_multiple (2x-tiling-4)
[502.091763] Starting subtest: 2x-tiling-4
[502.093322] Subtest 2x-tiling-4: SKIP (0.000s)
[502.161297] [107/132] (534s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[502.246467] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[502.248276] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[502.348975] [108/132] (534s left) kms_prop_blob (blob-prop-core)
[502.402256] Starting subtest: blob-prop-core
[502.403381] Subtest blob-prop-core: SUCCESS (0.000s)
[502.482982] [109/132] (534s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[502.570962] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[502.571899] Starting dynamic subtest: pipe-A-default-mode
[503.706781] Dynamic subtest pipe-A-default-mode: SKIP (1.134s)
[503.708368] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.136s)
[503.873421] [110/132] (532s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[504.252251] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[505.071544] [111/132] (531s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[505.133425] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[505.135286] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[505.323765] [112/132] (531s left) kms_sequence (queue-busy)
[505.418929] Starting subtest: queue-busy
[505.419835] Starting dynamic subtest: pipe-A-eDP-1
[507.371323] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.951s)
[507.380673] Starting dynamic subtest: pipe-B-eDP-1
[510.010177] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.636s)
[510.019039] Starting dynamic subtest: pipe-C-eDP-1
[512.617883] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.607s)
[512.628529] Starting dynamic subtest: pipe-D-eDP-1
[515.252199] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.632s)
[515.253243] Subtest queue-busy: SUCCESS (9.832s)
[516.145953] [113/132] (520s left) perf_pmu (busy-check-all)
[516.179637] Starting subtest: busy-check-all
[516.180484] Starting dynamic subtest: rcs0
[516.729149] Dynamic subtest rcs0: SUCCESS (0.549s)
[516.742730] Starting dynamic subtest: bcs0
[517.279838] Dynamic subtest bcs0: SUCCESS (0.548s)
[517.293104] Starting dynamic subtest: vcs0
[518.961250] Dynamic subtest vcs0: SUCCESS (1.669s)
[518.972710] Starting dynamic subtest: vcs1
[520.945900] Dynamic subtest vcs1: SUCCESS (1.982s)
[520.957317] Starting dynamic subtest: vecs0
[522.993303] Dynamic subtest vecs0: SUCCESS (2.044s)
[523.004785] Starting dynamic subtest: ccs0
[523.539532] Dynamic subtest ccs0: SUCCESS (0.553s)
[523.542568] Subtest busy-check-all: SUCCESS (7.360s)
[523.639060] [114/132] (513s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[523.741559] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[523.743414] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[523.842824] [115/132] (512s left) syncobj_timeline (wait-for-submit-snapshot)
[523.882157] Starting subtest: wait-for-submit-snapshot
[523.964086] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[524.036348] [116/132] (512s left) gem_mmap_wc (invalid-flags)
[524.083666] Subtest invalid-flags: SKIP (0.000s)
[524.135114] [117/132] (512s left) kms_async_flips (invalid-async-flip)
[524.219763] Starting subtest: invalid-async-flip
[524.594304] Starting dynamic subtest: pipe-A-eDP-1
[525.377982] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s)
[525.736058] Starting dynamic subtest: pipe-B-eDP-1
[526.510957] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s)
[526.886541] Starting dynamic subtest: pipe-C-eDP-1
[527.651796] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.773s)
[528.012634] Starting dynamic subtest: pipe-D-eDP-1
[528.783287] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s)
[528.785079] Subtest invalid-async-flip: SUCCESS (4.564s)
[529.939758] [118/132] (506s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[530.023798] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[536.794346] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.771s)
[536.903621] [119/132] (500s left) kms_joiner (basic-force-big-joiner)
[536.989815] Starting subtest: basic-force-big-joiner
[536.991531] Subtest basic-force-big-joiner: SKIP (0.000s)
[537.056838] [120/132] (499s left) kms_psr (pr-sprite-mmap-gtt)
[537.144933] Starting subtest: pr-sprite-mmap-gtt
[537.146790] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[537.213633] [121/132] (499s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[537.309001] Starting subtest: psr-2p-primscrn-spr-indfb-move
[537.310806] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[537.390126] [122/132] (499s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[537.475300] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[537.476186] Starting dynamic subtest: pipe-A-eDP-1
[537.570314] Dynamic subtest pipe-A-eDP-1: SKIP (0.094s)
[537.579986] Starting dynamic subtest: pipe-B-eDP-1
[538.720777] Dynamic subtest pipe-B-eDP-1: SKIP (1.149s)
[538.722640] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.246s)
[539.907896] [123/132] (497s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[539.969690] Starting subtest: multi-wait-for-submit-unsubmitted
[540.075505] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[540.164464] [124/132] (496s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[540.422944] Starting subtest: cursor-rapid-movement-256x85
[540.467553] Subtest cursor-rapid-movement-256x85: SKIP (0.043s)
[540.641131] [125/132] (496s left) gem_mmap_wc (read)
[540.692175] Subtest read: SKIP (0.000s)
[540.754069] [126/132] (496s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[540.845822] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[540.847741] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[540.914570] [127/132] (496s left) gem_exec_balancer (sliced)
[540.969498] Starting subtest: sliced
[540.971731] Subtest sliced: SKIP (0.000s)
[541.272797] [128/132] (496s left) kms_flip (2x-plain-flip-interruptible)
[541.366480] Starting subtest: 2x-plain-flip-interruptible
[541.378216] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[541.469099] [129/132] (495s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[541.554333] Starting subtest: fbcpsr-rgb101010-draw-render
[548.285080] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.732s)
[548.411769] [130/132] (488s left) gem_mmap_gtt (big-copy-odd)
[548.463034] Subtest big-copy-odd: SKIP (0.000s)
[548.523338] [131/132] (488s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[548.583517] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[548.692157] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[548.765656] [132/132] (488s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[548.861775] Starting subtest: fbc-psr2-sprite-plane-onoff
[548.862799] Starting dynamic subtest: eDP-1
[548.864420] Dynamic subtest eDP-1: SKIP (0.000s)
[548.866067] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[548.930140] Closing watchdogs
results: parsing output: 0/ for test: gem_pread
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: gem_softpin
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_feature_discovery
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: gem_reg_read
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_atomic_transition
results: parsing output: 13/ for test: gem_userptr_blits
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: gem_render_copy
results: parsing output: 19/ for test: gem_busy
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: gen9_exec_parse
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_pipe_b_c_ivb
results: parsing output: 31/ for test: kms_atomic_interruptible
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_chamelium_color
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: api_intel_allocator
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: sw_sync
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: gem_ctx_shared
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_legacy_colorkey
results: parsing output: 45/ for test: gem_eio
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_chamelium_frames
results: parsing output: 50/ for test: syncobj_basic
results: parsing output: 51/ for test: api_intel_bb
results: parsing output: 52/ for test: gem_wait
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: i915_pm_rpm
results: parsing output: 56/ for test: gem_exercise_blt
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_ctx_engines
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_dirtyfb
results: parsing output: 65/ for test: kms_color
results: parsing output: 66/ for test: gem_pipe_control_store_loop
results: parsing output: 67/ for test: i915_hangman
results: parsing output: 68/ for test: kms_properties
results: parsing output: 69/ for test: prime_vgem
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: gem_spin_batch
results: parsing output: 72/ for test: kms_getfb
results: parsing output: 73/ for test: gem_ctx_param
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_cursor_edge_walk
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: dmabuf_sync_file
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: kms_scaling_modes
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: kms_hdr
results: parsing output: 88/ for test: gen9_exec_parse
results: parsing output: 89/ for test: kms_plane_alpha_blend
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: gem_exec_store
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: i915_suspend
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_content_protection
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: gem_exec_balancer
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_plane_multiple
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_prop_blob
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_chamelium_hpd
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_sequence
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_mmap_wc
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_joiner
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: gem_mmap_wc
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_psr
Done.