[57.141261] Initializing watchdogs
[57.141315]   /dev/watchdog0
[57.156272] [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.160657] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.163103] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.166519] [001/131] (960s left) fbdev (unaligned-read)
[57.234867] Starting subtest: unaligned-read
[57.249781] Subtest unaligned-read: SUCCESS (0.015s)
[57.327827] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[57.399128] Starting subtest: dirty-switch
[57.401419] Starting dynamic subtest: rcs0
[57.653908] Dynamic subtest rcs0: SUCCESS (0.255s)
[57.663545] Starting dynamic subtest: bcs0
[57.946697] Dynamic subtest bcs0: SUCCESS (0.292s)
[57.956164] Starting dynamic subtest: vcs0
[58.201470] Dynamic subtest vcs0: SUCCESS (0.255s)
[58.209440] Starting dynamic subtest: vcs1
[60.151133] Dynamic subtest vcs1: SUCCESS (1.948s)
[60.158190] Starting dynamic subtest: vecs0
[62.119920] Dynamic subtest vecs0: SUCCESS (1.969s)
[62.129618] Starting dynamic subtest: ccs0
[64.131244] Dynamic subtest ccs0: SUCCESS (2.011s)
[64.133769] Subtest dirty-switch: SUCCESS (6.732s)
[64.413205] [003/131] (953s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[64.525083] Starting subtest: psr-modesetfrombusy
[70.678832] Subtest psr-modesetfrombusy: SUCCESS (6.157s)
[70.860200] [004/131] (946s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[70.962572] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[70.964680] Starting dynamic subtest: pipe-A-default-mode
[73.703239] Dynamic subtest pipe-A-default-mode: SUCCESS (2.737s)
[73.705554] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.738s)
[74.581438] [005/131] (943s left) gem_exec_params (sol-reset-invalid)
[74.645720] Starting subtest: sol-reset-invalid
[74.651055] Subtest sol-reset-invalid: SUCCESS (0.005s)
[75.999741] [006/131] (941s left) gem_spin_batch (resubmit-new)
[76.065817] Starting subtest: resubmit-new
[76.068287] Starting dynamic subtest: rcs0
[76.073341] Dynamic subtest rcs0: SUCCESS (0.008s)
[76.083609] Starting dynamic subtest: bcs0
[76.085651] Dynamic subtest bcs0: SUCCESS (0.004s)
[76.094998] Starting dynamic subtest: vcs0
[76.097551] Dynamic subtest vcs0: SUCCESS (0.004s)
[76.104843] Starting dynamic subtest: vcs1
[76.107077] Dynamic subtest vcs1: SUCCESS (0.004s)
[76.114177] Starting dynamic subtest: vecs0
[76.116417] Dynamic subtest vecs0: SUCCESS (0.004s)
[76.124075] Starting dynamic subtest: ccs0
[76.126264] Dynamic subtest ccs0: SUCCESS (0.004s)
[76.128419] Subtest resubmit-new: SUCCESS (0.029s)
[77.970180] [007/131] (939s left) gem_exec_schedule (preempt-user)
[78.057067] Starting subtest: preempt-user
[78.059136] Starting dynamic subtest: rcs0
[78.092859] Dynamic subtest rcs0: SUCCESS (0.041s)
[78.100295] Starting dynamic subtest: bcs0
[78.123916] Dynamic subtest bcs0: SUCCESS (0.032s)
[78.131706] Starting dynamic subtest: vcs0
[78.159432] Dynamic subtest vcs0: SUCCESS (0.035s)
[78.170607] Starting dynamic subtest: vcs1
[78.184591] Dynamic subtest vcs1: SUCCESS (0.025s)
[78.192114] Starting dynamic subtest: vecs0
[78.209314] Dynamic subtest vecs0: SUCCESS (0.024s)
[78.217165] Starting dynamic subtest: ccs0
[78.239619] Dynamic subtest ccs0: SUCCESS (0.030s)
[78.242155] Subtest preempt-user: SUCCESS (0.189s)
[79.931799] [008/131] (938s left) sysfs_heartbeat_interval (nopreempt)
[79.999036] Starting subtest: nopreempt
[80.001284] Starting dynamic subtest: vecs0
[89.882141] Dynamic subtest vecs0: SUCCESS (9.881s)
[89.893727] Starting dynamic subtest: ccs0
[93.920993] Dynamic subtest ccs0: SUCCESS (4.038s)
[93.933186] Starting dynamic subtest: vcs0
[103.901454] Dynamic subtest vcs0: SUCCESS (9.979s)
[103.913337] Starting dynamic subtest: bcs0
[107.875566] Dynamic subtest bcs0: SUCCESS (3.971s)
[107.885908] Starting dynamic subtest: rcs0
[112.042590] Dynamic subtest rcs0: SUCCESS (4.167s)
[112.052152] Starting dynamic subtest: vcs1
[121.902208] Dynamic subtest vcs1: SUCCESS (9.860s)
[121.904994] Subtest nopreempt: SUCCESS (41.902s)
[122.000317] [009/131] (895s left) kms_invalid_mode (zero-hdisplay)
[122.115456] Starting subtest: zero-hdisplay
[122.117764] Starting dynamic subtest: pipe-A-eDP-1
[122.402331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[122.411640] Starting dynamic subtest: pipe-B-eDP-1
[122.413796] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[122.421376] Starting dynamic subtest: pipe-C-eDP-1
[122.423744] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[122.431667] Starting dynamic subtest: pipe-D-eDP-1
[122.433583] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[122.435487] Subtest zero-hdisplay: SUCCESS (0.292s)
[123.214679] [010/131] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[123.324371] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[123.328807] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[123.452039] [011/131] (894s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[123.556323] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[124.435892] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.881s)
[124.640312] [012/131] (893s left) kms_getfb (getfb-handle-zero)
[124.742684] Starting subtest: getfb-handle-zero
[124.744992] Subtest getfb-handle-zero: SUCCESS (0.000s)
[124.887780] [013/131] (893s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[124.959282] Starting subtest: yf-tiled-ccs-to-yf-tiled
[124.963882] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[125.164418] [014/131] (893s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[125.268262] Starting subtest: multiplane-rotation-cropping-bottom
[132.513852] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.249s)
[132.672457] [015/131] (885s left) gem_eio (wait-1us)
[132.917063] Starting subtest: wait-1us
[133.272540] Subtest wait-1us: SUCCESS (0.355s)
[133.461682] [016/131] (884s left) syncobj_wait (multi-wait-for-submit-signaled)
[133.514999] Starting subtest: multi-wait-for-submit-signaled
[133.516954] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[133.660270] [017/131] (884s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[133.765080] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[133.767087] Starting dynamic subtest: pipe-A-default-mode
[134.056073] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[134.060433] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.290s)
[134.933055] [018/131] (883s left) kms_plane_alpha_blend (alpha-7efc)
[135.024982] Starting subtest: alpha-7efc
[135.312957] Starting dynamic subtest: pipe-A-eDP-1
[135.931362] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.615s)
[135.961622] Starting dynamic subtest: pipe-D-eDP-1
[137.242659] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.288s)
[137.244937] Subtest alpha-7efc: SUCCESS (2.218s)
[138.102789] [019/131] (880s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[138.218720] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[138.222770] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[138.362298] [020/131] (880s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[138.466632] Starting subtest: fbc-psr2-primary-mmap-cpu
[138.468835] Starting dynamic subtest: eDP-1
[138.473049] Dynamic subtest eDP-1: SKIP (0.000s)
[138.477108] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[138.561366] [021/131] (879s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[138.657786] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[138.667971] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[138.809072] [022/131] (879s left) gem_exec_whisper (basic-normal-all)
[138.879452] Starting subtest: basic-normal-all
[141.366919] Subtest basic-normal-all: SUCCESS (2.488s)
[141.579209] [023/131] (876s left) kms_big_fb (linear-16bpp-rotate-180)
[141.685837] Starting subtest: linear-16bpp-rotate-180
[143.109134] Subtest linear-16bpp-rotate-180: SUCCESS (1.422s)
[143.271373] [024/131] (875s left) kms_frontbuffer_tracking (psr-slowdraw)
[143.379927] Starting subtest: psr-slowdraw
[168.507385] Subtest psr-slowdraw: SUCCESS (25.128s)
[168.655861] [025/131] (849s left) vgem_basic (dmabuf-fence)
[168.774862] Starting subtest: dmabuf-fence
[168.776881] Subtest dmabuf-fence: SUCCESS (0.001s)
[168.851947] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[168.855084] [026/131] (849s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[168.916498] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[168.918775] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[169.056309] [027/131] (849s left) kms_psr (pr-primary-render)
[169.141683] Starting subtest: pr-primary-render
[169.145595] Subtest pr-primary-render: SKIP (0.000s)
[169.238350] [028/131] (849s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[169.329141] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[169.330967] Starting dynamic subtest: pipe-A-eDP-1
[169.350070] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[169.360060] Starting dynamic subtest: pipe-B-eDP-1
[169.377746] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[169.385169] Starting dynamic subtest: pipe-C-eDP-1
[169.403136] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[169.410711] Starting dynamic subtest: pipe-D-eDP-1
[169.430514] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[169.434650] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[171.652978] [029/131] (847s left) core_auth (getclient-master-drop)
[171.693403] Starting subtest: getclient-master-drop
[171.714171] Subtest getclient-master-drop: SUCCESS (0.021s)
[171.839124] [030/131] (846s left) kms_plane_scaling (planes-downscale-factor-0-5)
[171.930126] Starting subtest: planes-downscale-factor-0-5
[171.932350] Starting dynamic subtest: pipe-A
[171.951799] Dynamic subtest pipe-A: SKIP (0.018s)
[171.960628] Starting dynamic subtest: pipe-B
[171.989606] Dynamic subtest pipe-B: SKIP (0.037s)
[171.998701] Starting dynamic subtest: pipe-C
[172.029312] Dynamic subtest pipe-C: SKIP (0.036s)
[172.037708] Starting dynamic subtest: pipe-D
[172.059533] Dynamic subtest pipe-D: SKIP (0.032s)
[172.063110] Subtest planes-downscale-factor-0-5: SKIP (0.126s)
[172.186141] [031/131] (846s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[172.290646] Starting subtest: fb-8bpc-vs-panel-8bpc
[172.292808] Starting dynamic subtest: pipe-A-eDP-1
[173.714468] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.422s)
[173.716673] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.423s)
[174.604944] [032/131] (844s left) gem_partial_pwrite_pread (reads-snoop)
[174.673489] Subtest reads-snoop: SKIP (0.000s)
[174.738997] [033/131] (844s left) gem_eio (in-flight-contexts-immediate)
[174.981456] Starting subtest: in-flight-contexts-immediate
[188.913614] Subtest in-flight-contexts-immediate: SUCCESS (13.930s)
[189.120996] [034/131] (829s left) gen3_render_mixed_blits
[189.256808] [035/131] (829s left) kms_pm_rpm (pm-tiling)
[191.083750] Starting subtest: pm-tiling
[191.088580] Subtest pm-tiling: SKIP (0.000s)
[191.528939] [036/131] (827s left) i915_module_load (reload-no-display)
[191.566161] Starting subtest: reload-no-display
[197.804784] Subtest reload-no-display: SUCCESS (6.238s)
[197.836374] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[197.837148] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[197.840324] [037/131] (821s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[199.461887] Starting subtest: plane-upscale-20x20-with-rotation
[199.464127] Starting dynamic subtest: pipe-A
[199.709279] Dynamic subtest pipe-A: SUCCESS (0.249s)
[199.717027] Starting dynamic subtest: pipe-B
[201.034535] Dynamic subtest pipe-B: SUCCESS (1.323s)
[201.042325] Starting dynamic subtest: pipe-C
[202.364551] Dynamic subtest pipe-C: SUCCESS (1.329s)
[202.372072] Starting dynamic subtest: pipe-D
[203.697817] Dynamic subtest pipe-D: SUCCESS (1.332s)
[203.700243] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.240s)
[204.853439] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[204.854697] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[204.858373] [038/131] (814s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[204.964085] Starting subtest: 4-tiled-8bpp-rotate-180
[206.170353] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.206s)
[206.353720] [039/131] (812s left) kms_rotation_crc (primary-rotation-90)
[206.460105] Starting subtest: primary-rotation-90
[206.463506] Subtest primary-rotation-90: SKIP (0.001s)
[206.555188] [040/131] (812s left) kms_cursor_crc (cursor-onscreen-32x10)
[206.707272] Starting subtest: cursor-onscreen-32x10
[206.753706] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[207.034738] [041/131] (812s left) kms_vblank (wait-idle)
[207.141395] Starting subtest: wait-idle
[207.143347] Starting dynamic subtest: pipe-A-eDP-1
[208.896787] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.755s)
[208.909443] Starting dynamic subtest: pipe-D-eDP-1
[211.335213] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.434s)
[211.337699] Subtest wait-idle: SUCCESS (4.194s)
[212.169782] [042/131] (807s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[212.275217] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[212.279613] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[212.413256] [043/131] (806s left) kms_flip (2x-flip-vs-dpms)
[212.510959] Starting subtest: 2x-flip-vs-dpms
[212.519737] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[212.626069] [044/131] (806s left) gem_exec_fence (syncobj-channel)
[213.052568] Starting subtest: syncobj-channel
[214.071293] Subtest syncobj-channel: SUCCESS (1.016s)
[215.060472] [045/131] (804s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[215.162084] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[215.164419] Starting dynamic subtest: pipe-A-eDP-1
[215.173748] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[215.182543] Starting dynamic subtest: pipe-B-eDP-1
[215.192889] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[215.201604] Starting dynamic subtest: pipe-C-eDP-1
[215.210465] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.218175] Starting dynamic subtest: pipe-D-eDP-1
[215.227080] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.231423] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[217.327425] [046/131] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[217.430308] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[224.731517] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.303s)
[224.880130] [047/131] (794s left) kms_flip (busy-flip)
[224.984272] Starting subtest: busy-flip
[224.986191] Starting dynamic subtest: A-eDP1
[226.708149] Dynamic subtest A-eDP1: SUCCESS (1.726s)
[226.718065] Starting dynamic subtest: B-eDP1
[228.359870] Dynamic subtest B-eDP1: SUCCESS (1.650s)
[228.370084] Starting dynamic subtest: C-eDP1
[230.075442] Dynamic subtest C-eDP1: SUCCESS (1.714s)
[230.084641] Starting dynamic subtest: D-eDP1
[231.710440] Dynamic subtest D-eDP1: SUCCESS (1.634s)
[231.715845] Subtest busy-flip: SUCCESS (6.733s)
[232.894157] [048/131] (786s left) prime_mmap (test_aperture_limit)
[232.952540] Starting subtest: test_aperture_limit
[232.954521] Starting dynamic subtest: test_aperture_limit-smem
[232.961818] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[232.966113] Subtest test_aperture_limit: SKIP (0.008s)
[233.096770] [049/131] (786s left) i915_pm_rpm (sysfs-read)
[235.021213] Starting subtest: sysfs-read
[236.194349] Subtest sysfs-read: SUCCESS (1.167s)
[236.570035] [050/131] (783s left) kms_big_fb (yf-tiled-addfb)
[236.678146] Starting subtest: yf-tiled-addfb
[236.682146] Subtest yf-tiled-addfb: SKIP (0.000s)
[236.815394] [051/131] (782s left) sriov_basic (enable-vfs-autoprobe-on)
[236.882161] Starting subtest: enable-vfs-autoprobe-on
[236.884436] Starting dynamic subtest: numvfs-1
[236.961744] Dynamic subtest numvfs-1: FAIL (0.029s)
[236.971161] Starting dynamic subtest: numvfs-2
[237.042579] Dynamic subtest numvfs-2: FAIL (0.004s)
[237.051024] Starting dynamic subtest: numvfs-3
[237.123234] Dynamic subtest numvfs-3: FAIL (0.004s)
[237.132254] Starting dynamic subtest: numvfs-4
[237.204041] Dynamic subtest numvfs-4: FAIL (0.004s)
[237.214252] Starting dynamic subtest: numvfs-5
[237.286536] Dynamic subtest numvfs-5: FAIL (0.004s)
[237.295085] Starting dynamic subtest: numvfs-6
[237.367845] Dynamic subtest numvfs-6: FAIL (0.004s)
[237.378022] Starting dynamic subtest: numvfs-7
[237.452152] Dynamic subtest numvfs-7: FAIL (0.004s)
[237.461367] Starting dynamic subtest: numvfs-random
[237.523792] Dynamic subtest numvfs-random: FAIL (0.004s)
[237.533605] Starting dynamic subtest: numvfs-all
[237.592051] Dynamic subtest numvfs-all: FAIL (0.004s)
[237.593747] Subtest enable-vfs-autoprobe-on: FAIL (0.568s)
[237.628673] [052/131] (782s left) gem_exec_whisper (basic-queues)
[237.691797] Starting subtest: basic-queues
[243.319308] Subtest basic-queues: SUCCESS (5.627s)
[243.531823] [053/131] (776s left) kms_flip (2x-dpms-vs-vblank-race)
[243.637404] Starting subtest: 2x-dpms-vs-vblank-race
[243.649433] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[243.801938] [054/131] (775s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[243.909227] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[244.294434] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[247.032077] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.736s)
[247.043720] Starting dynamic subtest: pipe-A-eDP-1-4
[249.207136] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[249.216490] Starting dynamic subtest: pipe-A-eDP-1-4
[251.216914] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[251.225906] Starting dynamic subtest: pipe-A-eDP-1-x
[253.395845] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[253.773727] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[256.567075] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[256.577832] Starting dynamic subtest: pipe-B-eDP-1-4
[258.752848] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[258.763510] Starting dynamic subtest: pipe-B-eDP-1-4
[260.762995] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[260.773541] Starting dynamic subtest: pipe-B-eDP-1-x
[262.953065] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[263.316094] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[266.099977] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[266.110763] Starting dynamic subtest: pipe-C-eDP-1-4
[268.275361] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[268.286353] Starting dynamic subtest: pipe-C-eDP-1-4
[270.285502] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[270.295583] Starting dynamic subtest: pipe-C-eDP-1-x
[272.463771] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[272.826159] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[275.634605] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.813s)
[275.645856] Starting dynamic subtest: pipe-D-eDP-1-4
[277.820557] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s)
[277.828972] Starting dynamic subtest: pipe-D-eDP-1-4
[279.830550] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[279.838678] Starting dynamic subtest: pipe-D-eDP-1-x
[282.042865] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.211s)
[282.045265] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.134s)
[283.245846] [055/131] (736s left) gem_mmap_gtt (basic-write-read-distinct)
[283.311827] Subtest basic-write-read-distinct: SKIP (0.000s)
[283.374970] [056/131] (736s left) gem_mmap_offset (oob-read)
[283.427284] Starting subtest: oob-read
[283.429194] Subtest oob-read: SUCCESS (0.000s)
[283.545254] [057/131] (736s left) kms_atomic (atomic-plane-damage)
[283.640922] Starting subtest: atomic-plane-damage
[283.689108] Starting dynamic subtest: pipe-A-eDP-1
[284.239857] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[284.242206] Subtest atomic-plane-damage: SUCCESS (0.600s)
[285.074625] [058/131] (734s left) kms_atomic_transition (plane-all-transition-nonblocking)
[285.174979] Starting subtest: plane-all-transition-nonblocking
[285.177332] Starting dynamic subtest: pipe-A-eDP-1
[287.668934] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[287.981679] Starting dynamic subtest: pipe-B-eDP-1
[291.188053] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.214s)
[291.489744] Subtest plane-all-transition-nonblocking: SUCCESS (6.312s)
[292.342186] [059/131] (727s left) gem_exec_parallel (contexts)
[292.414495] Starting subtest: contexts
[292.416967] Starting dynamic subtest: rcs0
[295.356308] Dynamic subtest rcs0: SUCCESS (2.944s)
[295.364680] Starting dynamic subtest: bcs0
[298.729228] Dynamic subtest bcs0: SUCCESS (3.368s)
[298.740652] Starting dynamic subtest: vcs0
[302.459378] Dynamic subtest vcs0: SUCCESS (3.727s)
[302.470296] Starting dynamic subtest: vcs1
[306.484798] Dynamic subtest vcs1: SUCCESS (4.024s)
[306.495845] Starting dynamic subtest: vecs0
[310.391491] Dynamic subtest vecs0: SUCCESS (3.904s)
[310.400231] Starting dynamic subtest: ccs0
[313.762781] Dynamic subtest ccs0: SUCCESS (3.370s)
[313.765750] Subtest contexts: SUCCESS (21.351s)
[313.977882] [060/131] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[314.093075] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[320.919507] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.830s)
[321.103202] [061/131] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[321.209613] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[321.214064] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[321.349255] [062/131] (698s left) kms_atomic_interruptible (legacy-pageflip)
[321.460910] Starting subtest: legacy-pageflip
[321.463082] Starting dynamic subtest: pipe-A-eDP-1
[328.871336] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.408s)
[328.873648] Subtest legacy-pageflip: SUCCESS (7.410s)
[329.711244] [063/131] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[329.822582] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[329.826643] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[329.960901] [064/131] (690s left) kms_psr (psr2-sprite-mmap-cpu)
[330.055607] Starting subtest: psr2-sprite-mmap-cpu
[330.057700] Starting dynamic subtest: eDP-1
[331.790295] Dynamic subtest eDP-1: SUCCESS (1.735s)
[331.792628] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.736s)
[332.692617] [065/131] (687s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[332.799320] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[339.890991] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.093s)
[340.096426] [066/131] (680s left) gem_exec_schedule (fairslice-all)
[340.161701] Starting subtest: fairslice-all
[342.216892] Subtest fairslice-all: SUCCESS (2.059s)
[344.013110] [067/131] (676s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[349.063055] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[349.065415] Starting dynamic subtest: pipe-A-eDP-1
[349.850210] Dynamic subtest pipe-A-eDP-1: SKIP (0.783s)
[349.864056] Starting dynamic subtest: pipe-B-eDP-1
[351.088913] Dynamic subtest pipe-B-eDP-1: SKIP (1.234s)
[351.093634] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (2.022s)
[352.295502] [068/131] (668s left) api_intel_allocator (two-level-inception)
[352.355945] Starting subtest: two-level-inception
[357.753734] Subtest two-level-inception: SUCCESS (5.399s)
[357.917619] [069/131] (662s left) i915_suspend (debugfs-reader)
[357.993691] Starting subtest: debugfs-reader
[376.412455] Subtest debugfs-reader: SUCCESS (7.275s)
[376.585236] [070/131] (644s left) kms_flip (plain-flip-fb-recreate-interruptible)
[376.694562] Starting subtest: plain-flip-fb-recreate-interruptible
[376.696869] Starting dynamic subtest: A-eDP1
[385.587122] Dynamic subtest A-eDP1: SUCCESS (8.878s)
[385.599120] Starting dynamic subtest: B-eDP1
[394.421632] Dynamic subtest B-eDP1: SUCCESS (8.825s)
[394.434554] Starting dynamic subtest: C-eDP1
[403.241243] Dynamic subtest C-eDP1: SUCCESS (8.813s)
[403.252249] Starting dynamic subtest: D-eDP1
[412.078885] Dynamic subtest D-eDP1: SUCCESS (8.840s)
[412.082984] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.368s)
[413.285587] [071/131] (607s left) gem_vm_create (invalid-destroy)
[413.342141] Starting subtest: invalid-destroy
[413.344560] Subtest invalid-destroy: SUCCESS (0.002s)
[413.461965] [072/131] (607s left) gem_ccs (ctrl-surf-copy-new-ctx)
[413.520109] Starting subtest: ctrl-surf-copy-new-ctx
[413.524044] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[413.644407] [073/131] (607s left) syncobj_basic (bad-destroy-pad)
[413.703567] Starting subtest: bad-destroy-pad
[413.705434] Subtest bad-destroy-pad: SUCCESS (0.000s)
[413.846857] [074/131] (606s left) kms_plane_multiple (2x-tiling-y)
[413.952118] Starting subtest: 2x-tiling-y
[413.956469] Subtest 2x-tiling-y: SKIP (0.000s)
[414.052524] [075/131] (606s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[414.157128] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[414.159406] Starting dynamic subtest: pipe-A-eDP-1
[414.181445] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[414.193012] Starting dynamic subtest: pipe-B-eDP-1
[414.209910] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[414.217878] Starting dynamic subtest: pipe-C-eDP-1
[414.234654] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[414.243005] Starting dynamic subtest: pipe-D-eDP-1
[414.260027] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[414.263400] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[416.348525] [076/131] (604s left) kms_pm_rpm (modeset-lpsp)
[418.180111] Starting subtest: modeset-lpsp
[419.638270] Subtest modeset-lpsp: SUCCESS (1.460s)
[419.758065] [077/131] (601s left) kms_setmode (basic)
[419.820053] Starting subtest: basic
[420.157614] Starting dynamic subtest: pipe-A-eDP-1
[422.227520] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.066s)
[422.578149] Starting dynamic subtest: pipe-B-eDP-1
[424.652075] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.078s)
[424.960220] Subtest basic: SUCCESS (5.139s)
[425.824449] [078/131] (595s left) kms_psr (fbc-psr-suspend)
[425.934307] Starting subtest: fbc-psr-suspend
[425.936558] Starting dynamic subtest: eDP-1
[425.940513] Dynamic subtest eDP-1: SKIP (0.000s)
[425.944520] Subtest fbc-psr-suspend: SKIP (0.001s)
[426.028655] [079/131] (594s left) gem_ringfill (engines-basic)
[432.032691] Starting subtest: engines-basic
[432.035273] Starting dynamic subtest: rcs0
[432.085219] Dynamic subtest rcs0: SUCCESS (0.053s)
[432.097201] Starting dynamic subtest: bcs0
[432.128137] Dynamic subtest bcs0: SUCCESS (0.041s)
[432.138769] Starting dynamic subtest: vcs0
[432.170384] Dynamic subtest vcs0: SUCCESS (0.040s)
[432.181092] Starting dynamic subtest: vcs1
[432.212259] Dynamic subtest vcs1: SUCCESS (0.040s)
[432.222226] Starting dynamic subtest: vecs0
[432.255379] Dynamic subtest vecs0: SUCCESS (0.041s)
[432.266206] Starting dynamic subtest: ccs0
[432.300160] Dynamic subtest ccs0: SUCCESS (0.043s)
[432.302532] Subtest engines-basic: SUCCESS (0.270s)
[432.403836] [080/131] (588s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[432.465373] Starting subtest: invalid-bsd2-flag-on-vebox
[432.467793] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[432.605219] [081/131] (588s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[432.707271] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[432.709502] Starting dynamic subtest: pipe-A-eDP-1
[432.729266] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[432.740222] Starting dynamic subtest: pipe-B-eDP-1
[432.760487] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[432.769815] Starting dynamic subtest: pipe-C-eDP-1
[432.790077] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[432.799400] Starting dynamic subtest: pipe-D-eDP-1
[432.819446] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[432.821615] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s)
[435.089969] [082/131] (586s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[435.194891] Starting subtest: extended-pageflip-modeset-hang-oldfb
[435.197000] Starting dynamic subtest: pipe-A
[443.100194] Dynamic subtest pipe-A: SUCCESS (7.903s)
[443.109827] Starting dynamic subtest: pipe-D
[451.681913] Dynamic subtest pipe-D: SUCCESS (8.580s)
[451.684353] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.488s)
[452.565841] [083/131] (568s left) gem_ppgtt (shrink-vs-evict-any)
[452.636655] Starting subtest: shrink-vs-evict-any
[458.049758] Subtest shrink-vs-evict-any: SUCCESS (5.411s)
[458.157444] [084/131] (563s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[458.220500] Starting subtest: etime-single-wait-for-submit-unsubmitted
[458.328722] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[458.432974] [085/131] (562s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[458.484727] Starting subtest: multi-wait-all-for-submit-signaled
[458.487016] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[458.620181] [086/131] (562s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[458.692168] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[458.800163] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[458.906995] [087/131] (562s left) gem_exec_schedule (implicit-write-read)
[458.982208] Starting subtest: implicit-write-read
[458.984829] Starting dynamic subtest: rcs0
[459.165685] Dynamic subtest rcs0: SUCCESS (0.191s)
[459.175308] Starting dynamic subtest: vcs0
[459.272912] Dynamic subtest vcs0: SUCCESS (0.106s)
[459.285405] Starting dynamic subtest: vcs1
[459.388837] Dynamic subtest vcs1: SUCCESS (0.114s)
[459.401309] Starting dynamic subtest: vecs0
[459.500423] Dynamic subtest vecs0: SUCCESS (0.110s)
[459.512755] Starting dynamic subtest: ccs0
[459.621047] Dynamic subtest ccs0: SUCCESS (0.119s)
[459.623995] Subtest implicit-write-read: SUCCESS (0.648s)
[461.153403] [088/131] (560s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[461.261750] Starting subtest: fbcpsr-rgb565-draw-blt
[468.272511] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.013s)
[468.430648] [089/131] (552s left) gem_ctx_persistence (processes)
[468.484088] Starting subtest: processes
[470.062003] Subtest processes: SUCCESS (1.577s)
[470.164439] [090/131] (551s left) kms_cursor_crc (cursor-sliding-32x10)
[470.319970] Starting subtest: cursor-sliding-32x10
[470.368012] Subtest cursor-sliding-32x10: SKIP (0.043s)
[470.682673] [091/131] (550s left) kms_psr (fbc-pr-primary-render)
[470.778727] Starting subtest: fbc-pr-primary-render
[470.782737] Subtest fbc-pr-primary-render: SKIP (0.000s)
[470.876170] [092/131] (550s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[470.952445] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[471.041981] [093/131] (550s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[471.097791] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[471.099791] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[471.231731] [094/131] (550s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[471.344005] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[471.347697] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[471.486683] [095/131] (550s left) gem_exec_async (concurrent-writes)
[471.553836] Starting subtest: concurrent-writes
[471.555757] Starting dynamic subtest: rcs0
[471.568882] Dynamic subtest rcs0: SUCCESS (0.015s)
[471.579444] Starting dynamic subtest: bcs0
[471.581411] Dynamic subtest bcs0: SUCCESS (0.007s)
[471.591193] Starting dynamic subtest: vcs0
[471.593246] Dynamic subtest vcs0: SUCCESS (0.004s)
[471.602830] Starting dynamic subtest: vcs1
[471.604670] Dynamic subtest vcs1: SUCCESS (0.005s)
[471.614019] Starting dynamic subtest: vecs0
[471.616043] Dynamic subtest vecs0: SUCCESS (0.005s)
[471.627117] Starting dynamic subtest: ccs0
[471.628996] Dynamic subtest ccs0: SUCCESS (0.005s)
[471.631027] Subtest concurrent-writes: SUCCESS (0.045s)
[471.875436] [096/131] (549s left) gem_mmap_gtt (basic-small-bo-tiledx)
[471.935357] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[472.007841] [097/131] (549s left) dmabuf_sync_file (import-basic)
[472.053733] Starting subtest: import-basic
[472.055773] Subtest import-basic: SUCCESS (0.002s)
[472.135623] [098/131] (549s left) kms_feature_discovery (display)
[472.226474] Starting subtest: display
[472.228408] Subtest display: SUCCESS (0.000s)
[472.323765] [099/131] (549s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[472.426020] Starting subtest: x-tiled-64bpp-rotate-90
[472.447179] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[472.617617] [100/131] (549s left) perf_pmu (busy-no-semaphores)
[472.660029] Starting subtest: busy-no-semaphores
[472.661800] Starting dynamic subtest: rcs0
[473.237269] Dynamic subtest rcs0: SUCCESS (0.577s)
[473.248374] Starting dynamic subtest: bcs0
[473.789101] Dynamic subtest bcs0: SUCCESS (0.549s)
[473.802089] Starting dynamic subtest: vcs0
[474.340731] Dynamic subtest vcs0: SUCCESS (0.548s)
[474.357366] Starting dynamic subtest: vcs1
[475.549944] Dynamic subtest vcs1: SUCCESS (1.206s)
[475.563318] Starting dynamic subtest: vecs0
[477.604786] Dynamic subtest vecs0: SUCCESS (2.052s)
[477.624764] Starting dynamic subtest: ccs0
[479.525268] Dynamic subtest ccs0: SUCCESS (1.918s)
[479.528173] Subtest busy-no-semaphores: SUCCESS (6.869s)
[479.686410] [101/131] (542s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[479.791557] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[479.795499] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[479.938462] [102/131] (542s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[480.063817] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[480.068356] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[480.234502] [103/131] (541s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[480.638663] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[481.477971] [104/131] (540s left) kms_getfb (getfb-reject-nv12)
[481.579253] Starting subtest: getfb-reject-nv12
[481.581584] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[481.700995] [105/131] (540s left) i915_drm_fdinfo (context-close-stress)
[481.744300] Starting subtest: context-close-stress
[492.486881] Subtest context-close-stress: SUCCESS (10.744s)
[492.599319] [106/131] (529s left) perf_pmu (module-unload)
[492.876724] Starting subtest: module-unload
[499.871194] Subtest module-unload: FAIL (6.882s)
[499.903907] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[499.904633] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[499.907922] [107/131] (522s left) kms_chamelium_edid (dp-edid-read)
[501.732422] Subtest dp-edid-read: SKIP (0.000s)
[502.555852] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[502.557041] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[502.560768] [108/131] (519s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[507.572920] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[507.575196] Starting dynamic subtest: pipe-A-eDP-1
[508.343960] Dynamic subtest pipe-A-eDP-1: SKIP (0.769s)
[508.357540] Starting dynamic subtest: pipe-B-eDP-1
[509.472027] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[509.476588] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.898s)
[510.678367] [109/131] (511s left) kms_vblank (query-busy)
[510.772377] Starting subtest: query-busy
[510.774248] Starting dynamic subtest: pipe-A-eDP-1
[512.665182] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.891s)
[512.679158] Starting dynamic subtest: pipe-D-eDP-1
[515.234866] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.568s)
[515.237153] Subtest query-busy: SUCCESS (4.463s)
[516.064722] [110/131] (506s left) syncobj_timeline (wait-for-submit-complex)
[516.136964] Starting subtest: wait-for-submit-complex
[516.198942] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[516.305835] [111/131] (506s left) perf (invalid-create-userspace-config)
[516.448154] Starting subtest: invalid-create-userspace-config
[516.450117] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[516.521958] [112/131] (505s left) gem_exec_basic (basic)
[516.592971] Starting subtest: basic
[516.595461] Starting dynamic subtest: rcs0-smem
[516.597845] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[516.609615] Starting dynamic subtest: bcs0-smem
[516.611545] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[516.620745] Starting dynamic subtest: vcs0-smem
[516.622586] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[516.630607] Starting dynamic subtest: vcs1-smem
[516.632410] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[516.640412] Starting dynamic subtest: vecs0-smem
[516.642209] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[516.650337] Starting dynamic subtest: ccs0-smem
[516.652157] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[516.653953] Subtest basic: SUCCESS (0.014s)
[518.108431] [113/131] (504s left) kms_chamelium_color (ctm-0-25)
[518.216944] Subtest ctm-0-25: SKIP (0.000s)
[518.263739] [114/131] (504s left) gem_userptr_blits (process-exit-busy)
[518.334912] Starting subtest: process-exit-busy
[518.345304] Subtest process-exit-busy: SUCCESS (0.013s)
[518.504131] [115/131] (504s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[518.554257] Starting subtest: y-tiled-ccs-to-y-tiled
[518.558735] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[518.760811] [116/131] (503s left) gen7_exec_parse (bitmasks)
[518.818713] Subtest bitmasks: SKIP (0.000s)
[518.882894] [117/131] (503s left) gem_eio (wait-wedge-10ms)
[519.067930] Starting subtest: wait-wedge-10ms
[520.071404] Subtest wait-wedge-10ms: SUCCESS (1.002s)
[520.256373] [118/131] (502s left) kms_content_protection (atomic)
[520.396599] Starting subtest: atomic
[520.401002] Subtest atomic: SKIP (0.000s)
[520.561055] [119/131] (502s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[520.650365] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[520.652634] Starting dynamic subtest: pipe-A-default-mode
[520.948666] Dynamic subtest pipe-A-default-mode: SKIP (0.297s)
[520.953076] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.298s)
[521.806582] [120/131] (500s left) gem_exec_params (invalid-flag)
[521.875451] Starting subtest: invalid-flag
[521.878000] Subtest invalid-flag: SUCCESS (0.000s)
[522.014895] [121/131] (500s left) kms_getfb (getfb-addfb-different-handles)
[522.112214] Starting subtest: getfb-addfb-different-handles
[522.114475] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[522.252028] [122/131] (500s left) gem_exec_flush (basic-uc-ro-default)
[522.313235] Starting subtest: basic-uc-ro-default
[527.769764] Subtest basic-uc-ro-default: SUCCESS (5.457s)
[527.981712] [123/131] (494s left) gem_sync (basic-each)
[528.067104] Starting subtest: basic-each
[530.599775] Subtest basic-each: SUCCESS (2.538s)
[530.810148] [124/131] (492s left) gem_exec_balancer (full)
[530.879756] Starting subtest: full
[535.974386] Subtest full: SUCCESS (5.094s)
[536.336374] [125/131] (486s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[536.454479] Starting subtest: y-tiled-8bpp-rotate-180
[536.458900] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[536.563771] [126/131] (486s left) sw_sync (sync_merge_invalid)
[536.603005] Starting subtest: sync_merge_invalid
[536.628380] Subtest sync_merge_invalid: SUCCESS (0.026s)
[536.706744] [127/131] (486s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[536.809811] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[541.236444] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.427s)
[542.396670] [128/131] (480s left) gem_lmem_swapping (parallel-random-verify-ccs)
[542.439224] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[542.482230] [129/131] (480s left) kms_lease (lease-unleased-connector)
[542.587707] Starting subtest: lease-unleased-connector
[542.589992] Starting dynamic subtest: pipe-A-eDP-1
[542.594935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.008s)
[542.607610] Starting dynamic subtest: pipe-B-eDP-1
[542.609934] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[542.619929] Starting dynamic subtest: pipe-C-eDP-1
[542.622041] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[542.632162] Starting dynamic subtest: pipe-D-eDP-1
[542.634258] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[542.636452] Subtest lease-unleased-connector: SUCCESS (0.043s)
[542.764981] [130/131] (480s left) perf (enable-disable)
[542.873039] Starting subtest: enable-disable
[542.875694] Starting dynamic subtest: 0-rcs0
[545.137954] Dynamic subtest 0-rcs0: SUCCESS (2.264s)
[545.149145] Starting dynamic subtest: 1-vecs0
[549.626468] Dynamic subtest 1-vecs0: SUCCESS (4.487s)
[549.629165] Subtest enable-disable: SUCCESS (6.753s)
[549.678307] [131/131] (473s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[549.835051] Starting subtest: cursor-rapid-movement-32x32
[549.884231] Subtest cursor-rapid-movement-32x32: SKIP (0.044s)
[550.236339] Closing watchdogs
results: parsing output: 0/ for test: fbdev
results: parsing output: 1/ for test: gem_ctx_isolation
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: gem_spin_batch
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: sysfs_heartbeat_interval
results: parsing output: 8/ for test: kms_invalid_mode
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_getfb
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: kms_rotation_crc
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_plane_alpha_blend
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: vgem_basic
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: core_auth
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: kms_dither
results: parsing output: 31/ for test: gem_partial_pwrite_pread
results: parsing output: 32/ for test: gem_eio
results: parsing output: 33/ for test: gen3_render_mixed_blits
results: parsing output: 34/ for test: kms_pm_rpm
results: parsing output: 35/ for test: i915_module_load
results: parsing output: 36/ for test: kms_plane_scaling
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_rotation_crc
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: kms_vblank
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: sriov_basic
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: gem_mmap_offset
results: parsing output: 56/ for test: kms_atomic
results: parsing output: 57/ for test: kms_atomic_transition
results: parsing output: 58/ for test: gem_exec_parallel
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_atomic_interruptible
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: i915_suspend
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gem_vm_create
results: parsing output: 71/ for test: gem_ccs
results: parsing output: 72/ for test: syncobj_basic
results: parsing output: 73/ for test: kms_plane_multiple
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_pm_rpm
results: parsing output: 76/ for test: kms_setmode
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: gem_ringfill
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_busy
results: parsing output: 82/ for test: gem_ppgtt
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_async
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: dmabuf_sync_file
results: parsing output: 97/ for test: kms_feature_discovery
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_chamelium_hpd
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: kms_chamelium_edid
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: gem_exec_basic
results: parsing output: 112/ for test: kms_chamelium_color
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: gen7_exec_parse
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_content_protection
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: kms_getfb
results: parsing output: 121/ for test: gem_exec_flush
results: parsing output: 122/ for test: gem_sync
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: sw_sync
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_lmem_swapping
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: kms_cursor_crc
Done.