[57.304011] Initializing watchdogs
[57.304061]   /dev/watchdog0
[57.319609] [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]
[57.324243] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.327115] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.330460] [001/133] (960s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[57.460913] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[57.463636] Starting dynamic subtest: pipe-A-eDP-1
[58.459219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.992s)
[58.467823] Starting dynamic subtest: pipe-B-eDP-1
[60.210618] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.747s)
[60.219207] Starting dynamic subtest: pipe-C-eDP-1
[61.847323] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.637s)
[61.856712] Starting dynamic subtest: pipe-D-eDP-1
[63.462112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.612s)
[63.464131] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.991s)
[64.630412] [002/133] (953s left) kms_psr (fbc-pr-sprite-plane-move)
[64.727524] Starting subtest: fbc-pr-sprite-plane-move
[64.731813] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[64.807622] [003/133] (953s left) gem_eio (in-flight-contexts-immediate)
[64.960432] Starting subtest: in-flight-contexts-immediate
[75.270910] Subtest in-flight-contexts-immediate: SUCCESS (10.307s)
[75.445989] [004/133] (942s left) kms_async_flips (async-flip-suspend-resume)
[75.531553] Starting subtest: async-flip-suspend-resume
[75.906052] Starting dynamic subtest: pipe-A-eDP-1
[93.233099] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.080s)
[93.606333] Starting dynamic subtest: pipe-B-eDP-1
[111.228975] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.855s)
[111.602226] Starting dynamic subtest: pipe-C-eDP-1
[129.226309] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.873s)
[129.594939] Starting dynamic subtest: pipe-D-eDP-1
[147.241923] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.880s)
[147.244278] Subtest async-flip-suspend-resume: SUCCESS (13.151s)
[148.456724] [005/133] (869s left) kms_flip (modeset-vs-vblank-race)
[148.560934] Starting subtest: modeset-vs-vblank-race
[148.563376] Starting dynamic subtest: A-eDP1
[153.416366] Dynamic subtest A-eDP1: SUCCESS (4.739s)
[153.428788] Starting dynamic subtest: B-eDP1
[158.218825] Dynamic subtest B-eDP1: SUCCESS (4.738s)
[158.229896] Starting dynamic subtest: C-eDP1
[162.937647] Dynamic subtest C-eDP1: SUCCESS (4.683s)
[162.949280] Starting dynamic subtest: D-eDP1
[167.586176] Dynamic subtest D-eDP1: SUCCESS (4.629s)
[167.588595] Subtest modeset-vs-vblank-race: SUCCESS (18.798s)
[168.746266] [006/133] (849s left) kms_psr (pr-cursor-plane-move)
[168.844933] Starting subtest: pr-cursor-plane-move
[168.849369] Subtest pr-cursor-plane-move: SKIP (0.000s)
[168.916405] [007/133] (849s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[169.013465] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[176.392615] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.369s)
[176.513711] [008/133] (841s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[176.628697] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[176.632824] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[176.733210] [009/133] (841s left) kms_atomic_transition (modeset-transition-nonblocking)
[176.827096] Starting subtest: modeset-transition-nonblocking
[176.829077] Starting dynamic subtest: 1x-outputs
[187.868794] Dynamic subtest 1x-outputs: SUCCESS (11.040s)
[187.871166] Subtest modeset-transition-nonblocking: SUCCESS (11.042s)
[188.728157] [010/133] (829s left) i915_power (sanity)
[188.780497] Starting subtest: sanity
[192.824343] Subtest sanity: SUCCESS (4.036s)
[194.597430] [011/133] (823s left) gem_exec_whisper (basic-queues-all)
[194.670959] Starting subtest: basic-queues-all
[206.570313] Subtest basic-queues-all: SUCCESS (11.894s)
[206.753899] [012/133] (811s left) drm_read (empty-nonblock)
[206.903590] Starting subtest: empty-nonblock
[206.905924] Subtest empty-nonblock: SUCCESS (0.000s)
[207.035498] [013/133] (811s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[207.137544] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[207.142018] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[207.207595] [014/133] (811s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[207.290897] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[207.295348] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[207.365391] [015/133] (811s left) kms_psr (psr-sprite-plane-move)
[207.466065] Starting subtest: psr-sprite-plane-move
[207.468440] Starting dynamic subtest: eDP-1
[209.274197] Dynamic subtest eDP-1: SUCCESS (1.806s)
[209.276379] Subtest psr-sprite-plane-move: SUCCESS (1.807s)
[210.092458] [016/133] (808s left) gem_exec_create (legacy)
[210.155058] Starting subtest: legacy
[210.157364] Starting dynamic subtest: smem
[212.243519] Dynamic subtest smem: SUCCESS (2.087s)
[212.245899] Subtest legacy: SUCCESS (2.088s)
[212.423450] [017/133] (806s left) perf (blocking)
[212.542430] Starting subtest: blocking
[212.544618] Starting dynamic subtest: 0-rcs0
[222.556136] Dynamic subtest 0-rcs0: SUCCESS (10.009s)
[222.567595] Starting dynamic subtest: 1-vcs1
[232.582029] Dynamic subtest 1-vcs1: SUCCESS (10.021s)
[232.584721] Subtest blocking: SUCCESS (20.031s)
[232.631732] [018/133] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[232.727545] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[232.731607] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[232.833915] [019/133] (785s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[232.917651] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[232.919870] Starting dynamic subtest: pipe-A-eDP-1
[233.661616] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[233.671697] Starting dynamic subtest: pipe-B-eDP-1
[235.442909] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.780s)
[235.454088] Starting dynamic subtest: pipe-C-eDP-1
[237.279221] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.834s)
[237.290495] Starting dynamic subtest: pipe-D-eDP-1
[239.108927] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.828s)
[239.110863] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.183s)
[240.248409] [020/133] (778s left) kms_lease (lease-invalid-crtc)
[240.336385] Starting subtest: lease-invalid-crtc
[240.338700] Starting dynamic subtest: pipe-A-eDP-1
[240.341002] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[240.351875] Starting dynamic subtest: pipe-B-eDP-1
[240.354089] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[240.364054] Starting dynamic subtest: pipe-C-eDP-1
[240.365910] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[240.375524] Starting dynamic subtest: pipe-D-eDP-1
[240.377388] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[240.379254] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[240.415533] [021/133] (778s left) kms_content_protection (atomic-hdcp14)
[240.557384] Starting subtest: atomic-hdcp14
[240.561962] Subtest atomic-hdcp14: SKIP (0.000s)
[240.671158] [022/133] (777s left) gem_ctx_sseu (invalid-args)
[240.729960] Subtest invalid-args: SKIP (0.000s)
[240.817231] [023/133] (777s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[240.871354] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[240.974392] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[241.048098] [024/133] (777s left) gem_lmem_swapping (parallel-random-engines)
[241.090838] Subtest parallel-random-engines: SKIP (0.000s)
[241.133412] [025/133] (777s left) gem_softpin (evict-prime)
[241.190849] Starting subtest: evict-prime
[241.192768] Starting dynamic subtest: rcs0
[242.360349] Dynamic subtest rcs0: SUCCESS (1.168s)
[242.374630] Starting dynamic subtest: bcs0
[243.484977] Dynamic subtest bcs0: SUCCESS (1.123s)
[243.498691] Starting dynamic subtest: vcs0
[245.539043] Dynamic subtest vcs0: SUCCESS (2.052s)
[245.554096] Starting dynamic subtest: vcs1
[247.570826] Dynamic subtest vcs1: SUCCESS (2.031s)
[247.586425] Starting dynamic subtest: vecs0
[249.503883] Dynamic subtest vecs0: SUCCESS (1.931s)
[249.516796] Starting dynamic subtest: ccs0
[250.623971] Dynamic subtest ccs0: SUCCESS (1.120s)
[250.636354] Starting dynamic subtest: all
[252.571660] Dynamic subtest all: SUCCESS (1.946s)
[252.574331] Subtest evict-prime: SUCCESS (11.383s)
[252.653239] [026/133] (766s left) kms_plane_lowres (tiling-none)
[252.754144] Starting subtest: tiling-none
[252.756456] Starting dynamic subtest: pipe-A-eDP-1
[252.760935] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[253.052052] Starting dynamic subtest: pipe-B-eDP-1
[253.056543] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[253.066679] Starting dynamic subtest: pipe-C-eDP-1
[253.071062] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[253.081349] Starting dynamic subtest: pipe-D-eDP-1
[253.085270] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[253.089282] Subtest tiling-none: SKIP (0.294s)
[253.864965] [027/133] (764s left) kms_draw_crc (draw-method-mmap-cpu)
[253.965150] Starting subtest: draw-method-mmap-cpu
[253.966987] Starting dynamic subtest: xrgb8888-untiled
[254.230111] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[254.242676] Starting dynamic subtest: rgb565-untiled
[254.452077] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[254.462967] Starting dynamic subtest: xrgb2101010-untiled
[254.675126] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[254.685923] Starting dynamic subtest: xbgr16161616f-untiled
[254.896445] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[254.909334] Starting dynamic subtest: xrgb8888-xtiled
[255.029503] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[255.040184] Starting dynamic subtest: rgb565-xtiled
[255.162788] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[255.173000] Starting dynamic subtest: xrgb2101010-xtiled
[255.284955] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[255.295335] Starting dynamic subtest: xbgr16161616f-xtiled
[255.418493] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[255.430845] Starting dynamic subtest: xrgb8888-4tiled
[255.573506] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.153s)
[255.583304] Starting dynamic subtest: rgb565-4tiled
[255.718477] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[255.728869] Starting dynamic subtest: xrgb2101010-4tiled
[255.851471] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[255.862647] Starting dynamic subtest: xbgr16161616f-4tiled
[255.995904] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[255.997854] Subtest draw-method-mmap-cpu: SUCCESS (2.034s)
[256.102045] [028/133] (762s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[256.158020] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[256.233703] [029/133] (762s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[256.323420] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[256.325223] Starting dynamic subtest: pipe-A-eDP-1
[256.423216] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[256.436205] Starting dynamic subtest: pipe-B-eDP-1
[257.558809] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[257.562987] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.236s)
[258.748874] [030/133] (760s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[258.854075] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[258.858352] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[258.971801] [031/133] (760s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[259.073918] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[259.078055] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[259.173094] [032/133] (759s left) kms_rotation_crc (primary-rotation-180)
[259.254840] Starting subtest: primary-rotation-180
[266.251771] Subtest primary-rotation-180: SUCCESS (6.999s)
[267.426506] [033/133] (751s left) kms_pm_rpm (universal-planes-dpms)
[269.661162] Starting subtest: universal-planes-dpms
[269.663450] Starting dynamic subtest: plane-35
[278.014304] Dynamic subtest plane-35: SUCCESS (8.354s)
[278.027979] Starting dynamic subtest: plane-65
[286.365042] Dynamic subtest plane-65: SUCCESS (8.348s)
[286.377562] Starting dynamic subtest: plane-95
[294.971661] Dynamic subtest plane-95: SUCCESS (8.603s)
[294.985586] Starting dynamic subtest: plane-125
[303.317197] Dynamic subtest plane-125: SUCCESS (8.342s)
[303.328742] Starting dynamic subtest: plane-135
[311.737131] Dynamic subtest plane-135: SUCCESS (8.414s)
[311.750940] Starting dynamic subtest: plane-145
[320.251181] Dynamic subtest plane-145: SUCCESS (8.510s)
[320.254342] Subtest universal-planes-dpms: SUCCESS (50.586s)
[320.654919] [034/133] (698s left) kms_pm_lpsp (kms-lpsp)
[321.761743] Starting subtest: kms-lpsp
[321.763634] Starting dynamic subtest: pipe-A-eDP-1
[321.906735] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[322.208994] Subtest kms-lpsp: SUCCESS (0.450s)
[323.069793] [035/133] (696s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[323.449538] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[324.261990] [036/133] (694s left) api_intel_allocator (two-level-inception-interruptible)
[324.310962] Starting subtest: two-level-inception-interruptible
[329.721098] Subtest two-level-inception-interruptible: SUCCESS (5.410s)
[329.857149] [037/133] (689s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[329.960865] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[329.964979] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[330.093632] [038/133] (689s left) gem_userptr_blits (huge-split)
[330.168154] Starting subtest: huge-split
[330.175734] Subtest huge-split: SUCCESS (0.008s)
[330.293756] [039/133] (689s left) gem_eio (in-flight-10ms)
[330.524014] Starting subtest: in-flight-10ms
[339.508735] Subtest in-flight-10ms: SUCCESS (8.983s)
[339.625747] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[339.631921] [040/133] (679s left) perf_pmu (pmu-read)
[339.674688] Starting subtest: pmu-read
[339.679450] Subtest pmu-read: SUCCESS (0.003s)
[339.788514] [041/133] (679s left) kms_properties (plane-properties-atomic)
[339.873596] Starting subtest: plane-properties-atomic
[339.875922] Starting dynamic subtest: pipe-A-eDP-1
[340.446227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[340.457801] Starting dynamic subtest: pipe-B-eDP-1
[341.765323] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.315s)
[341.776568] Starting dynamic subtest: pipe-C-eDP-1
[343.011117] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.246s)
[343.023405] Starting dynamic subtest: pipe-D-eDP-1
[344.256491] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[344.258914] Subtest plane-properties-atomic: SUCCESS (4.383s)
[345.044028] [042/133] (674s left) gem_ctx_exec (basic-invalid-context)
[345.103505] Starting subtest: basic-invalid-context
[345.107724] Subtest basic-invalid-context: SUCCESS (0.005s)
[345.242692] [043/133] (674s left) gem_exec_params (rel-constants-invalid)
[345.294949] Starting subtest: rel-constants-invalid
[345.297375] Subtest rel-constants-invalid: SUCCESS (0.000s)
[345.389665] [044/133] (674s left) syncobj_wait (reset-multiple-signaled)
[345.439991] Starting subtest: reset-multiple-signaled
[345.442342] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[345.569936] [045/133] (674s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[345.666386] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[345.670784] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[345.761877] [046/133] (673s left) gem_ctx_persistence (legacy-engines-mixed)
[345.813749] Starting subtest: legacy-engines-mixed
[345.815936] Starting dynamic subtest: render
[345.893053] Dynamic subtest render: SUCCESS (0.078s)
[345.908218] Starting dynamic subtest: bsd1
[345.937066] Dynamic subtest bsd1: SUCCESS (0.040s)
[345.951753] Starting dynamic subtest: bsd2
[345.980931] Dynamic subtest bsd2: SUCCESS (0.041s)
[345.991829] Starting dynamic subtest: blt
[346.037452] Dynamic subtest blt: SUCCESS (0.055s)
[346.051714] Starting dynamic subtest: vebox
[346.107031] Dynamic subtest vebox: SUCCESS (0.066s)
[346.109553] Subtest legacy-engines-mixed: SUCCESS (0.294s)
[346.190445] [047/133] (673s left) gem_pread (display)
[346.250255] Subtest display: SKIP (0.000s)
[346.318998] [048/133] (673s left) fbdev (unaligned-write)
[346.362073] Starting subtest: unaligned-write
[346.463733] Subtest unaligned-write: SUCCESS (0.102s)
[346.526334] [049/133] (673s left) syncobj_timeline (device-signal-unordered)
[346.584542] Starting subtest: device-signal-unordered
[346.586728] Subtest device-signal-unordered: SUCCESS (0.001s)
[346.669500] [050/133] (673s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[346.761940] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[353.714063] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.951s)
[353.856373] [051/133] (666s left) kms_flip (2x-flip-vs-expired-vblank)
[353.945052] Starting subtest: 2x-flip-vs-expired-vblank
[353.953493] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[354.037282] [052/133] (665s left) kms_psr (psr2-sprite-render)
[354.133305] Starting subtest: psr2-sprite-render
[354.135584] Starting dynamic subtest: eDP-1
[355.866844] Dynamic subtest eDP-1: SUCCESS (1.732s)
[355.869076] Subtest psr2-sprite-render: SUCCESS (1.733s)
[356.735733] [053/133] (663s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[356.835495] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[356.837723] Starting dynamic subtest: pipe-A-eDP-1
[362.729228] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.896s)
[362.741959] Starting dynamic subtest: pipe-B-eDP-1
[369.306353] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.574s)
[369.308758] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.473s)
[370.176942] [054/133] (649s left) drm_read (short-buffer-nonblock)
[370.327645] Starting subtest: short-buffer-nonblock
[370.329958] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[370.456017] [055/133] (649s left) gem_exec_schedule (pi-userfault)
[370.635775] Starting subtest: pi-userfault
[370.638164] Starting dynamic subtest: rcs0
[370.643540] Dynamic subtest rcs0: SUCCESS (0.010s)
[370.655959] Starting dynamic subtest: bcs0
[370.658006] Dynamic subtest bcs0: SUCCESS (0.009s)
[370.672746] Starting dynamic subtest: vcs0
[370.674632] Dynamic subtest vcs0: SUCCESS (0.008s)
[370.686151] Starting dynamic subtest: vcs1
[370.688489] Dynamic subtest vcs1: SUCCESS (0.010s)
[370.699120] Starting dynamic subtest: vecs0
[370.701118] Dynamic subtest vecs0: SUCCESS (0.009s)
[370.711442] Starting dynamic subtest: ccs0
[370.713332] Dynamic subtest ccs0: SUCCESS (0.009s)
[370.715251] Subtest pi-userfault: SUCCESS (0.059s)
[370.896261] [056/133] (649s left) i915_pm_rpm (sysfs-read)
[372.721345] Starting subtest: sysfs-read
[373.878100] Subtest sysfs-read: SUCCESS (1.155s)
[374.258146] [057/133] (645s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[374.353662] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[375.466587] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.113s)
[375.595249] [058/133] (644s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[375.702909] Starting subtest: y-tiled-64bpp-rotate-270
[375.706474] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[375.802950] [059/133] (644s left) kms_psr (fbc-psr-primary-blt)
[375.892473] Starting subtest: fbc-psr-primary-blt
[375.894378] Starting dynamic subtest: eDP-1
[375.897743] Dynamic subtest eDP-1: SKIP (0.000s)
[375.901100] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[375.970132] [060/133] (644s left) vgem_basic (dmabuf-export)
[376.010276] Starting subtest: dmabuf-export
[376.050168] Subtest dmabuf-export: SUCCESS (0.044s)
[376.149766] [061/133] (644s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[376.204228] Starting subtest: multi-wait-all-for-submit-available-signaled
[376.206243] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[376.329870] [062/133] (644s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[376.431967] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[376.445526] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.012s)
[376.529390] [063/133] (643s left) syncobj_timeline (single-wait-all-available-submitted)
[376.585203] Starting subtest: single-wait-all-available-submitted
[376.587218] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[376.711802] [064/133] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[376.807574] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[376.811216] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[376.912502] [065/133] (643s left) kms_universal_plane (disable-primary-vs-flip)
[376.997637] Starting subtest: disable-primary-vs-flip
[376.999667] Starting dynamic subtest: pipe-A-eDP-1
[378.533782] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.537s)
[378.547337] Starting dynamic subtest: pipe-B-eDP-1
[380.773475] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.239s)
[380.784997] Starting dynamic subtest: pipe-C-eDP-1
[382.949876] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.171s)
[382.961704] Starting dynamic subtest: pipe-D-eDP-1
[385.122359] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.172s)
[385.124593] Subtest disable-primary-vs-flip: SUCCESS (8.127s)
[385.933152] [066/133] (634s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[386.024850] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[386.029264] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[386.133470] [067/133] (634s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[386.217360] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[386.229218] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[386.308841] [068/133] (634s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[386.401970] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[386.406313] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[386.477919] [069/133] (634s left) vgem_basic (bad-handle)
[386.528559] Starting subtest: bad-handle
[386.530871] Subtest bad-handle: SUCCESS (0.000s)
[386.586204] [070/133] (634s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[386.681274] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[386.683581] Starting dynamic subtest: pipe-A-eDP-1
[386.706133] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[386.718226] Starting dynamic subtest: pipe-B-eDP-1
[386.740053] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[386.750972] Starting dynamic subtest: pipe-C-eDP-1
[386.772249] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[386.782714] Starting dynamic subtest: pipe-D-eDP-1
[386.804867] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[386.808967] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[388.995255] [071/133] (631s left) api_intel_bb (intel-bb-blit-x)
[389.047564] Starting subtest: intel-bb-blit-x
[392.654752] Subtest intel-bb-blit-x: SUCCESS (3.608s)
[392.779111] [072/133] (628s left) kms_cursor_crc (cursor-sliding-32x10)
[392.940368] Starting subtest: cursor-sliding-32x10
[392.992377] Subtest cursor-sliding-32x10: SKIP (0.046s)
[393.273892] [073/133] (627s left) prime_self_import (export-vs-gem_close-race)
[393.312161] Starting subtest: export-vs-gem_close-race
[398.413229] Subtest export-vs-gem_close-race: SUCCESS (5.104s)
[398.496563] [074/133] (622s left) perf (non-sampling-read-error)
[398.611538] Starting subtest: non-sampling-read-error
[398.617152] Subtest non-sampling-read-error: SUCCESS (0.008s)
[398.663146] [075/133] (622s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[398.762073] Starting subtest: bad-rotation-90-y-tiled-ccs
[398.764247] Starting dynamic subtest: pipe-A-eDP-1
[398.787749] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[398.801522] Starting dynamic subtest: pipe-B-eDP-1
[398.822652] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[398.833909] Starting dynamic subtest: pipe-C-eDP-1
[398.856079] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[398.867499] Starting dynamic subtest: pipe-D-eDP-1
[398.889351] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[398.893724] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[401.058235] [076/133] (619s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[401.161137] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[408.123188] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.965s)
[408.251695] [077/133] (612s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[408.306900] Starting subtest: invalid-bsd2-flag-on-blt
[408.309263] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[408.441344] [078/133] (612s left) kms_cursor_crc (cursor-onscreen-128x42)
[408.682935] Starting subtest: cursor-onscreen-128x42
[408.734917] Subtest cursor-onscreen-128x42: SKIP (0.047s)
[408.948926] [079/133] (612s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[409.061768] Starting subtest: modeset-atomic-cursor-hotspot
[409.065767] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[409.220592] [080/133] (611s left) gem_render_copy (linear)
[409.273543] Starting subtest: linear
[409.275350] Starting dynamic subtest: smem
[409.319918] Dynamic subtest smem: SUCCESS (0.047s)
[409.322327] Subtest linear: SUCCESS (0.049s)
[409.542818] [081/133] (611s left) prime_self_import (basic-with_one_bo_two_files)
[409.575910] Starting subtest: basic-with_one_bo_two_files
[409.601368] Subtest basic-with_one_bo_two_files: SUCCESS (0.026s)
[409.708904] [082/133] (611s left) kms_chamelium_edid (hdmi-edid-read)
[410.087159] Subtest hdmi-edid-read: SKIP (0.000s)
[410.924192] [083/133] (610s left) gem_exec_params (readonly)
[410.977572] Starting subtest: readonly
[410.982472] Subtest readonly: SUCCESS (0.002s)
[411.111010] [084/133] (610s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[411.203477] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[411.205885] Starting dynamic subtest: pipe-A-default-mode
[412.393476] Dynamic subtest pipe-A-default-mode: SKIP (1.190s)
[412.397991] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.192s)
[412.577535] [085/133] (608s left) gem_mmap_gtt (cpuset-big-copy)
[412.637346] Subtest cpuset-big-copy: SKIP (0.000s)
[412.704391] [086/133] (608s left) sriov_basic (enable-vfs-autoprobe-on)
[412.762802] Starting subtest: enable-vfs-autoprobe-on
[412.765227] Starting dynamic subtest: numvfs-1
[412.846913] Dynamic subtest numvfs-1: FAIL (0.034s)
[412.859961] Starting dynamic subtest: numvfs-2
[412.934595] Dynamic subtest numvfs-2: FAIL (0.004s)
[412.946984] Starting dynamic subtest: numvfs-3
[413.019241] Dynamic subtest numvfs-3: FAIL (0.004s)
[413.031426] Starting dynamic subtest: numvfs-4
[413.104333] Dynamic subtest numvfs-4: FAIL (0.004s)
[413.116283] Starting dynamic subtest: numvfs-5
[413.190092] Dynamic subtest numvfs-5: FAIL (0.004s)
[413.202342] Starting dynamic subtest: numvfs-6
[413.269696] Dynamic subtest numvfs-6: FAIL (0.004s)
[413.281339] Starting dynamic subtest: numvfs-7
[413.347529] Dynamic subtest numvfs-7: FAIL (0.004s)
[413.358185] Starting dynamic subtest: numvfs-random
[413.416759] Dynamic subtest numvfs-random: FAIL (0.004s)
[413.427919] Starting dynamic subtest: numvfs-all
[413.487999] Dynamic subtest numvfs-all: FAIL (0.004s)
[413.489768] Subtest enable-vfs-autoprobe-on: FAIL (0.584s)
[413.529006] [087/133] (607s left) kms_plane_scaling (planes-downscale-factor-0-75)
[413.622266] Starting subtest: planes-downscale-factor-0-75
[413.624254] Starting dynamic subtest: pipe-A
[413.645850] Dynamic subtest pipe-A: SKIP (0.020s)
[413.656513] Starting dynamic subtest: pipe-B
[413.683669] Dynamic subtest pipe-B: SKIP (0.036s)
[413.694738] Starting dynamic subtest: pipe-C
[413.718571] Dynamic subtest pipe-C: SKIP (0.035s)
[413.729189] Starting dynamic subtest: pipe-D
[413.753949] Dynamic subtest pipe-D: SKIP (0.035s)
[413.756980] Subtest planes-downscale-factor-0-75: SKIP (0.129s)
[413.858124] [088/133] (607s left) kms_plane (plane-panning-top-left)
[413.949380] Starting subtest: plane-panning-top-left
[413.951334] Starting dynamic subtest: pipe-A
[415.656825] Dynamic subtest pipe-A: SUCCESS (1.705s)
[415.667957] Starting dynamic subtest: pipe-B
[418.098872] Dynamic subtest pipe-B: SUCCESS (2.443s)
[418.101159] Subtest plane-panning-top-left: SUCCESS (4.150s)
[418.978225] [089/133] (602s left) kms_plane_cursor (overlay)
[419.071432] Starting subtest: overlay
[419.075980] Starting dynamic subtest: pipe-A-eDP-1-size-64
[421.791087] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.720s)
[421.852450] Starting dynamic subtest: pipe-A-eDP-1-size-128
[424.524564] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.682s)
[424.586855] Starting dynamic subtest: pipe-A-eDP-1-size-256
[427.281206] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.704s)
[427.635305] Starting dynamic subtest: pipe-B-eDP-1-size-64
[431.010595] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.387s)
[431.070862] Starting dynamic subtest: pipe-B-eDP-1-size-128
[433.755588] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.694s)
[433.818180] Starting dynamic subtest: pipe-B-eDP-1-size-256
[436.490603] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.682s)
[436.843257] Starting dynamic subtest: pipe-C-eDP-1-size-64
[439.906387] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.073s)
[439.948862] Starting dynamic subtest: pipe-C-eDP-1-size-128
[442.283666] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.347s)
[442.323743] Starting dynamic subtest: pipe-C-eDP-1-size-256
[444.650617] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.336s)
[444.981977] Starting dynamic subtest: pipe-D-eDP-1-size-64
[448.037769] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.069s)
[448.077852] Starting dynamic subtest: pipe-D-eDP-1-size-128
[450.439007] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.369s)
[450.480375] Starting dynamic subtest: pipe-D-eDP-1-size-256
[452.838229] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.369s)
[453.159576] Subtest overlay: SUCCESS (34.086s)
[454.020711] [090/133] (567s left) perf_pmu (busy)
[454.064332] Starting subtest: busy
[454.066182] Starting dynamic subtest: rcs0
[454.650057] Dynamic subtest rcs0: SUCCESS (0.586s)
[454.665015] Starting dynamic subtest: bcs0
[455.216045] Dynamic subtest bcs0: SUCCESS (0.564s)
[455.231787] Starting dynamic subtest: vcs0
[456.541076] Dynamic subtest vcs0: SUCCESS (1.323s)
[456.553384] Starting dynamic subtest: vcs1
[458.589721] Dynamic subtest vcs1: SUCCESS (2.044s)
[458.608545] Starting dynamic subtest: vecs0
[460.572596] Dynamic subtest vecs0: SUCCESS (1.979s)
[460.584603] Starting dynamic subtest: ccs0
[461.149088] Dynamic subtest ccs0: SUCCESS (0.575s)
[461.152236] Subtest busy: SUCCESS (7.086s)
[461.281830] [091/133] (560s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[461.387622] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[461.399685] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[461.488742] [092/133] (560s left) kms_frontbuffer_tracking (fbc-stridechange)
[461.584680] Starting subtest: fbc-stridechange
[464.933686] Subtest fbc-stridechange: SUCCESS (3.351s)
[466.124871] [093/133] (555s left) gem_pread (bench)
[466.181893] Subtest bench: SKIP (0.000s)
[466.246104] [094/133] (555s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[466.345738] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[473.255641] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.911s)
[473.376659] [095/133] (548s left) syncobj_basic (bad-fd-to-handle)
[473.437971] Starting subtest: bad-fd-to-handle
[473.440309] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[473.551880] [096/133] (548s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[473.599827] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[473.601788] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[473.706672] [097/133] (548s left) perf (mi-rpc)
[473.802308] Starting subtest: mi-rpc
[473.806610] Subtest mi-rpc: SKIP (0.000s)
[473.850805] [098/133] (548s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[473.943925] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[473.948097] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[474.072897] [099/133] (547s left) kms_vblank (ts-continuation-modeset-rpm)
[474.163494] Starting subtest: ts-continuation-modeset-rpm
[474.165823] Starting dynamic subtest: pipe-A-eDP-1
[476.708835] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.545s)
[476.724945] Starting dynamic subtest: pipe-D-eDP-1
[478.932967] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.221s)
[478.935506] Subtest ts-continuation-modeset-rpm: SUCCESS (4.771s)
[479.818050] [100/133] (542s left) perf (non-system-wide-paranoid)
[479.890663] Starting subtest: non-system-wide-paranoid
[479.910760] Subtest non-system-wide-paranoid: SUCCESS (0.020s)
[479.962808] [101/133] (542s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[480.058695] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[480.061015] Starting dynamic subtest: pipe-A-eDP-1
[480.086166] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[480.097970] Starting dynamic subtest: pipe-B-eDP-1
[480.121946] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[480.133512] Starting dynamic subtest: pipe-C-eDP-1
[480.157526] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[480.168582] Starting dynamic subtest: pipe-D-eDP-1
[480.192715] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[480.196825] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[482.380776] [102/133] (539s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[482.474070] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[492.064666] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.590s)
[492.182415] [103/133] (530s left) gem_softpin (allocator-basic)
[492.251712] Starting subtest: allocator-basic
[492.324258] Subtest allocator-basic: SUCCESS (0.072s)
[492.473714] [104/133] (529s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[492.576878] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[499.320532] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.746s)
[499.448327] [105/133] (522s left) syncobj_basic (create-signaled)
[499.505867] Starting subtest: create-signaled
[499.508161] Subtest create-signaled: SUCCESS (0.000s)
[499.613300] [106/133] (522s left) gem_mmap (basic-small-bo)
[499.666116] Subtest basic-small-bo: SKIP (0.000s)
[499.737899] [107/133] (522s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[499.829643] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[506.440511] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.613s)
[506.556670] [108/133] (515s left) kms_force_connector_basic (force-load-detect)
[506.637488] Starting subtest: force-load-detect
[506.642207] Subtest force-load-detect: SKIP (0.000s)
[506.755480] [109/133] (515s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[506.859802] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[506.862513] Starting dynamic subtest: pipe-A-eDP-1
[506.934314] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s)
[506.946837] Starting dynamic subtest: pipe-B-eDP-1
[508.019642] Dynamic subtest pipe-B-eDP-1: SKIP (1.083s)
[508.023895] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.164s)
[509.308758] [110/133] (513s left) gem_mmap_wc (coherency)
[509.375578] Subtest coherency: SKIP (0.000s)
[509.440254] [111/133] (513s left) kms_concurrent (multi-plane-atomic-lowres)
[509.532403] Starting subtest: multi-plane-atomic-lowres
[509.534714] Starting dynamic subtest: pipe-A-eDP-1
[510.030571] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.494s)
[510.042266] Starting dynamic subtest: pipe-B-eDP-1
[511.267857] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.236s)
[511.280033] Starting dynamic subtest: pipe-C-eDP-1
[512.458947] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.191s)
[512.470018] Starting dynamic subtest: pipe-D-eDP-1
[513.669965] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[513.672573] Subtest multi-plane-atomic-lowres: SUCCESS (4.136s)
[514.540372] [112/133] (508s left) gem_gtt_cpu_tlb
[514.664868] [113/133] (507s left) i915_module_load (reload-no-display)
[514.702240] Starting subtest: reload-no-display
[520.152525] Subtest reload-no-display: SUCCESS (5.454s)
[520.183429] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[520.184180] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[520.187486] [114/133] (502s left) i915_drm_fdinfo (idle)
[521.738221] Starting subtest: idle
[521.740094] Starting dynamic subtest: rcs0
[522.325518] Dynamic subtest rcs0: SUCCESS (0.589s)
[522.337929] Starting dynamic subtest: bcs0
[522.832515] Dynamic subtest bcs0: SUCCESS (0.504s)
[522.843220] Starting dynamic subtest: vcs0
[523.338631] Dynamic subtest vcs0: SUCCESS (0.503s)
[523.351586] Starting dynamic subtest: vcs1
[523.845221] Dynamic subtest vcs1: SUCCESS (0.503s)
[523.858107] Starting dynamic subtest: vecs0
[524.350736] Dynamic subtest vecs0: SUCCESS (0.503s)
[524.363245] Starting dynamic subtest: ccs0
[524.856019] Dynamic subtest ccs0: SUCCESS (0.503s)
[524.858676] Subtest idle: SUCCESS (3.119s)
[524.905702] [FACT i915_drm_fdinfo (idle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[524.907432] [FACT i915_drm_fdinfo (idle)] new: kernel.kmod_is_loaded.i915: true
[524.911489] [115/133] (497s left) dumb_buffer (create-clear)
[524.972556] Starting subtest: create-clear
[559.347089] Subtest create-clear: SUCCESS (34.363s)
[559.463147] [116/133] (463s left) kms_flip (flip-vs-fences-interruptible)
[559.573493] Starting subtest: flip-vs-fences-interruptible
[559.577894] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[559.684342] [117/133] (463s left) kms_big_fb (linear-8bpp-rotate-270)
[559.780267] Starting subtest: linear-8bpp-rotate-270
[559.821910] Subtest linear-8bpp-rotate-270: SKIP (0.038s)
[559.955064] [118/133] (462s left) gen9_exec_parse (bb-oversize)
[560.019497] Subtest bb-oversize: SKIP (0.000s)
[560.096392] [119/133] (462s left) gem_exec_schedule (smoketest)
[560.281566] Starting subtest: smoketest
[560.283952] Starting dynamic subtest: rcs0
[565.829021] Dynamic subtest rcs0: SUCCESS (5.497s)
[565.842910] Starting dynamic subtest: bcs0
[571.340357] Dynamic subtest bcs0: SUCCESS (5.512s)
[571.351711] Starting dynamic subtest: vcs0
[576.843342] Dynamic subtest vcs0: SUCCESS (5.498s)
[576.857940] Starting dynamic subtest: vcs1
[582.349444] Dynamic subtest vcs1: SUCCESS (5.499s)
[582.363861] Starting dynamic subtest: vecs0
[587.840493] Dynamic subtest vecs0: SUCCESS (5.490s)
[587.853158] Starting dynamic subtest: ccs0
[593.339262] Dynamic subtest ccs0: SUCCESS (5.494s)
[593.341349] Subtest smoketest: SUCCESS (32.999s)
[593.541580] [120/133] (429s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[593.734381] Starting subtest: cursor-rapid-movement-64x21
[593.792068] Subtest cursor-rapid-movement-64x21: SKIP (0.055s)
[594.048871] [121/133] (428s left) gem_mmap (basic)
[594.100933] Subtest basic: SKIP (0.000s)
[594.164095] [122/133] (428s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[594.252328] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[594.876636] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[595.055164] [123/133] (428s left) gem_exec_balancer (hang)
[595.320109] Starting subtest: hang
[597.034850] Subtest hang: SUCCESS (1.718s)
[597.167519] [124/133] (425s left) gem_ctx_exec (basic-norecovery)
[597.220981] Starting subtest: basic-norecovery
[597.570030] Subtest basic-norecovery: SUCCESS (0.351s)
[597.686592] [125/133] (425s left) kms_hdr (static-toggle)
[597.779664] Starting subtest: static-toggle
[597.786362] Subtest static-toggle: SKIP (0.000s)
[597.853227] [126/133] (425s left) kms_properties (invalid-properties-legacy)
[597.944635] Starting subtest: invalid-properties-legacy
[598.052137] Subtest invalid-properties-legacy: SUCCESS (0.107s)
[598.138550] [127/133] (425s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[598.239825] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[602.351612] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.113s)
[603.558659] [128/133] (419s left) gem_workarounds (suspend-resume-context)
[603.621585] Starting subtest: suspend-resume-context
[619.204972] Subtest suspend-resume-context: SUCCESS (1.984s)
[619.352009] [129/133] (403s left) gem_exec_fence (keep-in-fence)
[619.538908] Starting subtest: keep-in-fence
[619.541121] Starting dynamic subtest: rcs0
[619.595355] Dynamic subtest rcs0: SUCCESS (0.056s)
[619.609173] Starting dynamic subtest: bcs0
[619.651723] Dynamic subtest bcs0: SUCCESS (0.054s)
[619.664204] Starting dynamic subtest: vcs0
[621.178558] Dynamic subtest vcs0: SUCCESS (1.469s)
[621.192561] Starting dynamic subtest: vcs1
[623.170724] Dynamic subtest vcs1: SUCCESS (1.922s)
[623.185185] Starting dynamic subtest: vecs0
[625.146508] Dynamic subtest vecs0: SUCCESS (1.940s)
[625.160776] Starting dynamic subtest: ccs0
[625.398867] Dynamic subtest ccs0: SUCCESS (0.246s)
[625.402067] Subtest keep-in-fence: SUCCESS (5.699s)
[627.208165] [130/133] (396s left) gem_mmap_gtt (hang-user)
[627.266926] Subtest hang-user: SKIP (0.000s)
[627.327117] [131/133] (396s left) kms_atomic_transition (plane-all-transition-fencing)
[627.417799] Starting subtest: plane-all-transition-fencing
[627.420168] Starting dynamic subtest: pipe-A-eDP-1
[629.944884] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[630.269881] Starting dynamic subtest: pipe-B-eDP-1
[633.553795] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.267s)
[633.856729] Subtest plane-all-transition-fencing: SUCCESS (6.373s)
[634.700302] [132/133] (388s left) gem_pxp (protected-raw-src-copy-not-readible)
[634.831764] Starting subtest: protected-raw-src-copy-not-readible
[634.890654] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[634.999073] [133/133] (388s left) syncobj_wait (multi-wait-for-submit-submitted)
[635.054285] Starting subtest: multi-wait-for-submit-submitted
[635.155794] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s)
[635.234400] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_atomic_transition
results: parsing output: 9/ for test: i915_power
results: parsing output: 10/ for test: gem_exec_whisper
results: parsing output: 11/ for test: drm_read
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_exec_create
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_lease
results: parsing output: 20/ for test: kms_content_protection
results: parsing output: 21/ for test: gem_ctx_sseu
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_lmem_swapping
results: parsing output: 24/ for test: gem_softpin
results: parsing output: 25/ for test: kms_plane_lowres
results: parsing output: 26/ for test: kms_draw_crc
results: parsing output: 27/ for test: kms_pipe_b_c_ivb
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_pm_lpsp
results: parsing output: 34/ for test: kms_chamelium_hpd
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_properties
results: parsing output: 41/ for test: gem_ctx_exec
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_ctx_persistence
results: parsing output: 46/ for test: gem_pread
results: parsing output: 47/ for test: fbdev
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: drm_read
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: i915_pm_rpm
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: vgem_basic
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_universal_plane
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: prime_self_import
results: parsing output: 73/ for test: perf
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: prime_self_import
results: parsing output: 81/ for test: kms_chamelium_edid
results: parsing output: 82/ for test: gem_exec_params
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: sriov_basic
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: kms_plane
results: parsing output: 88/ for test: kms_plane_cursor
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_pread
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: syncobj_basic
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: perf
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: syncobj_basic
results: parsing output: 105/ for test: gem_mmap
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_force_connector_basic
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: gem_mmap_wc
results: parsing output: 110/ for test: kms_concurrent
results: parsing output: 111/ for test: gem_gtt_cpu_tlb
results: parsing output: 112/ for test: i915_module_load
results: parsing output: 113/ for test: i915_drm_fdinfo
results: parsing output: 114/ for test: dumb_buffer
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gen9_exec_parse
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_mmap
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: gem_ctx_exec
results: parsing output: 124/ for test: kms_hdr
results: parsing output: 125/ for test: kms_properties
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_workarounds
results: parsing output: 128/ for test: gem_exec_fence
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: kms_atomic_transition
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: syncobj_wait
Done.