[56.547579] Initializing watchdogs
[56.547627]   /dev/watchdog0
[56.562722] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.567199] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.569858] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.573047] [001/133] (960s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[56.703821] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[56.706156] Starting dynamic subtest: pipe-A-eDP-1
[57.620828] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.904s)
[57.628308] Starting dynamic subtest: pipe-B-eDP-1
[59.148769] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.515s)
[59.157906] Starting dynamic subtest: pipe-C-eDP-1
[60.693037] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.536s)
[60.702122] Starting dynamic subtest: pipe-D-eDP-1
[62.181703] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.481s)
[62.184058] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.440s)
[63.374881] [002/133] (953s left) kms_psr (fbc-pr-sprite-plane-move)
[63.465258] Starting subtest: fbc-pr-sprite-plane-move
[63.469841] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[63.537552] [003/133] (953s left) gem_eio (in-flight-contexts-immediate)
[63.681157] Starting subtest: in-flight-contexts-immediate
[73.294106] Subtest in-flight-contexts-immediate: SUCCESS (9.594s)
[73.542825] [004/133] (943s left) kms_async_flips (async-flip-suspend-resume)
[73.645167] Starting subtest: async-flip-suspend-resume
[74.020388] Starting dynamic subtest: pipe-A-eDP-1
[92.262580] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.014s)
[92.647693] Starting dynamic subtest: pipe-B-eDP-1
[110.255713] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.854s)
[110.622027] Starting dynamic subtest: pipe-C-eDP-1
[128.257776] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.882s)
[128.633853] Starting dynamic subtest: pipe-D-eDP-1
[146.251454] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.850s)
[146.254460] Subtest async-flip-suspend-resume: SUCCESS (13.078s)
[147.431728] [005/133] (869s left) kms_flip (modeset-vs-vblank-race)
[147.531019] Starting subtest: modeset-vs-vblank-race
[147.533408] Starting dynamic subtest: A-eDP1
[152.318945] Dynamic subtest A-eDP1: SUCCESS (4.744s)
[152.330980] Starting dynamic subtest: B-eDP1
[157.068371] Dynamic subtest B-eDP1: SUCCESS (4.722s)
[157.078006] Starting dynamic subtest: C-eDP1
[161.698237] Dynamic subtest C-eDP1: SUCCESS (4.614s)
[161.708955] Starting dynamic subtest: D-eDP1
[166.162655] Dynamic subtest D-eDP1: SUCCESS (4.455s)
[166.165146] Subtest modeset-vs-vblank-race: SUCCESS (18.544s)
[167.338942] [006/133] (849s left) kms_psr (pr-cursor-plane-move)
[167.448550] Starting subtest: pr-cursor-plane-move
[167.453285] Subtest pr-cursor-plane-move: SKIP (0.000s)
[167.518092] [007/133] (849s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[167.612702] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[174.970489] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.354s)
[175.103509] [008/133] (842s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[175.206716] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[175.211594] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[175.322892] [009/133] (842s left) kms_atomic_transition (modeset-transition-nonblocking)
[175.403455] Starting subtest: modeset-transition-nonblocking
[175.405920] Starting dynamic subtest: 1x-outputs
[186.444951] Dynamic subtest 1x-outputs: SUCCESS (11.047s)
[186.447334] Subtest modeset-transition-nonblocking: SUCCESS (11.048s)
[187.314557] [010/133] (830s left) i915_power (sanity)
[187.363033] Starting subtest: sanity
[191.407462] Subtest sanity: SUCCESS (4.038s)
[192.818384] [011/133] (824s left) gem_exec_whisper (basic-queues-all)
[192.889882] Starting subtest: basic-queues-all
[204.844132] Subtest basic-queues-all: SUCCESS (11.951s)
[205.022423] [012/133] (812s left) drm_read (empty-nonblock)
[205.165745] Starting subtest: empty-nonblock
[205.168356] Subtest empty-nonblock: SUCCESS (0.000s)
[205.290718] [013/133] (812s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[205.373644] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[205.378211] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[205.457485] [014/133] (812s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[205.550197] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[205.554637] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[205.620117] [015/133] (811s left) kms_psr (psr-sprite-plane-move)
[205.718445] Starting subtest: psr-sprite-plane-move
[205.720579] Starting dynamic subtest: eDP-1
[207.432876] Dynamic subtest eDP-1: SUCCESS (1.714s)
[207.434780] Subtest psr-sprite-plane-move: SUCCESS (1.714s)
[208.260803] [016/133] (809s left) gem_exec_create (legacy)
[208.312764] Starting subtest: legacy
[208.315121] Starting dynamic subtest: smem
[210.403889] Dynamic subtest smem: SUCCESS (2.090s)
[210.406324] Subtest legacy: SUCCESS (2.091s)
[210.594315] [017/133] (807s left) perf (blocking)
[210.722071] Starting subtest: blocking
[210.724441] Starting dynamic subtest: 0-rcs0
[220.761368] Dynamic subtest 0-rcs0: SUCCESS (10.035s)
[220.772268] Starting dynamic subtest: 1-vecs0
[230.782728] Dynamic subtest 1-vecs0: SUCCESS (10.018s)
[230.784940] Subtest blocking: SUCCESS (20.055s)
[230.831503] [018/133] (786s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[230.922609] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[230.926821] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[231.026415] [019/133] (786s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[231.112480] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[231.114751] Starting dynamic subtest: pipe-A-eDP-1
[231.840200] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[231.851928] Starting dynamic subtest: pipe-B-eDP-1
[233.592020] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.750s)
[233.602527] Starting dynamic subtest: pipe-C-eDP-1
[235.318056] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.723s)
[235.329400] Starting dynamic subtest: pipe-D-eDP-1
[237.067731] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.749s)
[237.069723] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.947s)
[238.210492] [020/133] (779s left) kms_lease (lease-invalid-crtc)
[238.309565] Starting subtest: lease-invalid-crtc
[238.312163] Starting dynamic subtest: pipe-A-eDP-1
[238.314591] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[238.325312] Starting dynamic subtest: pipe-B-eDP-1
[238.327597] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[238.337551] Starting dynamic subtest: pipe-C-eDP-1
[238.339788] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[238.349582] Starting dynamic subtest: pipe-D-eDP-1
[238.351873] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[238.354147] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[238.394177] [021/133] (779s left) kms_content_protection (atomic-hdcp14)
[238.535034] Starting subtest: atomic-hdcp14
[238.539444] Subtest atomic-hdcp14: SKIP (0.000s)
[238.680452] [022/133] (779s left) gem_ctx_sseu (invalid-args)
[238.745621] Subtest invalid-args: SKIP (0.000s)
[238.802862] [023/133] (779s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[238.860323] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[238.969634] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[239.058500] [024/133] (778s left) gem_lmem_swapping (parallel-random-engines)
[239.104045] Subtest parallel-random-engines: SKIP (0.000s)
[239.154168] [025/133] (778s left) gem_softpin (evict-prime)
[239.218911] Starting subtest: evict-prime
[239.221571] Starting dynamic subtest: rcs0
[240.376302] Dynamic subtest rcs0: SUCCESS (1.156s)
[240.387135] Starting dynamic subtest: bcs0
[241.497276] Dynamic subtest bcs0: SUCCESS (1.119s)
[241.509915] Starting dynamic subtest: vcs0
[242.723054] Dynamic subtest vcs0: SUCCESS (1.223s)
[242.734517] Starting dynamic subtest: vcs1
[244.712554] Dynamic subtest vcs1: SUCCESS (1.988s)
[244.724879] Starting dynamic subtest: vecs0
[246.685882] Dynamic subtest vecs0: SUCCESS (1.971s)
[246.705075] Starting dynamic subtest: ccs0
[247.823572] Dynamic subtest ccs0: SUCCESS (1.139s)
[247.836793] Starting dynamic subtest: all
[249.668458] Dynamic subtest all: SUCCESS (1.842s)
[249.671193] Subtest evict-prime: SUCCESS (10.451s)
[249.788895] [026/133] (768s left) kms_plane_lowres (tiling-none)
[249.883159] Starting subtest: tiling-none
[249.885483] Starting dynamic subtest: pipe-A-eDP-1
[249.890106] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[250.192317] Starting dynamic subtest: pipe-B-eDP-1
[250.196878] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[250.207080] Starting dynamic subtest: pipe-C-eDP-1
[250.211911] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[250.224145] Starting dynamic subtest: pipe-D-eDP-1
[250.228577] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[250.232899] Subtest tiling-none: SKIP (0.309s)
[251.038016] [027/133] (767s left) kms_draw_crc (draw-method-mmap-cpu)
[251.123420] Starting subtest: draw-method-mmap-cpu
[251.125319] Starting dynamic subtest: xrgb8888-untiled
[251.353740] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[251.364927] Starting dynamic subtest: rgb565-untiled
[251.575806] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[251.587305] Starting dynamic subtest: xrgb2101010-untiled
[251.797851] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[251.808875] Starting dynamic subtest: xbgr16161616f-untiled
[252.020021] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[252.032542] Starting dynamic subtest: xrgb8888-xtiled
[252.141992] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[252.151495] Starting dynamic subtest: rgb565-xtiled
[252.264067] Dynamic subtest rgb565-xtiled: SUCCESS (0.120s)
[252.273571] Starting dynamic subtest: xrgb2101010-xtiled
[252.386230] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[252.395969] Starting dynamic subtest: xbgr16161616f-xtiled
[252.519656] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[252.529660] Starting dynamic subtest: xrgb8888-4tiled
[252.664560] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[252.675928] Starting dynamic subtest: rgb565-4tiled
[252.808603] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[252.819082] Starting dynamic subtest: xrgb2101010-4tiled
[252.941757] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[252.958098] Starting dynamic subtest: xbgr16161616f-4tiled
[253.086513] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[253.088367] Subtest draw-method-mmap-cpu: SUCCESS (1.967s)
[253.189097] [028/133] (764s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[253.250843] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[253.307138] [029/133] (764s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[253.394008] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[253.395812] Starting dynamic subtest: pipe-A-eDP-1
[253.491415] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[253.502797] Starting dynamic subtest: pipe-B-eDP-1
[254.615658] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[254.620360] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.223s)
[255.810562] [030/133] (762s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[255.910012] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[255.914233] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[256.010704] [031/133] (762s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[256.109861] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[256.113899] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[256.207312] [032/133] (762s left) kms_rotation_crc (primary-rotation-180)
[256.298462] Starting subtest: primary-rotation-180
[263.348394] Subtest primary-rotation-180: SUCCESS (7.053s)
[264.507825] [033/133] (753s left) kms_pm_rpm (universal-planes-dpms)
[266.040050] Starting subtest: universal-planes-dpms
[266.042806] Starting dynamic subtest: plane-35
[274.468317] Dynamic subtest plane-35: SUCCESS (8.432s)
[274.479494] Starting dynamic subtest: plane-65
[282.769302] Dynamic subtest plane-65: SUCCESS (8.298s)
[282.781906] Starting dynamic subtest: plane-95
[291.093483] Dynamic subtest plane-95: SUCCESS (8.322s)
[291.112036] Starting dynamic subtest: plane-125
[299.429305] Dynamic subtest plane-125: SUCCESS (8.332s)
[299.443599] Starting dynamic subtest: plane-135
[307.739873] Dynamic subtest plane-135: SUCCESS (8.307s)
[307.752044] Starting dynamic subtest: plane-145
[316.057943] Dynamic subtest plane-145: SUCCESS (8.314s)
[316.060482] Subtest universal-planes-dpms: SUCCESS (50.019s)
[316.441593] [034/133] (701s left) kms_pm_lpsp (kms-lpsp)
[317.546212] Starting subtest: kms-lpsp
[317.548561] Starting dynamic subtest: pipe-A-eDP-1
[317.693810] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[317.992593] Subtest kms-lpsp: SUCCESS (0.449s)
[318.862873] [035/133] (699s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[319.238571] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[320.069718] [036/133] (698s left) api_intel_allocator (two-level-inception-interruptible)
[320.122153] Starting subtest: two-level-inception-interruptible
[325.532187] Subtest two-level-inception-interruptible: SUCCESS (5.411s)
[325.666411] [037/133] (692s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[325.769710] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[325.774102] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[325.878683] [038/133] (692s left) gem_userptr_blits (huge-split)
[325.952292] Starting subtest: huge-split
[325.957409] Subtest huge-split: SUCCESS (0.008s)
[326.069945] [039/133] (692s left) gem_eio (in-flight-10ms)
[326.295175] Starting subtest: in-flight-10ms
[334.603468] Subtest in-flight-10ms: SUCCESS (8.306s)
[334.779084] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[334.782696] [040/133] (683s left) perf_pmu (pmu-read)
[334.822850] Starting subtest: pmu-read
[334.825239] Subtest pmu-read: SUCCESS (0.003s)
[334.949450] [041/133] (683s left) kms_properties (plane-properties-atomic)
[335.044493] Starting subtest: plane-properties-atomic
[335.046867] Starting dynamic subtest: pipe-A-eDP-1
[335.591036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s)
[335.601765] Starting dynamic subtest: pipe-B-eDP-1
[336.868316] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.276s)
[336.880706] Starting dynamic subtest: pipe-C-eDP-1
[338.196085] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.324s)
[338.207343] Starting dynamic subtest: pipe-D-eDP-1
[339.429097] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[339.431518] Subtest plane-properties-atomic: SUCCESS (4.386s)
[340.229863] [042/133] (678s left) gem_ctx_exec (basic-invalid-context)
[340.283141] Starting subtest: basic-invalid-context
[340.288054] Subtest basic-invalid-context: SUCCESS (0.004s)
[340.408117] [043/133] (678s left) gem_exec_params (rel-constants-invalid)
[340.460705] Starting subtest: rel-constants-invalid
[340.463075] Subtest rel-constants-invalid: SUCCESS (0.000s)
[340.555134] [044/133] (678s left) syncobj_wait (reset-multiple-signaled)
[340.606713] Starting subtest: reset-multiple-signaled
[340.608968] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[340.707556] [045/133] (678s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[340.802837] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[340.806982] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[340.901567] [046/133] (677s left) gem_ctx_persistence (legacy-engines-mixed)
[340.950454] Starting subtest: legacy-engines-mixed
[340.952865] Starting dynamic subtest: render
[341.038576] Dynamic subtest render: SUCCESS (0.086s)
[341.052672] Starting dynamic subtest: bsd1
[341.105544] Dynamic subtest bsd1: SUCCESS (0.064s)
[341.120688] Starting dynamic subtest: bsd2
[341.168565] Dynamic subtest bsd2: SUCCESS (0.060s)
[341.182651] Starting dynamic subtest: blt
[341.235714] Dynamic subtest blt: SUCCESS (0.064s)
[341.247867] Starting dynamic subtest: vebox
[341.289424] Dynamic subtest vebox: SUCCESS (0.053s)
[341.291533] Subtest legacy-engines-mixed: SUCCESS (0.340s)
[341.369190] [047/133] (677s left) gem_pread (display)
[341.414392] Subtest display: SKIP (0.000s)
[341.476287] [048/133] (677s left) fbdev (unaligned-write)
[341.518809] Starting subtest: unaligned-write
[341.683065] Subtest unaligned-write: SUCCESS (0.162s)
[341.747626] [049/133] (677s left) syncobj_timeline (device-signal-unordered)
[341.791797] Starting subtest: device-signal-unordered
[341.793802] Subtest device-signal-unordered: SUCCESS (0.001s)
[341.893338] [050/133] (677s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[341.978918] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[348.847394] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.869s)
[348.991993] [051/133] (670s left) kms_flip (2x-flip-vs-expired-vblank)
[349.083857] Starting subtest: 2x-flip-vs-expired-vblank
[349.094485] Subtest 2x-flip-vs-expired-vblank: SKIP (0.013s)
[349.188067] [052/133] (669s left) kms_psr (psr2-sprite-render)
[349.280311] Starting subtest: psr2-sprite-render
[349.282474] Starting dynamic subtest: eDP-1
[351.046865] Dynamic subtest eDP-1: SUCCESS (1.765s)
[351.049342] Subtest psr2-sprite-render: SUCCESS (1.766s)
[351.917554] [053/133] (667s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[352.014098] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[352.016444] Starting dynamic subtest: pipe-A-eDP-1
[357.911594] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.901s)
[357.922599] Starting dynamic subtest: pipe-B-eDP-1
[364.572903] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.656s)
[364.575303] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.560s)
[365.436729] [054/133] (653s left) drm_read (short-buffer-nonblock)
[365.581043] Starting subtest: short-buffer-nonblock
[365.583230] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[365.706658] [055/133] (653s left) gem_exec_schedule (pi-userfault)
[365.888091] Starting subtest: pi-userfault
[365.890336] Starting dynamic subtest: rcs0
[365.895909] Dynamic subtest rcs0: SUCCESS (0.010s)
[365.906685] Starting dynamic subtest: bcs0
[365.908579] Dynamic subtest bcs0: SUCCESS (0.008s)
[365.918912] Starting dynamic subtest: vcs0
[365.921291] Dynamic subtest vcs0: SUCCESS (0.009s)
[365.931963] Starting dynamic subtest: vcs1
[365.934206] Dynamic subtest vcs1: SUCCESS (0.007s)
[365.944356] Starting dynamic subtest: vecs0
[365.946377] Dynamic subtest vecs0: SUCCESS (0.008s)
[365.955890] Starting dynamic subtest: ccs0
[365.957888] Dynamic subtest ccs0: SUCCESS (0.008s)
[365.959831] Subtest pi-userfault: SUCCESS (0.055s)
[366.136946] [056/133] (653s left) i915_pm_rpm (sysfs-read)
[367.872809] Starting subtest: sysfs-read
[369.030973] Subtest sysfs-read: SUCCESS (1.156s)
[369.416910] [057/133] (649s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[369.514583] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[370.537604] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.023s)
[370.679578] [058/133] (648s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[370.776325] Starting subtest: y-tiled-64bpp-rotate-270
[370.780194] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[370.878975] [059/133] (648s left) kms_psr (fbc-psr-primary-blt)
[370.982841] Starting subtest: fbc-psr-primary-blt
[370.984830] Starting dynamic subtest: eDP-1
[370.988456] Dynamic subtest eDP-1: SKIP (0.000s)
[370.992119] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[371.056857] [060/133] (648s left) vgem_basic (dmabuf-export)
[371.096460] Starting subtest: dmabuf-export
[371.119794] Subtest dmabuf-export: SUCCESS (0.025s)
[371.228653] [061/133] (648s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[371.283723] Starting subtest: multi-wait-all-for-submit-available-signaled
[371.285403] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[371.381991] [062/133] (648s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[371.467694] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[371.477734] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[371.554304] [063/133] (648s left) syncobj_timeline (single-wait-all-available-submitted)
[371.610540] Starting subtest: single-wait-all-available-submitted
[371.612458] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[371.714070] [064/133] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[371.799687] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[371.803189] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[371.901140] [065/133] (647s left) kms_universal_plane (disable-primary-vs-flip)
[371.980073] Starting subtest: disable-primary-vs-flip
[371.981976] Starting dynamic subtest: pipe-A-eDP-1
[373.596157] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.613s)
[373.610248] Starting dynamic subtest: pipe-B-eDP-1
[375.844015] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.248s)
[375.855099] Starting dynamic subtest: pipe-C-eDP-1
[378.023929] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.179s)
[378.036712] Starting dynamic subtest: pipe-D-eDP-1
[380.200898] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.176s)
[380.203312] Subtest disable-primary-vs-flip: SUCCESS (8.222s)
[380.999157] [066/133] (638s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[381.102942] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[381.107189] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[381.195240] [067/133] (638s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[381.287716] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[381.299544] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[381.401892] [068/133] (638s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[381.489424] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[381.494056] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[381.563559] [069/133] (638s left) vgem_basic (bad-handle)
[381.604948] Starting subtest: bad-handle
[381.607068] Subtest bad-handle: SUCCESS (0.000s)
[381.661523] [070/133] (638s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[381.746574] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[381.748740] Starting dynamic subtest: pipe-A-eDP-1
[381.770645] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[381.782434] Starting dynamic subtest: pipe-B-eDP-1
[381.804628] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[381.814684] Starting dynamic subtest: pipe-C-eDP-1
[381.836246] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[381.845819] Starting dynamic subtest: pipe-D-eDP-1
[381.867784] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[381.872152] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[384.079894] [071/133] (635s left) api_intel_bb (intel-bb-blit-x)
[384.138226] Starting subtest: intel-bb-blit-x
[387.639168] Subtest intel-bb-blit-x: SUCCESS (3.501s)
[387.742153] [072/133] (632s left) kms_cursor_crc (cursor-sliding-32x10)
[387.905508] Starting subtest: cursor-sliding-32x10
[387.950696] Subtest cursor-sliding-32x10: SKIP (0.042s)
[388.269892] [073/133] (631s left) prime_self_import (export-vs-gem_close-race)
[388.309313] Starting subtest: export-vs-gem_close-race
[393.388659] Subtest export-vs-gem_close-race: SUCCESS (5.081s)
[393.468135] [074/133] (626s left) perf (non-sampling-read-error)
[393.567291] Starting subtest: non-sampling-read-error
[393.576345] Subtest non-sampling-read-error: SUCCESS (0.007s)
[393.619887] [075/133] (626s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[393.728221] Starting subtest: bad-rotation-90-y-tiled-ccs
[393.730726] Starting dynamic subtest: pipe-A-eDP-1
[393.753526] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[393.766095] Starting dynamic subtest: pipe-B-eDP-1
[393.787043] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[393.796755] Starting dynamic subtest: pipe-C-eDP-1
[393.818159] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[393.828031] Starting dynamic subtest: pipe-D-eDP-1
[393.850322] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[393.854677] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[396.024574] [076/133] (624s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[396.118582] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[402.990076] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.875s)
[403.126760] [077/133] (617s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[403.182820] Starting subtest: invalid-bsd2-flag-on-blt
[403.185104] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[403.288240] [078/133] (616s left) kms_cursor_crc (cursor-onscreen-128x42)
[403.527243] Starting subtest: cursor-onscreen-128x42
[403.572968] Subtest cursor-onscreen-128x42: SKIP (0.043s)
[403.780179] [079/133] (616s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[403.890642] Starting subtest: modeset-atomic-cursor-hotspot
[403.895124] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[404.034592] [080/133] (616s left) gem_render_copy (linear)
[404.090385] Starting subtest: linear
[404.091949] Starting dynamic subtest: smem
[404.127548] Dynamic subtest smem: SUCCESS (0.039s)
[404.129424] Subtest linear: SUCCESS (0.040s)
[404.362392] [081/133] (615s left) prime_self_import (basic-with_one_bo_two_files)
[404.393846] Starting subtest: basic-with_one_bo_two_files
[404.418806] Subtest basic-with_one_bo_two_files: SUCCESS (0.026s)
[404.540070] [082/133] (615s left) kms_chamelium_edid (hdmi-edid-read)
[404.918077] Subtest hdmi-edid-read: SKIP (0.000s)
[405.740725] [083/133] (614s left) gem_exec_params (readonly)
[405.808677] Starting subtest: readonly
[405.814554] Subtest readonly: SUCCESS (0.003s)
[405.932422] [084/133] (614s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[406.028603] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[406.030959] Starting dynamic subtest: pipe-A-default-mode
[407.228177] Dynamic subtest pipe-A-default-mode: SKIP (1.198s)
[407.232948] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.199s)
[407.375341] [085/133] (613s left) gem_mmap_gtt (cpuset-big-copy)
[407.426004] Subtest cpuset-big-copy: SKIP (0.000s)
[407.488135] [086/133] (613s left) sriov_basic (enable-vfs-autoprobe-on)
[407.538888] Starting subtest: enable-vfs-autoprobe-on
[407.541489] Starting dynamic subtest: numvfs-1
[407.623368] Dynamic subtest numvfs-1: FAIL (0.033s)
[407.634408] Starting dynamic subtest: numvfs-2
[407.705531] Dynamic subtest numvfs-2: FAIL (0.004s)
[407.716298] Starting dynamic subtest: numvfs-3
[407.790469] Dynamic subtest numvfs-3: FAIL (0.003s)
[407.802566] Starting dynamic subtest: numvfs-4
[407.868208] Dynamic subtest numvfs-4: FAIL (0.003s)
[407.878126] Starting dynamic subtest: numvfs-5
[407.936515] Dynamic subtest numvfs-5: FAIL (0.004s)
[407.946222] Starting dynamic subtest: numvfs-6
[408.002505] Dynamic subtest numvfs-6: FAIL (0.004s)
[408.012179] Starting dynamic subtest: numvfs-7
[408.069376] Dynamic subtest numvfs-7: FAIL (0.004s)
[408.078502] Starting dynamic subtest: numvfs-random
[408.135427] Dynamic subtest numvfs-random: FAIL (0.004s)
[408.144859] Starting dynamic subtest: numvfs-all
[408.201674] Dynamic subtest numvfs-all: FAIL (0.462s)
[408.203235] Subtest enable-vfs-autoprobe-on: FAIL (0.527s)
[408.242032] [087/133] (612s left) kms_plane_scaling (planes-downscale-factor-0-75)
[408.337687] Starting subtest: planes-downscale-factor-0-75
[408.339613] Starting dynamic subtest: pipe-A
[408.359048] Dynamic subtest pipe-A: SKIP (0.019s)
[408.369761] Starting dynamic subtest: pipe-B
[408.394053] Dynamic subtest pipe-B: SKIP (0.034s)
[408.404316] Starting dynamic subtest: pipe-C
[408.433933] Dynamic subtest pipe-C: SKIP (0.038s)
[408.444075] Starting dynamic subtest: pipe-D
[408.466623] Dynamic subtest pipe-D: SKIP (0.032s)
[408.470104] Subtest planes-downscale-factor-0-75: SKIP (0.126s)
[408.562590] [088/133] (612s left) kms_plane (plane-panning-top-left)
[408.659842] Starting subtest: plane-panning-top-left
[408.661754] Starting dynamic subtest: pipe-A
[410.365666] Dynamic subtest pipe-A: SUCCESS (1.705s)
[410.377029] Starting dynamic subtest: pipe-B
[412.648802] Dynamic subtest pipe-B: SUCCESS (2.282s)
[412.651215] Subtest plane-panning-top-left: SUCCESS (3.990s)
[413.461071] [089/133] (607s left) kms_plane_cursor (overlay)
[413.557916] Starting subtest: overlay
[413.562296] Starting dynamic subtest: pipe-A-eDP-1-size-64
[416.055338] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.497s)
[416.115702] Starting dynamic subtest: pipe-A-eDP-1-size-128
[418.577298] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.472s)
[418.638591] Starting dynamic subtest: pipe-A-eDP-1-size-256
[421.144984] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.516s)
[421.492740] Starting dynamic subtest: pipe-B-eDP-1-size-64
[424.735324] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.254s)
[424.797011] Starting dynamic subtest: pipe-B-eDP-1-size-128
[427.304953] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.518s)
[427.365856] Starting dynamic subtest: pipe-B-eDP-1-size-256
[429.938009] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[430.289052] Starting dynamic subtest: pipe-C-eDP-1-size-64
[433.211879] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.935s)
[433.251503] Starting dynamic subtest: pipe-C-eDP-1-size-128
[435.412894] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.170s)
[435.450334] Starting dynamic subtest: pipe-C-eDP-1-size-256
[437.601865] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[437.933865] Starting dynamic subtest: pipe-D-eDP-1-size-64
[440.772761] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.852s)
[440.812769] Starting dynamic subtest: pipe-D-eDP-1-size-128
[442.961684] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.158s)
[443.001578] Starting dynamic subtest: pipe-D-eDP-1-size-256
[445.162288] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.170s)
[445.481044] Subtest overlay: SUCCESS (31.922s)
[446.276962] [090/133] (574s left) perf_pmu (busy)
[446.333073] Starting subtest: busy
[446.335359] Starting dynamic subtest: rcs0
[446.929323] Dynamic subtest rcs0: SUCCESS (0.597s)
[446.942636] Starting dynamic subtest: bcs0
[447.498457] Dynamic subtest bcs0: SUCCESS (0.566s)
[447.513134] Starting dynamic subtest: vcs0
[448.733036] Dynamic subtest vcs0: SUCCESS (1.231s)
[448.747133] Starting dynamic subtest: vcs1
[450.717450] Dynamic subtest vcs1: SUCCESS (1.981s)
[450.730847] Starting dynamic subtest: vecs0
[452.701796] Dynamic subtest vecs0: SUCCESS (1.981s)
[452.715886] Starting dynamic subtest: ccs0
[453.273027] Dynamic subtest ccs0: SUCCESS (0.569s)
[453.276403] Subtest busy: SUCCESS (6.942s)
[453.374232] [091/133] (567s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[453.474830] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[453.486120] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[453.559627] [092/133] (567s left) kms_frontbuffer_tracking (fbc-stridechange)
[453.664408] Starting subtest: fbc-stridechange
[456.990495] Subtest fbc-stridechange: SUCCESS (3.329s)
[458.191602] [093/133] (562s left) gem_pread (bench)
[458.251100] Subtest bench: SKIP (0.000s)
[458.312967] [094/133] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[458.404021] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[465.260061] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.858s)
[465.398006] [095/133] (555s left) syncobj_basic (bad-fd-to-handle)
[465.466123] Starting subtest: bad-fd-to-handle
[465.468134] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[465.571595] [096/133] (555s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[465.625938] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[465.628316] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[465.737808] [097/133] (555s left) perf (mi-rpc)
[465.833998] Starting subtest: mi-rpc
[465.838358] Subtest mi-rpc: SKIP (0.000s)
[465.878648] [098/133] (555s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[465.977826] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[465.982250] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[466.079675] [099/133] (555s left) kms_vblank (ts-continuation-modeset-rpm)
[466.174129] Starting subtest: ts-continuation-modeset-rpm
[466.176371] Starting dynamic subtest: pipe-A-eDP-1
[468.705916] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.532s)
[468.721412] Starting dynamic subtest: pipe-D-eDP-1
[470.957845] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.248s)
[470.959985] Subtest ts-continuation-modeset-rpm: SUCCESS (4.783s)
[471.839155] [100/133] (549s left) perf (non-system-wide-paranoid)
[471.928668] Starting subtest: non-system-wide-paranoid
[471.956499] Subtest non-system-wide-paranoid: SUCCESS (0.028s)
[472.000415] [101/133] (549s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[472.099487] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[472.101788] Starting dynamic subtest: pipe-A-eDP-1
[472.126498] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[472.139886] Starting dynamic subtest: pipe-B-eDP-1
[472.164402] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[472.174483] Starting dynamic subtest: pipe-C-eDP-1
[472.198230] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[472.208301] Starting dynamic subtest: pipe-D-eDP-1
[472.232919] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[472.237114] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[474.394622] [102/133] (546s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[474.489021] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[483.783662] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.296s)
[483.913360] [103/133] (537s left) gem_softpin (allocator-basic)
[483.982930] Starting subtest: allocator-basic
[484.048569] Subtest allocator-basic: SUCCESS (0.065s)
[484.162541] [104/133] (537s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[484.262013] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[490.969800] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.711s)
[491.081700] [105/133] (530s left) syncobj_basic (create-signaled)
[491.146868] Starting subtest: create-signaled
[491.148767] Subtest create-signaled: SUCCESS (0.000s)
[491.252722] [106/133] (530s left) gem_mmap (basic-small-bo)
[491.298642] Subtest basic-small-bo: SKIP (0.000s)
[491.360280] [107/133] (530s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[491.471830] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[498.046109] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.577s)
[498.174015] [108/133] (523s left) kms_force_connector_basic (force-load-detect)
[498.259319] Starting subtest: force-load-detect
[498.263858] Subtest force-load-detect: SKIP (0.000s)
[498.387025] [109/133] (523s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[498.489325] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[498.491649] Starting dynamic subtest: pipe-A-eDP-1
[498.565752] Dynamic subtest pipe-A-eDP-1: SKIP (0.081s)
[498.577419] Starting dynamic subtest: pipe-B-eDP-1
[499.666809] Dynamic subtest pipe-B-eDP-1: SKIP (1.098s)
[499.671332] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.181s)
[500.871192] [110/133] (520s left) gem_mmap_wc (coherency)
[500.937685] Subtest coherency: SKIP (0.000s)
[501.001052] [111/133] (520s left) kms_concurrent (multi-plane-atomic-lowres)
[501.097660] Starting subtest: multi-plane-atomic-lowres
[501.100802] Starting dynamic subtest: pipe-A-eDP-1
[501.616301] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.516s)
[501.627060] Starting dynamic subtest: pipe-B-eDP-1
[502.815238] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.199s)
[502.827019] Starting dynamic subtest: pipe-C-eDP-1
[504.062898] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.246s)
[504.074105] Starting dynamic subtest: pipe-D-eDP-1
[505.279858] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.212s)
[505.282352] Subtest multi-plane-atomic-lowres: SUCCESS (4.180s)
[506.103839] [112/133] (515s left) gem_gtt_cpu_tlb
[506.222702] [113/133] (515s left) i915_module_load (reload-no-display)
[506.259125] Starting subtest: reload-no-display
[512.313551] Subtest reload-no-display: SUCCESS (6.053s)
[512.346323] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[512.347034] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[512.350648] [114/133] (509s left) i915_drm_fdinfo (idle)
[513.842491] Starting subtest: idle
[513.846109] Starting dynamic subtest: rcs0
[514.379914] Dynamic subtest rcs0: SUCCESS (0.537s)
[514.389405] Starting dynamic subtest: bcs0
[514.914026] Dynamic subtest bcs0: SUCCESS (0.533s)
[514.927497] Starting dynamic subtest: vcs0
[515.421315] Dynamic subtest vcs0: SUCCESS (0.504s)
[515.433636] Starting dynamic subtest: vcs1
[515.927587] Dynamic subtest vcs1: SUCCESS (0.503s)
[515.938992] Starting dynamic subtest: vecs0
[516.431695] Dynamic subtest vecs0: SUCCESS (0.503s)
[516.446907] Starting dynamic subtest: ccs0
[516.939158] Dynamic subtest ccs0: SUCCESS (0.503s)
[516.942034] Subtest idle: SUCCESS (3.097s)
[516.989347] [FACT i915_drm_fdinfo (idle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[516.990539] [FACT i915_drm_fdinfo (idle)] new: kernel.kmod_is_loaded.i915: true
[516.994266] [115/133] (504s left) dumb_buffer (create-clear)
[517.051153] Starting subtest: create-clear
[551.686176] Subtest create-clear: SUCCESS (34.626s)
[551.801621] [116/133] (469s left) kms_flip (flip-vs-fences-interruptible)
[551.904234] Starting subtest: flip-vs-fences-interruptible
[551.908545] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[552.000682] [117/133] (469s left) kms_big_fb (linear-8bpp-rotate-270)
[552.104698] Starting subtest: linear-8bpp-rotate-270
[552.145418] Subtest linear-8bpp-rotate-270: SKIP (0.040s)
[552.259892] [118/133] (469s left) gen9_exec_parse (bb-oversize)
[552.319677] Subtest bb-oversize: SKIP (0.000s)
[552.389845] [119/133] (469s left) gem_exec_schedule (smoketest)
[552.573064] Starting subtest: smoketest
[552.577614] Starting dynamic subtest: rcs0
[558.107915] Dynamic subtest rcs0: SUCCESS (5.483s)
[558.120458] Starting dynamic subtest: bcs0
[563.635933] Dynamic subtest bcs0: SUCCESS (5.526s)
[563.652650] Starting dynamic subtest: vcs0
[569.129481] Dynamic subtest vcs0: SUCCESS (5.490s)
[569.142438] Starting dynamic subtest: vcs1
[574.620084] Dynamic subtest vcs1: SUCCESS (5.488s)
[574.635479] Starting dynamic subtest: vecs0
[580.123641] Dynamic subtest vecs0: SUCCESS (5.500s)
[580.139596] Starting dynamic subtest: ccs0
[585.617329] Dynamic subtest ccs0: SUCCESS (5.495s)
[585.619319] Subtest smoketest: SUCCESS (32.991s)
[585.802910] [120/133] (436s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[585.994065] Starting subtest: cursor-rapid-movement-64x21
[586.046884] Subtest cursor-rapid-movement-64x21: SKIP (0.047s)
[586.285615] [121/133] (435s left) gem_mmap (basic)
[586.336966] Subtest basic: SKIP (0.000s)
[586.396066] [122/133] (435s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[586.493986] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[587.107220] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.615s)
[587.279719] [123/133] (434s left) gem_exec_balancer (hang)
[587.538920] Starting subtest: hang
[589.222310] Subtest hang: SUCCESS (1.683s)
[589.353108] [124/133] (432s left) gem_ctx_exec (basic-norecovery)
[589.410894] Starting subtest: basic-norecovery
[589.751205] Subtest basic-norecovery: SUCCESS (0.340s)
[589.874281] [125/133] (432s left) kms_hdr (static-toggle)
[589.965208] Starting subtest: static-toggle
[589.971602] Subtest static-toggle: SKIP (0.000s)
[590.038066] [126/133] (432s left) kms_properties (invalid-properties-legacy)
[590.137336] Starting subtest: invalid-properties-legacy
[590.241063] Subtest invalid-properties-legacy: SUCCESS (0.104s)
[590.329134] [127/133] (431s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[590.431123] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[594.520142] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.091s)
[595.674294] [128/133] (426s left) gem_workarounds (suspend-resume-context)
[595.745638] Starting subtest: suspend-resume-context
[611.217619] Subtest suspend-resume-context: SUCCESS (1.956s)
[611.351062] [129/133] (410s left) gem_exec_fence (keep-in-fence)
[611.532793] Starting subtest: keep-in-fence
[611.535791] Starting dynamic subtest: rcs0
[611.602057] Dynamic subtest rcs0: SUCCESS (0.069s)
[611.614807] Starting dynamic subtest: bcs0
[611.662187] Dynamic subtest bcs0: SUCCESS (0.057s)
[611.676674] Starting dynamic subtest: vcs0
[613.228737] Dynamic subtest vcs0: SUCCESS (1.540s)
[613.241851] Starting dynamic subtest: vcs1
[615.212083] Dynamic subtest vcs1: SUCCESS (1.958s)
[615.225691] Starting dynamic subtest: vecs0
[617.260975] Dynamic subtest vecs0: SUCCESS (2.028s)
[617.274088] Starting dynamic subtest: ccs0
[617.500081] Dynamic subtest ccs0: SUCCESS (0.236s)
[617.502958] Subtest keep-in-fence: SUCCESS (5.904s)
[619.302621] [130/133] (403s left) gem_mmap_gtt (hang-user)
[619.359632] Subtest hang-user: SKIP (0.000s)
[619.428910] [131/133] (402s left) kms_atomic_transition (plane-all-transition-fencing)
[619.526231] Starting subtest: plane-all-transition-fencing
[619.528794] Starting dynamic subtest: pipe-A-eDP-1
[622.034288] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[622.350196] Starting dynamic subtest: pipe-B-eDP-1
[625.606806] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.263s)
[625.921639] Subtest plane-all-transition-fencing: SUCCESS (6.368s)
[626.742633] [132/133] (395s left) gem_pxp (protected-raw-src-copy-not-readible)
[626.874282] Starting subtest: protected-raw-src-copy-not-readible
[626.930433] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.059s)
[627.036354] [133/133] (395s left) syncobj_wait (multi-wait-for-submit-submitted)
[627.093455] Starting subtest: multi-wait-for-submit-submitted
[627.200226] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[627.282053] 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.